builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1480021803.54 results: success (0) buildid: 20161124103032 builduid: 0a813220629143a09b6000ade01e4847 revision: bad312aefb42982f492ad2cf36f4c6c3d698f4f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 13:10:03.535797) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 13:10:03.536464) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 13:10:03.536752) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 13:10:03.837166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 13:10:03.837457) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-24 13:10:04-- 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% 113M=0s 2016-11-24 13:10:04 (113 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.386933 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 13:10:04.239514) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 13:10:04.239829) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016986 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 13:10:04.290025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-24 13:10:04.290396) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bad312aefb42982f492ad2cf36f4c6c3d698f4f7 --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 bad312aefb42982f492ad2cf36f4c6c3d698f4f7 --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=934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-24 13:10:04,611 truncating revision to first 12 chars 2016-11-24 13:10:04,611 Setting DEBUG logging. 2016-11-24 13:10:04,611 attempt 1/10 2016-11-24 13:10:04,611 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bad312aefb42?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-24 13:10:05,047 unpacking tar archive at: mozilla-central-bad312aefb42/testing/mozharness/ program finished with exit code 0 elapsedTime=0.997107 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-24 13:10:05.300448) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 13:10:05.300723) ========= script_repo_revision: bad312aefb42982f492ad2cf36f4c6c3d698f4f7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 13:10:05.301112) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 13:10:05.301408) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 13:10:05.315440) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-11-24 13:10:05.315714) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:10:05 INFO - MultiFileLogger online at 20161124 13:10:05 in /builds/slave/test 13:10:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:10:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:10:05 INFO - {'append_to_log': False, 13:10:05 INFO - 'base_work_dir': '/builds/slave/test', 13:10:05 INFO - 'blob_upload_branch': 'Firefox', 13:10:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:10:05 INFO - 'branch': 'Firefox', 13:10:05 INFO - 'buildbot_json_path': 'buildprops.json', 13:10:05 INFO - 'config_files': ('talos/linux_config.py',), 13:10:05 INFO - 'default_actions': ('clobber', 13:10:05 INFO - 'read-buildbot-config', 13:10:05 INFO - 'download-and-extract', 13:10:05 INFO - 'populate-webroot', 13:10:05 INFO - 'create-virtualenv', 13:10:05 INFO - 'install', 13:10:05 INFO - 'run-tests'), 13:10:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:10:05 INFO - 'download_minidump_stackwalk': True, 13:10:05 INFO - 'download_symbols': 'ondemand', 13:10:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:10:05 INFO - 'tooltool.py': '/tools/tooltool.py', 13:10:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:10:05 INFO - '/tools/misc-python/virtualenv.py')}, 13:10:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:10:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:10:05 INFO - 'installer_path': 'installer.exe', 13:10:05 INFO - 'log_level': 'info', 13:10:05 INFO - 'log_name': 'talos', 13:10:05 INFO - 'log_to_console': True, 13:10:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:10:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:10:05 INFO - 'opt_config_files': (), 13:10:05 INFO - 'pip_index': False, 13:10:05 INFO - 'sps_profile': False, 13:10:05 INFO - 'sps_profile_interval': 0, 13:10:05 INFO - 'suite': 'dromaeojs', 13:10:05 INFO - 'system_bits': '32', 13:10:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:10:05 INFO - 'title': 'talos-linux64-ix-057', 13:10:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:10:05 INFO - 'use_talos_json': True, 13:10:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:10:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:10:05 INFO - 'work_dir': 'build'} 13:10:05 INFO - [mozharness: 2016-11-24 21:10:05.741362Z] Running clobber step. 13:10:05 INFO - Running pre-action listener: _resource_record_pre_action 13:10:05 INFO - Running main action method: clobber 13:10:05 INFO - rmtree: /builds/slave/test/build 13:10:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:10:06 INFO - Running post-action listener: _resource_record_post_action 13:10:06 INFO - [mozharness: 2016-11-24 21:10:06.720807Z] Finished clobber step (success) 13:10:06 INFO - [mozharness: 2016-11-24 21:10:06.720906Z] Running read-buildbot-config step. 13:10:06 INFO - Running pre-action listener: _resource_record_pre_action 13:10:06 INFO - Running main action method: read_buildbot_config 13:10:06 INFO - Using buildbot properties: 13:10:06 INFO - { 13:10:06 INFO - "project": "", 13:10:06 INFO - "product": "firefox", 13:10:06 INFO - "script_repo_revision": "production", 13:10:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 13:10:06 INFO - "repository": "", 13:10:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 13:10:06 INFO - "buildid": "20161124103032", 13:10:06 INFO - "pgo_build": "True", 13:10:06 INFO - "basedir": "/builds/slave/test", 13:10:06 INFO - "buildnumber": 4, 13:10:06 INFO - "slavename": "talos-linux64-ix-057", 13:10:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:10:06 INFO - "platform": "ubuntu64_hw", 13:10:06 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 13:10:06 INFO - "branch": "mozilla-central", 13:10:06 INFO - "repo_path": "mozilla-central", 13:10:06 INFO - "revision": "bad312aefb42982f492ad2cf36f4c6c3d698f4f7", 13:10:06 INFO - "stage_platform": "linux64-pgo", 13:10:06 INFO - "builduid": "0a813220629143a09b6000ade01e4847", 13:10:06 INFO - "slavebuilddir": "test" 13:10:06 INFO - } 13:10:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 13:10:06 INFO - Running post-action listener: _resource_record_post_action 13:10:06 INFO - [mozharness: 2016-11-24 21:10:06.723343Z] Finished read-buildbot-config step (success) 13:10:06 INFO - [mozharness: 2016-11-24 21:10:06.723431Z] Running download-and-extract step. 13:10:06 INFO - Running pre-action listener: _resource_record_pre_action 13:10:06 INFO - Running main action method: download_and_extract 13:10:06 INFO - mkdir: /builds/slave/test/build/tests 13:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:06 INFO - trying https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 13:10:06 INFO - Downloading https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/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 13:10:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/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 13:10:07 INFO - Downloaded 1361 bytes. 13:10:07 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 13:10:07 INFO - Using the following test package requirements: 13:10:07 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 13:10:07 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:10:07 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:10:07 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:07 INFO - u'jsshell-linux-x86_64.zip'], 13:10:07 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:10:07 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 13:10:07 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:10:07 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:10:07 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:10:07 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:10:07 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:10:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 13:10:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:10:07 INFO - Fetch https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:10:07 INFO - Http code: 200 13:10:07 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 13:10:07 INFO - x-amz-cf-id: AQV5Lxc7FA6Sq71psMOiTSsijaeWjUS0JwVu5Yrs9lvs91fy4knRTA== 13:10:07 INFO - x-amz-version-id: ZsHIL9bOWLIA3I29X0bLQobbkx_mmAds 13:10:08 INFO - Expected file size: 21766752 13:10:08 INFO - Obtained file size: 21766752 13:10:12 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 13:10:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 13:10:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:10:12 INFO - Fetch https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:10:12 INFO - Http code: 200 13:10:12 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 13:10:12 INFO - x-amz-cf-id: DPw1hJkscY-w3Y6wAZbSx2jFCtyPGWu20fppWbPmDh6ZI9xY0fgjSg== 13:10:12 INFO - x-amz-version-id: ZsHIL9bOWLIA3I29X0bLQobbkx_mmAds 13:10:12 INFO - Expected file size: 21766752 13:10:12 INFO - Obtained file size: 21766752 13:10:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 13:10:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:10:17 INFO - Fetch https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:10:17 INFO - Http code: 200 13:10:17 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 13:10:17 INFO - x-amz-cf-id: gxe0UBlnMAvHdhDxRoUzx0hyvQ1Hy-b66VLNnY-Z80Eau6-6ja75aA== 13:10:17 INFO - x-amz-version-id: eFJT1.8KEQoEHhHhRrOCqAOJQQY9I9ul 13:10:18 INFO - Expected file size: 14409749 13:10:18 INFO - Obtained file size: 14409749 13:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:18 INFO - trying https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 13:10:18 INFO - Downloading https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/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 13:10:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/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 13:10:21 INFO - Downloaded 59774696 bytes. 13:10:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 13:10:21 INFO - mkdir: /builds/slave/test/properties 13:10:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:10:21 INFO - Writing to file /builds/slave/test/properties/build_url 13:10:21 INFO - Contents: 13:10:21 INFO - build_url:https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 13:10:22 INFO - Running post-action listener: _resource_record_post_action 13:10:22 INFO - Running post-action listener: set_extra_try_arguments 13:10:22 INFO - [mozharness: 2016-11-24 21:10:22.121178Z] Finished download-and-extract step (success) 13:10:22 INFO - [mozharness: 2016-11-24 21:10:22.121402Z] Running populate-webroot step. 13:10:22 INFO - Running pre-action listener: _resource_record_pre_action 13:10:22 INFO - Running main action method: populate_webroot 13:10:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:10:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:10:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:10:22 INFO - '--tppagecycles', 13:10:22 INFO - '7'], 13:10:22 INFO - 'tests': ['tsvgm']}}, 13:10:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:10:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:10:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:10:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:10:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:10:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:10:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:10:22 INFO - 'talos_options': ['--disable-e10s'], 13:10:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:10:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:10:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:10:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:10:22 INFO - 'talos_options': ['--disable-e10s'], 13:10:22 INFO - 'tests': ['damp', 'tps']}, 13:10:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:10:22 INFO - 'tests': ['damp', 'tps']}, 13:10:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:10:22 INFO - 'tests': ['dromaeo_dom']}, 13:10:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:10:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:10:22 INFO - 'tests': ['basic_compositor_video']}, 13:10:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:10:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:10:22 INFO - 'tests': ['a11yr', 13:10:22 INFO - 'ts_paint', 13:10:22 INFO - 'tpaint', 13:10:22 INFO - 'sessionrestore', 13:10:22 INFO - 'sessionrestore_no_auto_restore', 13:10:22 INFO - 'tabpaint']}, 13:10:22 INFO - 'other-e10s': {'tests': ['a11yr', 13:10:22 INFO - 'ts_paint', 13:10:22 INFO - 'tpaint', 13:10:22 INFO - 'sessionrestore', 13:10:22 INFO - 'sessionrestore_no_auto_restore', 13:10:22 INFO - 'tabpaint']}, 13:10:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:10:22 INFO - 'ts_paint', 13:10:22 INFO - 'tpaint', 13:10:22 INFO - 'sessionrestore', 13:10:22 INFO - 'sessionrestore_no_auto_restore', 13:10:22 INFO - 'tabpaint']}, 13:10:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:10:22 INFO - 'ts_paint', 13:10:22 INFO - 'tpaint', 13:10:22 INFO - 'sessionrestore', 13:10:22 INFO - 'sessionrestore_no_auto_restore', 13:10:22 INFO - 'tabpaint']}, 13:10:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:10:22 INFO - 'tests': ['a11yr', 13:10:22 INFO - 'ts_paint', 13:10:22 INFO - 'tpaint', 13:10:22 INFO - 'sessionrestore', 13:10:22 INFO - 'sessionrestore_no_auto_restore', 13:10:22 INFO - 'tabpaint']}, 13:10:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:10:22 INFO - 'tests': ['a11yr', 13:10:22 INFO - 'ts_paint', 13:10:22 INFO - 'tpaint', 13:10:22 INFO - 'sessionrestore', 13:10:22 INFO - 'sessionrestore_no_auto_restore', 13:10:22 INFO - 'tabpaint']}, 13:10:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:10:22 INFO - 'tests': ['tsvgx', 13:10:22 INFO - 'tsvgr_opacity', 13:10:22 INFO - 'tart', 13:10:22 INFO - 'tscrollx', 13:10:22 INFO - 'cart', 13:10:22 INFO - 'tsvg_static']}, 13:10:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:10:22 INFO - 'tsvgr_opacity', 13:10:22 INFO - 'tart', 13:10:22 INFO - 'tscrollx', 13:10:22 INFO - 'cart', 13:10:22 INFO - 'tsvg_static']}, 13:10:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:10:22 INFO - 'talos_options': ['--disable-e10s'], 13:10:22 INFO - 'tests': ['tp5o']}, 13:10:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:10:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:10:22 INFO - 'talos_options': ['--disable-e10s', 13:10:22 INFO - '--xperf_path', 13:10:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:10:22 INFO - 'tests': ['tp5n']}, 13:10:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:10:22 INFO - 'talos_options': ['--xperf_path', 13:10:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:10:22 INFO - 'tests': ['tp5n']}}, 13:10:22 INFO - 'talos.zip': {'path': '', 13:10:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:10:22 INFO - Running post-action listener: _resource_record_post_action 13:10:22 INFO - [mozharness: 2016-11-24 21:10:22.139814Z] Finished populate-webroot step (success) 13:10:22 INFO - [mozharness: 2016-11-24 21:10:22.139902Z] Running create-virtualenv step. 13:10:22 INFO - Running pre-action listener: _resource_record_pre_action 13:10:22 INFO - Running main action method: create_virtualenv 13:10:22 INFO - Creating virtualenv /builds/slave/test/build/venv 13:10:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:10:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:10:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:10:22 INFO - Using real prefix '/usr' 13:10:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:10:22 INFO - Installing distribute.............................................................................................................................................................................................done. 13:10:24 INFO - Installing pip.................done. 13:10:24 INFO - Return code: 0 13:10:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:10:24 INFO - Reading from file tmpfile_stdout 13:10:24 INFO - Output received: 13:10:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:10:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c29cee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1924b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4efc0>, '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 0x1b4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b50350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:10:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:10:24 INFO - Using env: {'DISPLAY': ':0', 13:10:24 INFO - 'HOME': '/home/cltbld', 13:10:24 INFO - 'LANG': 'en_US.UTF-8', 13:10:24 INFO - 'LANGUAGE': 'en_US:en', 13:10:24 INFO - 'LOGNAME': 'cltbld', 13:10:24 INFO - 'MAIL': '/var/mail/cltbld', 13:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:24 INFO - 'MOZ_NO_REMOTE': '1', 13:10:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:24 INFO - 'NO_EM_RESTART': '1', 13:10:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:24 INFO - 'PWD': '/builds/slave/test', 13:10:24 INFO - 'SHELL': '/bin/bash', 13:10:24 INFO - 'SHLVL': '1', 13:10:24 INFO - 'TERM': 'linux', 13:10:24 INFO - 'TMOUT': '86400', 13:10:24 INFO - 'USER': 'cltbld', 13:10:24 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 13:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:24 INFO - '_': '/tools/buildbot/bin/python'} 13:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:10:25 INFO - Cleaning up... 13:10:25 INFO - Return code: 0 13:10:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe7c29cee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1924b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4efc0>, '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 0x1b4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b50350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:10:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:10:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:10:25 INFO - Using env: {'DISPLAY': ':0', 13:10:25 INFO - 'HOME': '/home/cltbld', 13:10:25 INFO - 'LANG': 'en_US.UTF-8', 13:10:25 INFO - 'LANGUAGE': 'en_US:en', 13:10:25 INFO - 'LOGNAME': 'cltbld', 13:10:25 INFO - 'MAIL': '/var/mail/cltbld', 13:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:25 INFO - 'MOZ_NO_REMOTE': '1', 13:10:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:25 INFO - 'NO_EM_RESTART': '1', 13:10:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:25 INFO - 'PWD': '/builds/slave/test', 13:10:25 INFO - 'SHELL': '/bin/bash', 13:10:25 INFO - 'SHLVL': '1', 13:10:25 INFO - 'TERM': 'linux', 13:10:25 INFO - 'TMOUT': '86400', 13:10:25 INFO - 'USER': 'cltbld', 13:10:25 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 13:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:25 INFO - '_': '/tools/buildbot/bin/python'} 13:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:25 INFO - Downloading/unpacking psutil>=3.1.1 13:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:10:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:10:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:10:27 INFO - Installing collected packages: psutil 13:10:27 INFO - Running setup.py install for psutil 13:10:27 INFO - building 'psutil._psutil_linux' extension 13:10:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:10:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:10:27 INFO - building 'psutil._psutil_posix' extension 13:10:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:10:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:10:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:10:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:10:27 INFO - Successfully installed psutil 13:10:27 INFO - Cleaning up... 13:10:27 INFO - Return code: 0 13:10:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c29cee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1924b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4efc0>, '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 0x1b4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b50350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:10:27 INFO - Using env: {'DISPLAY': ':0', 13:10:27 INFO - 'HOME': '/home/cltbld', 13:10:27 INFO - 'LANG': 'en_US.UTF-8', 13:10:27 INFO - 'LANGUAGE': 'en_US:en', 13:10:27 INFO - 'LOGNAME': 'cltbld', 13:10:27 INFO - 'MAIL': '/var/mail/cltbld', 13:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:27 INFO - 'MOZ_NO_REMOTE': '1', 13:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:27 INFO - 'NO_EM_RESTART': '1', 13:10:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:27 INFO - 'PWD': '/builds/slave/test', 13:10:27 INFO - 'SHELL': '/bin/bash', 13:10:27 INFO - 'SHLVL': '1', 13:10:27 INFO - 'TERM': 'linux', 13:10:27 INFO - 'TMOUT': '86400', 13:10:27 INFO - 'USER': 'cltbld', 13:10:27 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 13:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:27 INFO - '_': '/tools/buildbot/bin/python'} 13:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:10:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:10:30 INFO - Installing collected packages: mozsystemmonitor 13:10:30 INFO - Running setup.py install for mozsystemmonitor 13:10:30 INFO - Successfully installed mozsystemmonitor 13:10:30 INFO - Cleaning up... 13:10:30 INFO - Return code: 0 13:10:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe7c29cee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1924b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4efc0>, '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 0x1b4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b50350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:10:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:10:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:10:30 INFO - Using env: {'DISPLAY': ':0', 13:10:30 INFO - 'HOME': '/home/cltbld', 13:10:30 INFO - 'LANG': 'en_US.UTF-8', 13:10:30 INFO - 'LANGUAGE': 'en_US:en', 13:10:30 INFO - 'LOGNAME': 'cltbld', 13:10:30 INFO - 'MAIL': '/var/mail/cltbld', 13:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:30 INFO - 'MOZ_NO_REMOTE': '1', 13:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:30 INFO - 'NO_EM_RESTART': '1', 13:10:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:30 INFO - 'PWD': '/builds/slave/test', 13:10:30 INFO - 'SHELL': '/bin/bash', 13:10:30 INFO - 'SHLVL': '1', 13:10:30 INFO - 'TERM': 'linux', 13:10:30 INFO - 'TMOUT': '86400', 13:10:30 INFO - 'USER': 'cltbld', 13:10:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 13:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:30 INFO - '_': '/tools/buildbot/bin/python'} 13:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:30 INFO - Downloading/unpacking jsonschema==2.5.1 13:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:10:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:32 INFO - Downloading functools32-3.2.3-2.tar.gz 13:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:10:32 INFO - warning: no files found matching '*.txt' 13:10:32 INFO - no previously-included directories found matching 'build' 13:10:32 INFO - no previously-included directories found matching 'dist' 13:10:32 INFO - no previously-included directories found matching '.git*' 13:10:32 INFO - Installing collected packages: jsonschema, functools32 13:10:32 INFO - Running setup.py install for functools32 13:10:32 INFO - warning: no files found matching '*.txt' 13:10:32 INFO - no previously-included directories found matching 'build' 13:10:32 INFO - no previously-included directories found matching 'dist' 13:10:32 INFO - no previously-included directories found matching '.git*' 13:10:32 INFO - Successfully installed jsonschema functools32 13:10:32 INFO - Cleaning up... 13:10:32 INFO - Return code: 0 13:10:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:32 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 0x7fe7c29cee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1924b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4efc0>, '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 0x1b4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b50350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:10:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:10:32 INFO - Using env: {'DISPLAY': ':0', 13:10:32 INFO - 'HOME': '/home/cltbld', 13:10:32 INFO - 'LANG': 'en_US.UTF-8', 13:10:32 INFO - 'LANGUAGE': 'en_US:en', 13:10:32 INFO - 'LOGNAME': 'cltbld', 13:10:32 INFO - 'MAIL': '/var/mail/cltbld', 13:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:32 INFO - 'MOZ_NO_REMOTE': '1', 13:10:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:32 INFO - 'NO_EM_RESTART': '1', 13:10:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:32 INFO - 'PWD': '/builds/slave/test', 13:10:32 INFO - 'SHELL': '/bin/bash', 13:10:32 INFO - 'SHLVL': '1', 13:10:32 INFO - 'TERM': 'linux', 13:10:32 INFO - 'TMOUT': '86400', 13:10:32 INFO - 'USER': 'cltbld', 13:10:32 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 13:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:32 INFO - '_': '/tools/buildbot/bin/python'} 13:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:10:33 INFO - Cleaning up... 13:10:33 INFO - Return code: 0 13:10:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:33 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 0x7fe7c29cee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1924b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4efc0>, '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 0x1b4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b50350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:10:33 INFO - Using env: {'DISPLAY': ':0', 13:10:33 INFO - 'HOME': '/home/cltbld', 13:10:33 INFO - 'LANG': 'en_US.UTF-8', 13:10:33 INFO - 'LANGUAGE': 'en_US:en', 13:10:33 INFO - 'LOGNAME': 'cltbld', 13:10:33 INFO - 'MAIL': '/var/mail/cltbld', 13:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:33 INFO - 'MOZ_NO_REMOTE': '1', 13:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:33 INFO - 'NO_EM_RESTART': '1', 13:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:33 INFO - 'PWD': '/builds/slave/test', 13:10:33 INFO - 'SHELL': '/bin/bash', 13:10:33 INFO - 'SHLVL': '1', 13:10:33 INFO - 'TERM': 'linux', 13:10:33 INFO - 'TMOUT': '86400', 13:10:33 INFO - 'USER': 'cltbld', 13:10:33 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 13:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:33 INFO - '_': '/tools/buildbot/bin/python'} 13:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:33 INFO - Downloading/unpacking blobuploader==1.2.4 13:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:35 INFO - Downloading blobuploader-1.2.4.tar.gz 13:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:10:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:10:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:36 INFO - Downloading docopt-0.6.1.tar.gz 13:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:10:36 INFO - Installing collected packages: blobuploader, requests, docopt 13:10:36 INFO - Running setup.py install for blobuploader 13:10:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:10:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:10:36 INFO - Running setup.py install for requests 13:10:36 INFO - Running setup.py install for docopt 13:10:36 INFO - Successfully installed blobuploader requests docopt 13:10:36 INFO - Cleaning up... 13:10:36 INFO - Return code: 0 13:10:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:36 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 0x7fe7c29cee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1924b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4efc0>, '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 0x1b4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b50350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:10:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:10:36 INFO - Using env: {'DISPLAY': ':0', 13:10:36 INFO - 'HOME': '/home/cltbld', 13:10:36 INFO - 'LANG': 'en_US.UTF-8', 13:10:36 INFO - 'LANGUAGE': 'en_US:en', 13:10:36 INFO - 'LOGNAME': 'cltbld', 13:10:36 INFO - 'MAIL': '/var/mail/cltbld', 13:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:36 INFO - 'MOZ_NO_REMOTE': '1', 13:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:36 INFO - 'NO_EM_RESTART': '1', 13:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:36 INFO - 'PWD': '/builds/slave/test', 13:10:36 INFO - 'SHELL': '/bin/bash', 13:10:36 INFO - 'SHLVL': '1', 13:10:36 INFO - 'TERM': 'linux', 13:10:36 INFO - 'TMOUT': '86400', 13:10:36 INFO - 'USER': 'cltbld', 13:10:36 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 13:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:36 INFO - '_': '/tools/buildbot/bin/python'} 13:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:10:36 INFO - Running setup.py (path:/tmp/pip-P_f5By-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:10:37 INFO - Running setup.py (path:/tmp/pip-nFf54e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:10:37 INFO - Running setup.py (path:/tmp/pip-E03NVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:10:37 INFO - Running setup.py (path:/tmp/pip-gvGIax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:10:37 INFO - Running setup.py (path:/tmp/pip-vSL_br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:10:37 INFO - Running setup.py (path:/tmp/pip-tU_pue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:10:37 INFO - Running setup.py (path:/tmp/pip-d16viH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:10:37 INFO - Running setup.py (path:/tmp/pip-JUkLqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:10:37 INFO - Running setup.py (path:/tmp/pip-BA1OOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:10:37 INFO - Running setup.py (path:/tmp/pip-gYLYw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:10:37 INFO - Running setup.py (path:/tmp/pip-sXURF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:10:37 INFO - Running setup.py (path:/tmp/pip-xQOd5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:10:37 INFO - Running setup.py (path:/tmp/pip-GTn2C9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:10:37 INFO - Running setup.py (path:/tmp/pip-UAgUSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:10:37 INFO - Running setup.py (path:/tmp/pip-ShPOOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:10:38 INFO - Running setup.py (path:/tmp/pip-CAzGWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:10:38 INFO - Running setup.py (path:/tmp/pip-hzsXs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:10:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:10:38 INFO - Running setup.py install for manifestparser 13:10:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:10:38 INFO - Running setup.py install for mozcrash 13:10:38 INFO - Running setup.py install for mozdebug 13:10:38 INFO - Running setup.py install for mozdevice 13:10:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:10:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:10:38 INFO - Running setup.py install for mozfile 13:10:38 INFO - Running setup.py install for mozhttpd 13:10:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:10:38 INFO - Running setup.py install for mozinfo 13:10:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:10:38 INFO - Running setup.py install for mozInstall 13:10:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:10:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:10:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:10:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:10:38 INFO - Running setup.py install for mozleak 13:10:39 INFO - Running setup.py install for mozlog 13:10:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:10:39 INFO - Running setup.py install for moznetwork 13:10:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:10:39 INFO - Running setup.py install for mozprocess 13:10:39 INFO - Running setup.py install for mozprofile 13:10:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:10:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:10:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:10:39 INFO - Running setup.py install for mozrunner 13:10:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:10:39 INFO - Running setup.py install for mozscreenshot 13:10:39 INFO - Running setup.py install for moztest 13:10:39 INFO - Running setup.py install for mozversion 13:10:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:10:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:10:39 INFO - Cleaning up... 13:10:39 INFO - Return code: 0 13:10:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:40 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 0x7fe7c29cee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1924b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4efc0>, '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 0x1b4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b50350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:10:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:10:40 INFO - Using env: {'DISPLAY': ':0', 13:10:40 INFO - 'HOME': '/home/cltbld', 13:10:40 INFO - 'LANG': 'en_US.UTF-8', 13:10:40 INFO - 'LANGUAGE': 'en_US:en', 13:10:40 INFO - 'LOGNAME': 'cltbld', 13:10:40 INFO - 'MAIL': '/var/mail/cltbld', 13:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:40 INFO - 'MOZ_NO_REMOTE': '1', 13:10:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:40 INFO - 'NO_EM_RESTART': '1', 13:10:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:40 INFO - 'PWD': '/builds/slave/test', 13:10:40 INFO - 'SHELL': '/bin/bash', 13:10:40 INFO - 'SHLVL': '1', 13:10:40 INFO - 'TERM': 'linux', 13:10:40 INFO - 'TMOUT': '86400', 13:10:40 INFO - 'USER': 'cltbld', 13:10:40 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 13:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:40 INFO - '_': '/tools/buildbot/bin/python'} 13:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:10:40 INFO - Running setup.py (path:/tmp/pip-Xjf5Dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:10:40 INFO - Running setup.py (path:/tmp/pip-m9qqRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:10:40 INFO - Running setup.py (path:/tmp/pip-leTbv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:10:40 INFO - Running setup.py (path:/tmp/pip-8BwRdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:10:40 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)) 13:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:10:40 INFO - Running setup.py (path:/tmp/pip-7uM01A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:10:40 INFO - Running setup.py (path:/tmp/pip-A4Jp8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:10:40 INFO - Running setup.py (path:/tmp/pip-KBcKCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:10:40 INFO - Running setup.py (path:/tmp/pip-gGSnYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:10:40 INFO - Running setup.py (path:/tmp/pip-lfFvI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:10:40 INFO - Running setup.py (path:/tmp/pip-fknFgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:10:40 INFO - Running setup.py (path:/tmp/pip-OLqkGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:10:41 INFO - Running setup.py (path:/tmp/pip-5qyKTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:10:41 INFO - Running setup.py (path:/tmp/pip-lDGuQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:10:41 INFO - Running setup.py (path:/tmp/pip-ASFOiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:10:41 INFO - Running setup.py (path:/tmp/pip-RCcvOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:10:41 INFO - Running setup.py (path:/tmp/pip-cF34uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:10:41 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)) 13:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:10:41 INFO - Running setup.py (path:/tmp/pip-_lKRuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:10:41 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)) 13:10:41 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)) 13:10:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:10: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 13:10: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 13:10: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 13:10: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 13:10: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 13:10: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 13:10:43 INFO - Downloading blessings-1.6.tar.gz 13:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:10:43 INFO - Installing collected packages: blessings 13:10:43 INFO - Running setup.py install for blessings 13:10:43 INFO - Successfully installed blessings 13:10:43 INFO - Cleaning up... 13:10:43 INFO - Return code: 0 13:10:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:10:43 INFO - Reading from file tmpfile_stdout 13:10:43 INFO - Current package versions: 13:10:43 INFO - argparse == 1.2.1 13:10:43 INFO - blessings == 1.6 13:10:43 INFO - blobuploader == 1.2.4 13:10:43 INFO - docopt == 0.6.1 13:10:43 INFO - functools32 == 3.2.3-2 13:10:43 INFO - jsonschema == 2.5.1 13:10:43 INFO - manifestparser == 1.1 13:10:43 INFO - mozInstall == 1.12 13:10:43 INFO - mozcrash == 1.0 13:10:43 INFO - mozdebug == 0.1 13:10:43 INFO - mozdevice == 0.49 13:10:43 INFO - mozfile == 1.2 13:10:43 INFO - mozhttpd == 0.7 13:10:43 INFO - mozinfo == 0.9 13:10:43 INFO - mozleak == 0.1 13:10:43 INFO - mozlog == 3.4 13:10:43 INFO - moznetwork == 0.27 13:10:43 INFO - mozprocess == 0.23 13:10:43 INFO - mozprofile == 0.28 13:10:43 INFO - mozrunner == 6.13 13:10:43 INFO - mozscreenshot == 0.1 13:10:43 INFO - mozsystemmonitor == 0.3 13:10:43 INFO - moztest == 0.7 13:10:43 INFO - mozversion == 1.4 13:10:43 INFO - psutil == 3.1.1 13:10:43 INFO - requests == 1.2.3 13:10:43 INFO - wsgiref == 0.1.2 13:10:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:43 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 0x7fe7c29cee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1924b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4efc0>, '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 0x1b4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b50350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:10:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:10:43 INFO - Using env: {'DISPLAY': ':0', 13:10:43 INFO - 'HOME': '/home/cltbld', 13:10:43 INFO - 'LANG': 'en_US.UTF-8', 13:10:43 INFO - 'LANGUAGE': 'en_US:en', 13:10:43 INFO - 'LOGNAME': 'cltbld', 13:10:43 INFO - 'MAIL': '/var/mail/cltbld', 13:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:43 INFO - 'MOZ_NO_REMOTE': '1', 13:10:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:43 INFO - 'NO_EM_RESTART': '1', 13:10:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:43 INFO - 'PWD': '/builds/slave/test', 13:10:43 INFO - 'SHELL': '/bin/bash', 13:10:43 INFO - 'SHLVL': '1', 13:10:43 INFO - 'TERM': 'linux', 13:10:43 INFO - 'TMOUT': '86400', 13:10:43 INFO - 'USER': 'cltbld', 13:10:43 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 13:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:43 INFO - '_': '/tools/buildbot/bin/python'} 13:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:10:44 INFO - Cleaning up... 13:10:44 INFO - Return code: 0 13:10:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:44 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 0x7fe7c29cee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1924b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4efc0>, '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 0x1b4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b50350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:10:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:10:44 INFO - Using env: {'DISPLAY': ':0', 13:10:44 INFO - 'HOME': '/home/cltbld', 13:10:44 INFO - 'LANG': 'en_US.UTF-8', 13:10:44 INFO - 'LANGUAGE': 'en_US:en', 13:10:44 INFO - 'LOGNAME': 'cltbld', 13:10:44 INFO - 'MAIL': '/var/mail/cltbld', 13:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:44 INFO - 'MOZ_NO_REMOTE': '1', 13:10:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:44 INFO - 'NO_EM_RESTART': '1', 13:10:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:44 INFO - 'PWD': '/builds/slave/test', 13:10:44 INFO - 'SHELL': '/bin/bash', 13:10:44 INFO - 'SHLVL': '1', 13:10:44 INFO - 'TERM': 'linux', 13:10:44 INFO - 'TMOUT': '86400', 13:10:44 INFO - 'USER': 'cltbld', 13:10:44 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 13:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:44 INFO - '_': '/tools/buildbot/bin/python'} 13:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:10:44 INFO - Cleaning up... 13:10:44 INFO - Return code: 0 13:10:44 INFO - Running post-action listener: _resource_record_post_action 13:10:44 INFO - Running post-action listener: _start_resource_monitoring 13:10:44 INFO - Starting resource monitoring. 13:10:44 INFO - [mozharness: 2016-11-24 21:10:44.407252Z] Finished create-virtualenv step (success) 13:10:44 INFO - [mozharness: 2016-11-24 21:10:44.407783Z] Running install step. 13:10:44 INFO - Running pre-action listener: _resource_record_pre_action 13:10:44 INFO - Running main action method: install 13:10:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:10:44 INFO - Reading from file tmpfile_stdout 13:10:44 INFO - Detecting whether we're running mozinstall >=1.0... 13:10:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:10:44 INFO - Reading from file tmpfile_stdout 13:10:44 INFO - Output received: 13:10:44 INFO - Usage: mozinstall [options] installer 13:10:44 INFO - Options: 13:10:44 INFO - -h, --help show this help message and exit 13:10:44 INFO - -d DEST, --destination=DEST 13:10:44 INFO - Directory to install application into. [default: 13:10:44 INFO - "/builds/slave/test"] 13:10:44 INFO - --app=APP Application being installed. [default: firefox] 13:10:44 INFO - mkdir: /builds/slave/test/build/application 13:10:44 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'] 13:10:44 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 13:11:01 INFO - Reading from file tmpfile_stdout 13:11:01 INFO - Output received: 13:11:01 INFO - /builds/slave/test/build/application/firefox/firefox 13:11:01 INFO - Running post-action listener: _resource_record_post_action 13:11:01 INFO - [mozharness: 2016-11-24 21:11:01.664367Z] Finished install step (success) 13:11:01 INFO - [mozharness: 2016-11-24 21:11:01.664608Z] Running run-tests step. 13:11:01 INFO - Running pre-action listener: _resource_record_pre_action 13:11:01 INFO - Running main action method: run_tests 13:11:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:11:01 INFO - Python 2.7.3 13:11:01 INFO - Return code: 0 13:11:01 INFO - grabbing minidump binary from tooltool 13:11: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')]} 13:11:01 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 0x1b4efc0>, '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 0x1b4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b50350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:11:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:11:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:11:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:11:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:11:01 INFO - Return code: 0 13:11:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:11:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:11:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:11:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:11:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:11:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:11:01 INFO - Using env: {'DISPLAY': ':0', 13:11:01 INFO - 'HOME': '/home/cltbld', 13:11:01 INFO - 'LANG': 'en_US.UTF-8', 13:11:01 INFO - 'LANGUAGE': 'en_US:en', 13:11:01 INFO - 'LOGNAME': 'cltbld', 13:11:01 INFO - 'MAIL': '/var/mail/cltbld', 13:11:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:11:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:01 INFO - 'MOZ_NO_REMOTE': '1', 13:11:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:01 INFO - 'NO_EM_RESTART': '1', 13:11:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:01 INFO - 'PWD': '/builds/slave/test', 13:11:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:11:01 INFO - 'SHELL': '/bin/bash', 13:11:01 INFO - 'SHLVL': '1', 13:11:01 INFO - 'TERM': 'linux', 13:11:01 INFO - 'TMOUT': '86400', 13:11:01 INFO - 'USER': 'cltbld', 13:11:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043', 13:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:01 INFO - '_': '/tools/buildbot/bin/python'} 13:11:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:11:01 INFO - mozversion application_buildid: 20161124103032 13:11:01 INFO - mozversion application_changeset: bad312aefb42982f492ad2cf36f4c6c3d698f4f7 13:11:01 INFO - mozversion application_display_name: Nightly 13:11:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:11:01 INFO - mozversion application_name: Firefox 13:11:01 INFO - mozversion application_remotingname: firefox 13:11:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:11:01 INFO - mozversion application_vendor: Mozilla 13:11:01 INFO - mozversion application_version: 53.0a1 13:11:01 INFO - mozversion platform_buildid: 20161124103032 13:11:01 INFO - mozversion platform_changeset: bad312aefb42982f492ad2cf36f4c6c3d698f4f7 13:11:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:11:01 INFO - mozversion platform_version: 53.0a1 13:11:01 INFO - using testdate: 1480021861 13:11:01 INFO - actual date: 1480021861 13:11:01 INFO - starting webserver on 'localhost:42097' 13:11:01 INFO - SUITE-START | Running 2 tests 13:11:01 INFO - TEST-START | dromaeo_css 13:11:01 INFO - operating with platform_type : linux_ 13:11:01 INFO - Initialising browser for dromaeo_css test... 13:11:01 INFO - TEST-INFO | started process 15851 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpydGoQP/profile http://localhost:42097/getInfo.html) 13:11:06 INFO - PROCESS | 15851 | __metrics Screen width/height:1600/1200 13:11:06 INFO - PROCESS | 15851 | colorDepth:24 13:11:06 INFO - PROCESS | 15851 | Browser inner width/height: 1024/697 13:11:06 INFO - PROCESS | 15851 | __metrics 13:11:07 INFO - PROCESS | 15851 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:11:07 INFO - PROCESS | 15851 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:11:07 INFO - PROCESS | 15851 | console.error: PushService: 13:11:07 INFO - PROCESS | 15851 | stateChangeProcessEnqueue: Error transitioning state 13:11:07 INFO - PROCESS | 15851 | UnknownError 13:11:08 INFO - TEST-INFO | 15851: exit 0 13:11:08 INFO - Browser initialized. 13:11:08 INFO - Running cycle 1/1 for dromaeo_css test... 13:11:08 INFO - TEST-INFO | started process 15936 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpydGoQP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:11:20 INFO - PROCESS | 15936 | RSS: Main: 173703168 13:11:20 INFO - PROCESS | 15936 | 13:12:11 INFO - PROCESS | 15936 | 1480021931577 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] 13:14:23 INFO - PROCESS | 15936 | Cycle 1(1): loaded http://localhost:42097/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42097/tests/dromaeo/cssquery-ext.html) 13:14:24 INFO - PROCESS | 15936 | RSS: Main: 326193152 13:14:24 INFO - PROCESS | 15936 | 13:17:27 INFO - PROCESS | 15936 | Cycle 1(1): loaded http://localhost:42097/tests/dromaeo/cssquery-ext.html (next: http://localhost:42097/tests/dromaeo/cssquery-jquery.html) 13:17:27 INFO - PROCESS | 15936 | RSS: Main: 276860928 13:17:27 INFO - PROCESS | 15936 | 13:20:29 INFO - PROCESS | 15936 | Cycle 1(1): loaded http://localhost:42097/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42097/tests/dromaeo/cssquery-mootools.html) 13:20:30 INFO - PROCESS | 15936 | RSS: Main: 221233152 13:20:30 INFO - PROCESS | 15936 | 13:23:32 INFO - PROCESS | 15936 | Cycle 1(1): loaded http://localhost:42097/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42097/tests/dromaeo/cssquery-prototype.html) 13:23:33 INFO - PROCESS | 15936 | RSS: Main: 270258176 13:23:33 INFO - PROCESS | 15936 | 13:26:35 INFO - PROCESS | 15936 | Cycle 1(1): loaded http://localhost:42097/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42097/tests/dromaeo/cssquery-yui.html) 13:26:36 INFO - PROCESS | 15936 | RSS: Main: 221478912 13:26:36 INFO - PROCESS | 15936 | 13:29:39 INFO - PROCESS | 15936 | Cycle 1(1): loaded http://localhost:42097/tests/dromaeo/cssquery-yui.html (next: http://localhost:42097/tests/dromaeo/cssquery-dojo.html) 13:29:39 INFO - PROCESS | 15936 | RSS: Main: 312045568 13:29:39 INFO - PROCESS | 15936 | 13:29:39 INFO - PROCESS | 15936 | __start_tp_report 13:29:39 INFO - PROCESS | 15936 | _x_x_mozilla_page_load 13:29:39 INFO - PROCESS | 15936 | _x_x_mozilla_page_load_details 13:29:39 INFO - PROCESS | 15936 | |i|pagename|runs| 13:29:39 INFO - PROCESS | 15936 | |0;dojo.html;2979.2105092150578;2998.9400211995776;3023.4557779599677;3035.7723170762197;3040.7719421043425;5165.121929272023;5281.656692314997;5285.180796976465;5286.762095705692;5378.731063446827;5289.18017707256;5300.893982120355;5306.283651707018;5316.4683531646815;5327.36071671399;4811.061842940628;4838.709677419366;4852.859577999185;4869.4887036861155;4887.755612219393;4875.41495020598;4889.53549412807;4909.189983652693;4917.4344950330815;4918.262260660912;4875.7074575525585;4923.852284431473;4924.28597853311;4934.679245849008;4935.679180853251;4949.727764972925;4958.925616115779;4986.2769898364895;4988.451270360258;5031.270465782441;4725.40932383452;4742.478327383985;4891.8777030574165;4911.287863259843;4931.7780699868235;5237.292965449692;5305.840824775263;5310.468953104697;5324.041672498949;5338.546223571001;5687.289088863892;5731.99690054243;5734.455226753452;5746.683932383718;5748.223989761413;5575.275214222125;5643.774249030034;5767.221425107598;5776.682282474462;5785.82642520725;5296.92054619181;5323.414424413311;5334.493223143756;5335.759890804923;5387.703676297763;5732.996725573008;5798.536117110621;5800.419958004166;5807.419258074243;5807.82576522705;5451.4276001019325;5562.833115006556;5563.248961390161;5569.248151499577;5570.693611851387;5570.248016517799;5708.143778433186;5715.485606295453;5744.368119506935;5767.394423585547;5648.85877853057;5691.430856914359;5692.430756924275;5694.4590263924865;5701.600887937804;5704.258446401941;5718;5720.256366672306;5721.828345149652;5753.280839895013;4273.18809426208;4308.978455107705;4319;4342.392065110887;4344.066025804467;3872.8644497442456;3880.049387899926;3889.7082718796205;3911.8630847920185;3921.921471595277;5373.785048598091;5380.946190538045;5385.461453854661;5388.5419739321815;5442.945570544323;5539.667619942817;5634.915476267859;5642.943570564324;5688.829335119953;5702.48677619008;5415.404305526389;5432.619716619799;5434.076207044733;5440.863978400572;5487.890242195213;4954.083494553519;4955.207166853286;4960.454350021495;4962.354893863847;4968.180250258667;5661.886762264649;5724.914126288026;5933.050711886164;5938.079597662369;5945.10823376497;5598.636088654224;5692.117721753135;5712.143178523254;5746.109353050284;5818.359980402237;5968.731407086605;5976.551758618034;5979.431953964367;5982.162497250301;5990.251218597676;5587.413321601336;5647.943520564741;5648.181013753065;5649.039663257338;5650;5703.657780533182;5750.654960702372;5750.971245143747;5760.94239057604;5762.827115186551;5409.323834520685;5468.890622187613;5536.667799932017;5586.16207568868;5592.720363981866;5571.247881535941;5597.27235459404;5600.887982240414;5601.991641504568;5634.098544232903;5561.777528898799;5563.499285064364;5581.469760372758;5602.215689803512;5616.21373007771;5442.918356224739;5493.23094766741;5513.255710479194;5627.831165065055;5691.544676425959;5355.277037599874;5369.1140961740875;5479.3972663007835;5554.2779438672715;5554.694491802989 13:29:39 INFO - PROCESS | 15936 | |1;ext.html;533.6981932186804;582.4845012164235;594.1859652276382;607.9544034197434;622.4895585619794;31255;42665.57334426655;43548.3467747984;43582.34626480597;43635;44028;44225.33661995073;44272.55727442724;44314.33528497075;44400;7915.445918785687;8091.676332946675;8478.703245386429;8627.482351058925;8636.222739953402;10128.088472037514;10378.32540884844;10380.377177369382;10663.200259980495;10666.146708263359;10473.79052418955;10534.420606866619;10548.68353949379;10549.050585447309;10550.314229575053;10305.330153539995;10356.275060745751;10359.274850760374;10359.689209323695;10367.792644147075;10177.18582513397;10220.591176352937;10246.333988290811;10252.846207306897;10256.38461692301;40209;40395;40510;40514.17686204128;40537.391939120935;3439.6216416194197;3525.1363415962996;3536.7877927324444;3649.908752281188;3850.306944749944;30244.09267721972;30472;30543.38913221723;30649;30809.845950770326;3960.6237407446247;4072.9389059164137;4132.297509423405;4136.152088821785;4162.62536371728;339518;340096;340264;340944;342730.44504214544;56306.71846640741;56546;56635.716821415626;56640.43359566434;56682;57955;58109.12836307459;58393.70803146042;58413.41586584165;58418.4158158413;16303;16869.15654217284;16890.493285201464;16891.155442228086;16892.40876569314;11628.825567616492;11727.589534366427;11883.881161188277;11946.402679866145;12990.480380784662;15870.127143007245;16079.678406431805;16133.435329763402;16133.919330403507;16137.112458814643;6084.4828189603495;6175.164469576297;6226.439620434183;6288.654124023223;6309.2428908530355;924.9861252081224;941.2893265584577;1028.4240825137947;1045.3936716704293;1074.4735079810837;30714.385712286075;31079.84460077685;31801.52297715536;32256.83871580674;34168.316633667186;1050.5850189175385;1092.4919912240846;1110.0897264243404;1140.4525827602797;1155.734759870646;14592.489262875748;15593.220338983232;15602.687946241012;15923.283452244677;16113.27490262941;468076;468501;469032;470818;471880;53794.46205537973;53870;53878.46121538813;53881.73059134679;54279.45720542823;1226.6565361698738;1256.7172386213213;1267.6007057776771;1328.2030781531005;1359.238826257299;29603.25991850135;30914.536281955337;31719.742051142148;31758.841205793822;32293.18722629949;46490;46867.29699054585;47078.293825593326;47099.52900470951;47176.7641161792;375924;377703;377855;378745;379635;26507.469850603266;26562;26717.866410667822;26922.32694182661;28081.859590701915;45205.77397112994;45229.09541809211;45327.32009019933;45509.31736023896;45533;37292.254154916205;37908.62091379051;38535.80732096434;39703;40040;36948.630513694516;38029.809850950565;38133.618663814115;38849.41725874058;39048.21903561856;39028.219435611696;39088;39148.412773807846;39189.2162156761;39201.215975679756;32639.510407343434;33970.66029339675;35133.121671958404;35276.647233527336;35337.116572085906;26149.60775588406;27768.583471248352;27932.30169245785;27946.580801288404;28010 13:29:39 INFO - PROCESS | 15936 | |2;jquery.html;361.882388223827;385.5931991748704;396.7302234480553;399.26734442298385;416.5605286422823;13601.45594176233;18406.539836504093;18413.907930460347;19196.23215071399;19370.934598597072;18030.27878884843;18836;18849;18952.24191032357;18976.715349269773;5460.153676180188;5779.104238842965;5781.624194427349;5782.508486778629;5796.507296879749;4115.176964607091;4340.392345071693;5641.210230567724;6083.17877086592;6353.0788035734795;6440.066190402389;6454.80635580931;6456.160699109109;6463.289038205794;6464.482841372679;6123.90814137786;6238.500919926418;6262.436380725757;6291.245050593935;6300.527460440485;4832.395950506187;5101.948980510185;5536.861578460531;5550.056490396642;5552.41699621542;13241.073124881263;13271.86728132716;13290.069695121345;13456.865431345659;19308.71036934447;2315.386422598013;2350.553394854989;2407.1815582701965;2459.754024597526;2714.429969706364;9831;10114.089731924161;10257.384556926609;10576.52405641748;10607.15142788575;1891.4609336339076;1908.5811520148113;1910.732497450358;1917.8561607879465;1954.6774782160926;77495.70051593789;80460;82059;82289;83590;10780.676579702622;10841.186910981707;11071.72320691989;11119.777604447865;11187.32876027441;15661.608459788597;15662.373505059897;15682.215889205494;15686.215689215494;15701.214939252992;7625.313721765067;7837.647305871249;7905.249001344863;7912.248336408032;7964.681412743425;7386.224446433154;7395.630218489054;7415.962920185472;7569.1295501018085;7602.543847369176;4657.3246879202325;4776.331313616027;4804.390529172766;4849.806007759721;4874.683145595596;1905.1902941249914;1939.8545109116872;1960.617679552502;1971.8225359717694;2008.4777957731096;829.668132746906;908.4458480326995;914.5884352041608;933.2394098809449;1015.4465816130227;17585.648287034186;19058.714119288223;19169.8083019168;19192.13635386411;19340.226390944485;911.5670056723136;944.5182956691999;947.393668052447;949.2216382566229;964.5804075227298;9880.703578892644;10363.407652459855;10608.734781630366;10624;10692.358458492516;364223;433280;446217;446659;447450;90744.5462772682;94278.52860735789;94370;94794.52602736941;99729.07044168569;985.7683444390562;1007.9647212347533;1015.6851376073441;1051.0330495943597;1059.1050562274866;16432.83567164361;16664.50006499807;16865.241064151898;17212.913935430242;17491.21289541999;39512.60487395089;40468.392974106;40705;41365;41592;55429.44570554243;55511.72244138754;55738;57272;58059.709701451226;8211.71259005932;8335.666573337;8383.916160838313;8437.198466145706;8786.209241168326;11823.70440738954;11918.821217681569;11989.76020479603;12081.879181208076;12343.506259749509;10986.945065274942;11086.833697494705;11122.833157502806;11193.664679389289;11558.711032223926;10274.332168409328;10319;10391.298262451666;10415.739606509898;10797.190210734068;10754.139668826632;10927.945360273148;11055.0603198729;11179.441027948733;11376.374299413612;8105.635246413807;8149.857337799281;8378.958105209435;8463.57682115904;8500.234978851933;10913.508892099715;10925.508352124014;10967.616133435291;11010.614628487965;11498.94250528742 13:29:39 INFO - PROCESS | 15936 | |3;mootools.html;1261.9179753316039;1387.2300873015479;1420.7158568286343;1501.4594745891477;1698.804637466691;6923.619200943946;7558.395328373731;7784.260495252942;7796.92203077969;7997.640106195221;7813.062432508107;7881.7241396551135;7892.842143157133;7907;7911.129775724666;1923.422973108062;1988.3935399703084;2253.4479052632128;2288.8168946484243;2289.7710228977135;2216.645336746121;2312.3294244669028;2321.257197696738;2342.8711420871846;2344.402177444749;2287.3938406322336;2294.8852557372147;2304.032306431303;2306.4464528513204;2323.5236776460783;2276.362618466832;2279.32759835848;2290.6449500327476;2296.0586159674535;2297.3337732057685;2206.9668954965687;2215.036459140279;2216.3240211735415;2220.0897631970815;2244.8091912187483;7702.9229707703325;7825.608719563999;7826.608669566556;7827.373810095236;7836.059672839296;4788.928166077511;4934.851954441372;4936.851894443173;4938.950610493885;4940.5059494050665;2981.8956336528117;3124.6875312468796;3155.8422078895965;3158.115727596277;3162.8892988745515;1031.9896801031969;1046.9581216751321;1082.880883102858;1087.1140020882956;1098.4288170151556;10246.897531024744;10508.579656813794;10516.158707303397;10608.681739547748;10753.30103543275;4221.831126754895;4314;4373.562643735601;4428.601425871687;4446.377072368627;8301.667933282723;8406.74779756596;8413.074561798197;8416.621252043551;8419.158084191531;4986.152354099811;4995.150824359867;4997.450280469146;4998.575121114746;5000.724960127155;3967.5238971323047;4248.808803603845;4526.502084770673;4711.2226482629985;4711.45818230901;3407.6592340765724;3457.533233013511;3519.225770330523;3543.76965497247;3565.3047655707405;1089.0634054712941;1115.9944200278946;1121.2655710509466;1127.8702949160788;1128.4696192789377;973.2846357926918;981.6367943860818;981.788915383196;1000.5247507433911;1001.1240164855751;5357.571394288448;5648.124540696116;5654.830355089354;5667.631603945731;5807.5063619591965;995.8406654935176;1012.8987101289812;1032.2155162076726;1046.3669479964512;1051.164324362134;3826.081740382344;3876.9806150969066;3888.591697871739;3896.298666240104;3982.8008599569907;9260.166585007382;9485.810283794286;9508.334416590911;9535.189508891823;9587.280953928483;9411.858822117674;9447.291453141042;9453.480058596842;9457.38526995743;9480.431174129575;7356.816079598053;7458.440616953641;7549.169591344948;7556.168821429638;7562.773116806505;5369.4093649697725;5406.107992181246;5523.502884740393;5675.0636145035605;5792.53659707214;8763.956180219058;8799.736007919773;8808.986966498935;8842.867356989522;8875.112488751074;8940.15068568485;8947.955260223658;9004.684836030707;9029.187373136449;9044.005159432325;5952.910706339322;6128.203333566787;6489.383508566679;6762.932370676231;6894.655267236719;7440.627968601657;7650.65572049248;7663.27198916102;7707.653155607899;7717.2668596483245;6816.386525212754;6874.072000279898;6922.169339679271;6943.236244013256;7099.183593886769;6800.829979250559;6898.586084834926;6935.757248496278;6938.23679395256;6967.895481567679;6422.747564224931;6523.608583485006;6578.5395022347975;6580.7038683260325;6590.2421221560135;4941.851744447672;4971.552560269593;5039.26930595069;5044.4198917125;5044.9243261350375;4848.515148485123;4880.463149053672;4989.301497790239;5052.621053421081;5239.790408383622 13:29:39 INFO - PROCESS | 15936 | |4;prototype.html;318.6097031136859;330.75358857651054;336.77436117801074;337.6404129601973;342.4503671607069;5153.969206158774;5290.867728306795;5298.20526920962;5326.280952071474;5342.038433082043;5213.400458947222;5228.490324644173;5231.398389185245;5235.214717792333;5258.737063146837;4188.790560471979;4189.476315460567;4205.663546916239;4223.788810559475;4232.53442121368;4143.171365726852;4150.156823030864;4191.685623578229;4256.808443620029;4257.3183592480955;4128.534370298546;4140.784680196096;4148.315527937887;4159.958400415987;4181.937270940938;4122.237386083569;4158.604932531404;4163.292240319138;4171.645410140141;4195.55946625603;3731.4962480065115;3731.8134093295225;3736.290104880064;3751.1559899022773;3752.924941501182;4982.725950072744;5093.414257360414;5112.36095488064;5138.409082955471;5147.922781158286;4739.834105806281;4762.738049407281;4784.40194975628;4785.377900872899;4787.40157480315;5363.731813409353;5514.641548299348;5528.75120619569;5553.0837411827;5588.798408342226;4036.2936486114813;4042.9595704042877;4052.250333688248;4058.939115913264;4081.632653061209;5399.218257974859;5617.775288988395;5706.914396284059;5716.8856622867725;5726.398728133528;4002.199560087994;4008.8596899108393;4011.2579172853116;4012.9598704012587;4017.7589344639414;4155.439015732898;4161.10536234711;4161.542230354658;4174.079923235346;4176.2691528982305;4549.158405694957;4710.411198600175;4712.693674911188;4715.4577223619035;4724.622030237572;5457.617966742369;5490.313710786152;5527.751251193706;5530.474604912527;5558.666480011212;1382.9377678004514;1395.1768456610648;1405.9015868889285;1414.5190635184088;1427.8286605607393;940.5908429833045;965.710286913923;976.9609215631295;986.5461887531673;997.6957028106498;5164.992826398891;5204.319775315716;5213.426523082458;5235.921461178085;5257.238824993594;5465.699386533699;5482.5613950883835;5519.736907867835;5555.416681248492;5557.666540007613;5021.573166280834;5121.8463446096675;5146.588272938156;5174.843345559206;5184.196449550326;2857.1143045590225;2899.6078235455834;2904.6369203849517;2907.956380654292;2914.781391395654;5636.774529018875;5643.795372447471;5645.576581756384;5645.717714114277;5666.801661941812;5238.842834714888;5422.267993820784;5517.944820551824;5565.387807341189;5581.5813813963305;5656.830295091154;5677.659340439587;5682.40334764852;5684.118961560965;5693.914591281134;5247.658902171346;5521.723913804374;5524.668519888659;5541.224228607917;5553.750081246434;5429.805442802577;5437.374701909331;5444.673319600678;5451.236826844324;5456.372517160577;5633.338165241182;5662.462066103713;5735.254416925773;5755.913661295168;5787.363390027178;4175.812088456088;4186.727862688916;4194.958050419456;4198.916021679488;4203.957960420479;5559.24750793221;5720.283914825619;5720.856978575569;5731.168980497888;5735.9388513125205;5454.2091396746455;5486.91769623448;5502.312210973629;5504.22940788298;5518.668879867221;5479.17812328138;5488.588355873405;5496.780128794803;5503.367112782082;5519.834404967857;5274.865903830541;5471.9726401369335;5499.945000549943;5501.504864562208;5523.8180918537755;5487.451254874481;5491.615586908878;5517.69652669107;5537.754005348765;5560.471755183251;5392.007435873128;5398.62209645321;5420.186971954238;5423.183233616783;5450.972745136249 13:29:39 INFO - PROCESS | 15936 | |5;yui.html;725.5066554742776;750.4296734481799;772.9149793522712;808.4906508899393;815.2092470303803;14042;15802.762958555631;16340.019598824048;16361.999999999985;16373.5906602335;15039.924800375982;15164.84835151648;15188.392464301414;15227.543173704778;15360.078395296263;664.6444152378479;758.6965213914438;775.7284950267418;776.1539921485579;776.4487214078011;671.4863129705778;684.4866350237322;684.750066225829;685.475611157465;756.6292516666821;819.4673462249556;835.4152093534519;839.8530257204995;840.9495430274203;841;832.2883934236231;833.5498830631452;833.7832163637468;833.791552111972;834.678648720244;513.0815839647065;516.4886762105489;581.1776336483913;610.1579819848581;610.4810910725892;12426.378681065911;12732.299723515203;12941.54704585335;12942.352882355844;13035.934820325932;12606.495740170381;12710.682232944158;12814.55149069778;13135.86864131356;13497.932510337483;11172.329660220332;11449.885501145049;11483.77032459346;11627.767444651145;11684.065274778082;3580.23025049613;3589.174489867319;3637.0907273181706;3679.1537946272238;3757.530308711411;59922.101168482506;60058.39941600528;60476.39523604796;60625;62221.68889155571;9635.277354198462;9655.275854310954;9943.850842237372;9969.900300997042;10746.032857042746;16699.74950375745;16761.832381676028;16783.916080419764;16821.327146913987;16822.915885420494;7759.961200194076;7907.723229686933;8058.556779377191;8092.473989190684;8162.428629995843;4513.954860451419;4519.864404067883;4571.748553829505;4634.37435946143;4864.197407427735;3129.7965632234286;3189.9154287542347;3191.808491490518;3210.3739770744482;3216.8230747308653;562.9408912064256;569.7663957777291;574.1645905207912;574.8476653686777;576.9884602307931;665.298110493434;678.5080816408065;714.7462650758906;737.7049180327912;752.6124046116255;8919;9393.859092113624;9418.576164072632;9558.808823823485;9655.420674759536;571.4428432278495;638.9616623002635;655.6983787457727;656.143732429175;716.6667499612705;4487.282034874404;4533.909321813545;4641.327007583949;4669.299605059268;4706.905861882811;81597.59201203956;82425.17574824295;83352;85840;87562.1243787554;56729.71635141798;61459;63350;63513.04730429047;63941;58824;59154;59254.70372648109;59345.40654593485;59665.40334596685;9173;9474.147326740627;9590.184834289164;9702.175315098295;9838.60645574169;35800.82099589486;36107.81946090253;36314;37282.627173729;37786;46077.76961115307;47145.76427117842;56903;58283.70858145682;59000.40999589949;12461.87538124607;12778.105532612628;13000.479980800663;13085.214887106804;13144.539941102015;13400.865991339962;13630.182189068688;13814.861851381358;13869.167849928634;14171.503997360043;12108.697282568006;12410.627681169579;12503.187292825936;12531.373431328215;12804.167729097579;12725.61823145307;12745.490180393052;12822.67943301425;12861.421236044212;12875.098743088269;12543.874561254635;12586;12669.74660506803;12841.807372889602;13650.658733531343;10633.627823026158;10706.785864282827;10782.838257425989;11215.55137794479;11544.365059921785;11184.720381990515;11235.719107022063;11280.717982050515;11380;11419.657410277705 13:29:39 INFO - PROCESS | 15936 | __end_tp_report 13:29:39 INFO - PROCESS | 15936 | __start_cc_report 13:29:39 INFO - PROCESS | 15936 | _x_x_mozilla_cycle_collect,1478 13:29:39 INFO - PROCESS | 15936 | __end_cc_report 13:29:39 INFO - PROCESS | 15936 | __startTimestamp1480022979449__endTimestamp 13:29:39 INFO - PROCESS | 15936 | 13:29:39 INFO - PROCESS | 15936 | ------- Summary: start ------- 13:29:39 INFO - PROCESS | 15936 | Number of tests: 6 13:29:39 INFO - PROCESS | 15936 | 13:29:39 INFO - PROCESS | 15936 | [#0] dojo.html Cycles:165 Average:5300.28 Median:5493.23 stddev:605.00 (11.0%) stddev-sans-first:578.81 13:29:39 INFO - PROCESS | 15936 | Values: 2979.2 2998.9 3023.5 3035.8 3040.8 5165.1 5281.7 5285.2 5286.8 5378.7 5289.2 5300.9 5306.3 5316.5 5327.4 4811.1 4838.7 4852.9 4869.5 4887.8 4875.4 4889.5 4909.2 4917.4 4918.3 4875.7 4923.9 4924.3 4934.7 4935.7 4949.7 4958.9 4986.3 4988.5 5031.3 4725.4 4742.5 4891.9 4911.3 4931.8 5237.3 5305.8 5310.5 5324.0 5338.5 5687.3 5732.0 5734.5 5746.7 5748.2 5575.3 5643.8 5767.2 5776.7 5785.8 5296.9 5323.4 5334.5 5335.8 5387.7 5733.0 5798.5 5800.4 5807.4 5807.8 5451.4 5562.8 5563.2 5569.2 5570.7 5570.2 5708.1 5715.5 5744.4 5767.4 5648.9 5691.4 5692.4 5694.5 5701.6 5704.3 5718.0 5720.3 5721.8 5753.3 4273.2 4309.0 4319.0 4342.4 4344.1 3872.9 3880.0 3889.7 3911.9 3921.9 5373.8 5380.9 5385.5 5388.5 5442.9 5539.7 5634.9 5642.9 5688.8 5702.5 5415.4 5432.6 5434.1 5440.9 5487.9 4954.1 4955.2 4960.5 4962.4 4968.2 5661.9 5724.9 5933.1 5938.1 5945.1 5598.6 5692.1 5712.1 5746.1 5818.4 5968.7 5976.6 5979.4 5982.2 5990.3 5587.4 5647.9 5648.2 5649.0 5650.0 5703.7 5750.7 5751.0 5760.9 5762.8 5409.3 5468.9 5536.7 5586.2 5592.7 5571.2 5597.3 5600.9 5602.0 5634.1 5561.8 5563.5 5581.5 5602.2 5616.2 5442.9 5493.2 5513.3 5627.8 5691.5 5355.3 5369.1 5479.4 5554.3 5554.7 13:29:39 INFO - PROCESS | 15936 | 13:29:39 INFO - PROCESS | 15936 | [#1] ext.html Cycles:180 Average:55613.80 Median:19436.95 stddev:105551.22 (543.0%) stddev-sans-first:105766.31 13:29:39 INFO - PROCESS | 15936 | Values: 533.7 582.5 594.2 608.0 622.5 31255.0 42665.6 43548.3 43582.3 43635.0 44028.0 44225.3 44272.6 44314.3 44400.0 7915.4 8091.7 8478.7 8627.5 8636.2 10128.1 10378.3 10380.4 10663.2 10666.1 10473.8 10534.4 10548.7 10549.1 10550.3 10305.3 10356.3 10359.3 10359.7 10367.8 10177.2 10220.6 10246.3 10252.8 10256.4 40209.0 40395.0 40510.0 40514.2 40537.4 3439.6 3525.1 3536.8 3649.9 3850.3 30244.1 30472.0 30543.4 30649.0 30809.8 3960.6 4072.9 4132.3 4136.2 4162.6 339518.0 340096.0 340264.0 340944.0 342730.4 56306.7 56546.0 56635.7 56640.4 56682.0 57955.0 58109.1 58393.7 58413.4 58418.4 16303.0 16869.2 16890.5 16891.2 16892.4 11628.8 11727.6 11883.9 11946.4 12990.5 15870.1 16079.7 16133.4 16133.9 16137.1 6084.5 6175.2 6226.4 6288.7 6309.2 925.0 941.3 1028.4 1045.4 1074.5 30714.4 31079.8 31801.5 32256.8 34168.3 1050.6 1092.5 1110.1 1140.5 1155.7 14592.5 15593.2 15602.7 15923.3 16113.3 468076.0 468501.0 469032.0 470818.0 471880.0 53794.5 53870.0 53878.5 53881.7 54279.5 1226.7 1256.7 1267.6 1328.2 1359.2 29603.3 30914.5 31719.7 31758.8 32293.2 46490.0 46867.3 47078.3 47099.5 47176.8 375924.0 377703.0 377855.0 378745.0 379635.0 26507.5 26562.0 26717.9 26922.3 28081.9 45205.8 45229.1 45327.3 45509.3 45533.0 37292.3 37908.6 38535.8 39703.0 40040.0 36948.6 38029.8 38133.6 38849.4 39048.2 39028.2 39088.0 39148.4 39189.2 39201.2 32639.5 33970.7 35133.1 35276.6 35337.1 26149.6 27768.6 27932.3 27946.6 28010.0 13:29:39 INFO - PROCESS | 15936 | 13:29:39 INFO - PROCESS | 15936 | [#2] jquery.html Cycles:180 Average:26838.44 Median:19949.10 stddev:71211.73 (357.0%) stddev-sans-first:71383.74 13:29:39 INFO - PROCESS | 15936 | Values: 361.9 385.6 396.7 399.3 416.6 13601.5 18406.5 18413.9 19196.2 19370.9 18030.3 18836.0 18849.0 18952.2 18976.7 5460.2 5779.1 5781.6 5782.5 5796.5 4115.2 4340.4 5641.2 6083.2 6353.1 6440.1 6454.8 6456.2 6463.3 6464.5 6123.9 6238.5 6262.4 6291.2 6300.5 4832.4 5101.9 5536.9 5550.1 5552.4 13241.1 13271.9 13290.1 13456.9 19308.7 2315.4 2350.6 2407.2 2459.8 2714.4 9831.0 10114.1 10257.4 10576.5 10607.2 1891.5 1908.6 1910.7 1917.9 1954.7 77495.7 80460.0 82059.0 82289.0 83590.0 10780.7 10841.2 11071.7 11119.8 11187.3 15661.6 15662.4 15682.2 15686.2 15701.2 7625.3 7837.6 7905.2 7912.2 7964.7 7386.2 7395.6 7416.0 7569.1 7602.5 4657.3 4776.3 4804.4 4849.8 4874.7 1905.2 1939.9 1960.6 1971.8 2008.5 829.7 908.4 914.6 933.2 1015.4 17585.6 19058.7 19169.8 19192.1 19340.2 911.6 944.5 947.4 949.2 964.6 9880.7 10363.4 10608.7 10624.0 10692.4 364223.0 433280.0 446217.0 446659.0 447450.0 90744.5 94278.5 94370.0 94794.5 99729.1 985.8 1008.0 1015.7 1051.0 1059.1 16432.8 16664.5 16865.2 17212.9 17491.2 39512.6 40468.4 40705.0 41365.0 41592.0 55429.4 55511.7 55738.0 57272.0 58059.7 8211.7 8335.7 8383.9 8437.2 8786.2 11823.7 11918.8 11989.8 12081.9 12343.5 10986.9 11086.8 11122.8 11193.7 11558.7 10274.3 10319.0 10391.3 10415.7 10797.2 10754.1 10927.9 11055.1 11179.4 11376.4 8105.6 8149.9 8379.0 8463.6 8500.2 10913.5 10925.5 10967.6 11010.6 11498.9 13:29:39 INFO - PROCESS | 15936 | 13:29:39 INFO - PROCESS | 15936 | [#3] mootools.html Cycles:180 Average:5228.51 Median:5020.00 stddev:2798.00 (55.7%) stddev-sans-first:2789.97 13:29:39 INFO - PROCESS | 15936 | Values: 1261.9 1387.2 1420.7 1501.5 1698.8 6923.6 7558.4 7784.3 7796.9 7997.6 7813.1 7881.7 7892.8 7907.0 7911.1 1923.4 1988.4 2253.4 2288.8 2289.8 2216.6 2312.3 2321.3 2342.9 2344.4 2287.4 2294.9 2304.0 2306.4 2323.5 2276.4 2279.3 2290.6 2296.1 2297.3 2207.0 2215.0 2216.3 2220.1 2244.8 7702.9 7825.6 7826.6 7827.4 7836.1 4788.9 4934.9 4936.9 4939.0 4940.5 2981.9 3124.7 3155.8 3158.1 3162.9 1032.0 1047.0 1082.9 1087.1 1098.4 10246.9 10508.6 10516.2 10608.7 10753.3 4221.8 4314.0 4373.6 4428.6 4446.4 8301.7 8406.7 8413.1 8416.6 8419.2 4986.2 4995.2 4997.5 4998.6 5000.7 3967.5 4248.8 4526.5 4711.2 4711.5 3407.7 3457.5 3519.2 3543.8 3565.3 1089.1 1116.0 1121.3 1127.9 1128.5 973.3 981.6 981.8 1000.5 1001.1 5357.6 5648.1 5654.8 5667.6 5807.5 995.8 1012.9 1032.2 1046.4 1051.2 3826.1 3877.0 3888.6 3896.3 3982.8 9260.2 9485.8 9508.3 9535.2 9587.3 9411.9 9447.3 9453.5 9457.4 9480.4 7356.8 7458.4 7549.2 7556.2 7562.8 5369.4 5406.1 5523.5 5675.1 5792.5 8764.0 8799.7 8809.0 8842.9 8875.1 8940.2 8948.0 9004.7 9029.2 9044.0 5952.9 6128.2 6489.4 6762.9 6894.7 7440.6 7650.7 7663.3 7707.7 7717.3 6816.4 6874.1 6922.2 6943.2 7099.2 6800.8 6898.6 6935.8 6938.2 6967.9 6422.7 6523.6 6578.5 6580.7 6590.2 4941.9 4971.6 5039.3 5044.4 5044.9 4848.5 4880.5 4989.3 5052.6 5239.8 13:29:39 INFO - PROCESS | 15936 | 13:29:39 INFO - PROCESS | 15936 | [#4] prototype.html Cycles:180 Average:4627.23 Median:5252.45 stddev:1327.93 (25.3%) stddev-sans-first:1291.67 13:29:39 INFO - PROCESS | 15936 | Values: 318.6 330.8 336.8 337.6 342.5 5154.0 5290.9 5298.2 5326.3 5342.0 5213.4 5228.5 5231.4 5235.2 5258.7 4188.8 4189.5 4205.7 4223.8 4232.5 4143.2 4150.2 4191.7 4256.8 4257.3 4128.5 4140.8 4148.3 4160.0 4181.9 4122.2 4158.6 4163.3 4171.6 4195.6 3731.5 3731.8 3736.3 3751.2 3752.9 4982.7 5093.4 5112.4 5138.4 5147.9 4739.8 4762.7 4784.4 4785.4 4787.4 5363.7 5514.6 5528.8 5553.1 5588.8 4036.3 4043.0 4052.3 4058.9 4081.6 5399.2 5617.8 5706.9 5716.9 5726.4 4002.2 4008.9 4011.3 4013.0 4017.8 4155.4 4161.1 4161.5 4174.1 4176.3 4549.2 4710.4 4712.7 4715.5 4724.6 5457.6 5490.3 5527.8 5530.5 5558.7 1382.9 1395.2 1405.9 1414.5 1427.8 940.6 965.7 977.0 986.5 997.7 5165.0 5204.3 5213.4 5235.9 5257.2 5465.7 5482.6 5519.7 5555.4 5557.7 5021.6 5121.8 5146.6 5174.8 5184.2 2857.1 2899.6 2904.6 2908.0 2914.8 5636.8 5643.8 5645.6 5645.7 5666.8 5238.8 5422.3 5517.9 5565.4 5581.6 5656.8 5677.7 5682.4 5684.1 5693.9 5247.7 5521.7 5524.7 5541.2 5553.8 5429.8 5437.4 5444.7 5451.2 5456.4 5633.3 5662.5 5735.3 5755.9 5787.4 4175.8 4186.7 4195.0 4198.9 4204.0 5559.2 5720.3 5720.9 5731.2 5735.9 5454.2 5486.9 5502.3 5504.2 5518.7 5479.2 5488.6 5496.8 5503.4 5519.8 5274.9 5472.0 5499.9 5501.5 5523.8 5487.5 5491.6 5517.7 5537.8 5560.5 5392.0 5398.6 5420.2 5423.2 5451.0 13:29:39 INFO - PROCESS | 15936 | 13:29:39 INFO - PROCESS | 15936 | [#5] yui.html Cycles:180 Average:16318.90 Median:25926.34 stddev:20797.07 (80.2%) stddev-sans-first:20822.45 13:29:39 INFO - PROCESS | 15936 | Values: 725.5 750.4 772.9 808.5 815.2 14042.0 15802.8 16340.0 16362.0 16373.6 15039.9 15164.8 15188.4 15227.5 15360.1 664.6 758.7 775.7 776.2 776.4 671.5 684.5 684.8 685.5 756.6 819.5 835.4 839.9 840.9 841.0 832.3 833.5 833.8 833.8 834.7 513.1 516.5 581.2 610.2 610.5 12426.4 12732.3 12941.5 12942.4 13035.9 12606.5 12710.7 12814.6 13135.9 13497.9 11172.3 11449.9 11483.8 11627.8 11684.1 3580.2 3589.2 3637.1 3679.2 3757.5 59922.1 60058.4 60476.4 60625.0 62221.7 9635.3 9655.3 9943.9 9969.9 10746.0 16699.7 16761.8 16783.9 16821.3 16822.9 7760.0 7907.7 8058.6 8092.5 8162.4 4514.0 4519.9 4571.7 4634.4 4864.2 3129.8 3189.9 3191.8 3210.4 3216.8 562.9 569.8 574.2 574.8 577.0 665.3 678.5 714.7 737.7 752.6 8919.0 9393.9 9418.6 9558.8 9655.4 571.4 639.0 655.7 656.1 716.7 4487.3 4533.9 4641.3 4669.3 4706.9 81597.6 82425.2 83352.0 85840.0 87562.1 56729.7 61459.0 63350.0 63513.0 63941.0 58824.0 59154.0 59254.7 59345.4 59665.4 9173.0 9474.1 9590.2 9702.2 9838.6 35800.8 36107.8 36314.0 37282.6 37786.0 46077.8 47145.8 56903.0 58283.7 59000.4 12461.9 12778.1 13000.5 13085.2 13144.5 13400.9 13630.2 13814.9 13869.2 14171.5 12108.7 12410.6 12503.2 12531.4 12804.2 12725.6 12745.5 12822.7 12861.4 12875.1 12543.9 12586.0 12669.7 12841.8 13650.7 10633.6 10706.8 10782.8 11215.6 11544.4 11184.7 11235.7 11280.7 11380.0 11419.7 13:29:39 INFO - PROCESS | 15936 | -------- Summary: end -------- 13:29:39 INFO - PROCESS | 15936 | 13:29:40 INFO - TEST-INFO | 15936: exit 0 13:29:40 INFO - TEST-OK | dromaeo_css | took 1118394ms 13:29:40 INFO - TEST-START | kraken 13:29:40 INFO - operating with platform_type : linux_ 13:29:40 INFO - Initialising browser for kraken test... 13:29:40 INFO - TEST-INFO | started process 16242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLGDwE0/profile http://localhost:42097/getInfo.html) 13:29:44 INFO - PROCESS | 16242 | __metrics Screen width/height:1600/1200 13:29:44 INFO - PROCESS | 16242 | colorDepth:24 13:29:44 INFO - PROCESS | 16242 | Browser inner width/height: 1024/697 13:29:44 INFO - PROCESS | 16242 | __metrics 13:29:45 INFO - PROCESS | 16242 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:29:45 INFO - PROCESS | 16242 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:29:45 INFO - PROCESS | 16242 | console.error: PushService: 13:29:45 INFO - PROCESS | 16242 | stateChangeProcessEnqueue: Error transitioning state 13:29:45 INFO - PROCESS | 16242 | UnknownError 13:29:46 INFO - TEST-INFO | 16242: exit 0 13:29:46 INFO - Browser initialized. 13:29:46 INFO - Running cycle 1/1 for kraken test... 13:29:46 INFO - TEST-INFO | started process 16329 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLGDwE0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:29:58 INFO - PROCESS | 16329 | RSS: Main: 173608960 13:29:58 INFO - PROCESS | 16329 | 13:30:01 INFO - PROCESS | 16329 | Cycle 1(1): loaded http://localhost:42097/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42097/tests/kraken/driver.html?testName=audio-beat-detection) 13:30:02 INFO - PROCESS | 16329 | RSS: Main: 234946560 13:30:02 INFO - PROCESS | 16329 | 13:30:04 INFO - PROCESS | 16329 | Cycle 1(1): loaded http://localhost:42097/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42097/tests/kraken/driver.html?testName=audio-dft) 13:30:05 INFO - PROCESS | 16329 | RSS: Main: 217014272 13:30:05 INFO - PROCESS | 16329 | 13:30:08 INFO - PROCESS | 16329 | Cycle 1(1): loaded http://localhost:42097/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42097/tests/kraken/driver.html?testName=audio-fft) 13:30:08 INFO - PROCESS | 16329 | RSS: Main: 298893312 13:30:08 INFO - PROCESS | 16329 | 13:30:10 INFO - PROCESS | 16329 | Cycle 1(1): loaded http://localhost:42097/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42097/tests/kraken/driver.html?testName=audio-oscillator) 13:30:11 INFO - PROCESS | 16329 | RSS: Main: 209256448 13:30:11 INFO - PROCESS | 16329 | 13:30:13 INFO - PROCESS | 16329 | Cycle 1(1): loaded http://localhost:42097/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42097/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:30:14 INFO - PROCESS | 16329 | RSS: Main: 214085632 13:30:14 INFO - PROCESS | 16329 | 13:30:17 INFO - PROCESS | 16329 | Cycle 1(1): loaded http://localhost:42097/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42097/tests/kraken/driver.html?testName=imaging-darkroom) 13:30:17 INFO - PROCESS | 16329 | RSS: Main: 252850176 13:30:17 INFO - PROCESS | 16329 | 13:30:21 INFO - PROCESS | 16329 | Cycle 1(1): loaded http://localhost:42097/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42097/tests/kraken/driver.html?testName=imaging-desaturate) 13:30:21 INFO - PROCESS | 16329 | RSS: Main: 253317120 13:30:21 INFO - PROCESS | 16329 | 13:30:24 INFO - PROCESS | 16329 | Cycle 1(1): loaded http://localhost:42097/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42097/tests/kraken/driver.html?testName=json-parse-financial) 13:30:25 INFO - PROCESS | 16329 | RSS: Main: 252362752 13:30:25 INFO - PROCESS | 16329 | 13:30:26 INFO - PROCESS | 16329 | Cycle 1(1): loaded http://localhost:42097/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42097/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:30:27 INFO - PROCESS | 16329 | RSS: Main: 214073344 13:30:27 INFO - PROCESS | 16329 | 13:30:29 INFO - PROCESS | 16329 | Cycle 1(1): loaded http://localhost:42097/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42097/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:30:29 INFO - PROCESS | 16329 | RSS: Main: 221245440 13:30:29 INFO - PROCESS | 16329 | 13:30:31 INFO - PROCESS | 16329 | Cycle 1(1): loaded http://localhost:42097/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42097/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:30:32 INFO - PROCESS | 16329 | RSS: Main: 230141952 13:30:32 INFO - PROCESS | 16329 | 13:30:35 INFO - PROCESS | 16329 | Cycle 1(1): loaded http://localhost:42097/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42097/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:30:35 INFO - PROCESS | 16329 | RSS: Main: 238256128 13:30:35 INFO - PROCESS | 16329 | 13:30:38 INFO - PROCESS | 16329 | Cycle 1(1): loaded http://localhost:42097/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42097/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:30:39 INFO - PROCESS | 16329 | RSS: Main: 235048960 13:30:39 INFO - PROCESS | 16329 | 13:30:40 INFO - PROCESS | 16329 | Cycle 1(1): loaded http://localhost:42097/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42097/tests/kraken/driver.html?testName=ai-astar) 13:30:41 INFO - PROCESS | 16329 | RSS: Main: 285859840 13:30:41 INFO - PROCESS | 16329 | 13:30:41 INFO - PROCESS | 16329 | __start_tp_report 13:30:41 INFO - PROCESS | 16329 | _x_x_mozilla_page_load 13:30:41 INFO - PROCESS | 16329 | _x_x_mozilla_page_load_details 13:30:41 INFO - PROCESS | 16329 | |i|pagename|runs| 13:30:41 INFO - PROCESS | 16329 | |0;ai-astar;111;112;114;113;112;114;112;113;111;112 13:30:41 INFO - PROCESS | 16329 | |1;audio-beat-detection;147;126;124;164;126;123;125;121;148;122 13:30:41 INFO - PROCESS | 16329 | |2;audio-dft;161;161;161;159;160;160;161;162;161;162 13:30:41 INFO - PROCESS | 16329 | |3;audio-fft;75;76;76;108;77;76;77;78;103;75 13:30:41 INFO - PROCESS | 16329 | |4;audio-oscillator;83;82;108;82;83;83;99;83;82;109 13:30:41 INFO - PROCESS | 16329 | |5;imaging-gaussian-blur;117;117;118;117;117;117;117;117;118;118 13:30:41 INFO - PROCESS | 16329 | |6;imaging-darkroom;147;147;147;147;147;148;149;146;147;147 13:30:41 INFO - PROCESS | 16329 | |7;imaging-desaturate;95;95;95;95;96;95;96;95;95;95 13:30:41 INFO - PROCESS | 16329 | |8;json-parse-financial;54;51;51;51;53;53;54;52;52;53 13:30:41 INFO - PROCESS | 16329 | |9;json-stringify-tinderbox;64;63;62;63;63;62;63;63;63;62 13:30:41 INFO - PROCESS | 16329 | |10;stanford-crypto-aes;81;84;80;81;81;80;83;80;81;87 13:30:41 INFO - PROCESS | 16329 | |11;stanford-crypto-ccm;136;141;133;141;135;139;136;130;179;134 13:30:41 INFO - PROCESS | 16329 | |12;stanford-crypto-pbkdf2;169;167;163;161;164;167;168;164;163;161 13:30:41 INFO - PROCESS | 16329 | |13;stanford-crypto-sha256-iterative;64;65;65;74;74;65;65;68;63;65 13:30:41 INFO - PROCESS | 16329 | __end_tp_report 13:30:41 INFO - PROCESS | 16329 | __start_cc_report 13:30:41 INFO - PROCESS | 16329 | _x_x_mozilla_cycle_collect,1664 13:30:41 INFO - PROCESS | 16329 | __end_cc_report 13:30:41 INFO - PROCESS | 16329 | __startTimestamp1480023041055__endTimestamp 13:30:41 INFO - PROCESS | 16329 | 13:30:41 INFO - PROCESS | 16329 | ------- Summary: start ------- 13:30:41 INFO - PROCESS | 16329 | Number of tests: 14 13:30:41 INFO - PROCESS | 16329 | 13:30:41 INFO - PROCESS | 16329 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.50 stddev:1.07 (1.0%) stddev-sans-first:1.01 13:30:41 INFO - PROCESS | 16329 | Values: 111.0 112.0 114.0 113.0 112.0 114.0 112.0 113.0 111.0 112.0 13:30:41 INFO - PROCESS | 16329 | 13:30:41 INFO - PROCESS | 16329 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:126.00 stddev:14.86 (11.8%) stddev-sans-first:14.82 13:30:41 INFO - PROCESS | 16329 | Values: 147.0 126.0 124.0 164.0 126.0 123.0 125.0 121.0 148.0 122.0 13:30:41 INFO - PROCESS | 16329 | 13:30:41 INFO - PROCESS | 16329 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 13:30:41 INFO - PROCESS | 16329 | Values: 161.0 161.0 161.0 159.0 160.0 160.0 161.0 162.0 161.0 162.0 13:30:41 INFO - PROCESS | 16329 | 13:30:41 INFO - PROCESS | 16329 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:12.42 (16.3%) stddev-sans-first:12.91 13:30:41 INFO - PROCESS | 16329 | Values: 75.0 76.0 76.0 108.0 77.0 76.0 77.0 78.0 103.0 75.0 13:30:41 INFO - PROCESS | 16329 | 13:30:41 INFO - PROCESS | 16329 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:83.00 stddev:11.31 (13.6%) stddev-sans-first:11.75 13:30:41 INFO - PROCESS | 16329 | Values: 83.0 82.0 108.0 82.0 83.0 83.0 99.0 83.0 82.0 109.0 13:30:41 INFO - PROCESS | 16329 | 13:30:41 INFO - PROCESS | 16329 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 13:30:41 INFO - PROCESS | 16329 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 13:30:41 INFO - PROCESS | 16329 | 13:30:41 INFO - PROCESS | 16329 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 13:30:41 INFO - PROCESS | 16329 | Values: 147.0 147.0 147.0 147.0 147.0 148.0 149.0 146.0 147.0 147.0 13:30:41 INFO - PROCESS | 16329 | 13:30:41 INFO - PROCESS | 16329 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:30:41 INFO - PROCESS | 16329 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 13:30:41 INFO - PROCESS | 16329 | 13:30:41 INFO - PROCESS | 16329 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:53.00 stddev:1.17 (2.2%) stddev-sans-first:1.09 13:30:41 INFO - PROCESS | 16329 | Values: 54.0 51.0 51.0 51.0 53.0 53.0 54.0 52.0 52.0 53.0 13:30:41 INFO - PROCESS | 16329 | 13:30:41 INFO - PROCESS | 16329 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 13:30:41 INFO - PROCESS | 16329 | Values: 64.0 63.0 62.0 63.0 63.0 62.0 63.0 63.0 63.0 62.0 13:30:41 INFO - PROCESS | 16329 | 13:30:41 INFO - PROCESS | 16329 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:81.00 stddev:2.25 (2.8%) stddev-sans-first:2.37 13:30:41 INFO - PROCESS | 16329 | Values: 81.0 84.0 80.0 81.0 81.0 80.0 83.0 80.0 81.0 87.0 13:30:41 INFO - PROCESS | 16329 | 13:30:41 INFO - PROCESS | 16329 | [#11] stanford-crypto-ccm Cycles:10 Average:140.40 Median:137.50 stddev:14.00 (10.2%) stddev-sans-first:14.76 13:30:41 INFO - PROCESS | 16329 | Values: 136.0 141.0 133.0 141.0 135.0 139.0 136.0 130.0 179.0 134.0 13:30:41 INFO - PROCESS | 16329 | 13:30:41 INFO - PROCESS | 16329 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:165.50 stddev:2.87 (1.7%) stddev-sans-first:2.59 13:30:41 INFO - PROCESS | 16329 | Values: 169.0 167.0 163.0 161.0 164.0 167.0 168.0 164.0 163.0 161.0 13:30:41 INFO - PROCESS | 16329 | 13:30:41 INFO - PROCESS | 16329 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:65.00 stddev:3.99 (6.1%) stddev-sans-first:4.11 13:30:41 INFO - PROCESS | 16329 | Values: 64.0 65.0 65.0 74.0 74.0 65.0 65.0 68.0 63.0 65.0 13:30:41 INFO - PROCESS | 16329 | -------- Summary: end -------- 13:30:41 INFO - PROCESS | 16329 | 13:30:42 INFO - TEST-INFO | 16329: exit 0 13:30:42 INFO - TEST-OK | kraken | took 61998ms 13:30:42 INFO - SUITE-END | took 1180s 13:30:42 INFO - Completed test suite (00:19:40) 13:30:42 INFO - javascript benchmark 13:30:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2979.2105092150578, 2998.9400211995776, 3023.4557779599677, 3035.7723170762197, 3040.7719421043425, 5165.121929272023, 5281.656692314997, 5285.180796976465, 5286.762095705692, 5378.731063446827, 5289.18017707256, 5300.893982120355, 5306.283651707018, 5316.4683531646815, 5327.36071671399, 4811.061842940628, 4838.709677419366, 4852.859577999185, 4869.4887036861155, 4887.755612219393, 4875.41495020598, 4889.53549412807, 4909.189983652693, 4917.4344950330815, 4918.262260660912, 4875.7074575525585, 4923.852284431473, 4924.28597853311, 4934.679245849008, 4935.679180853251, 4949.727764972925, 4958.925616115779, 4986.2769898364895, 4988.451270360258, 5031.270465782441, 4725.40932383452, 4742.478327383985, 4891.8777030574165, 4911.287863259843, 4931.7780699868235, 5237.292965449692, 5305.840824775263, 5310.468953104697, 5324.041672498949, 5338.546223571001, 5687.289088863892, 5731.99690054243, 5734.455226753452, 5746.683932383718, 5748.223989761413, 5575.275214222125, 5643.774249030034, 5767.221425107598, 5776.682282474462, 5785.82642520725, 5296.92054619181, 5323.414424413311, 5334.493223143756, 5335.759890804923, 5387.703676297763, 5732.996725573008, 5798.536117110621, 5800.419958004166, 5807.419258074243, 5807.82576522705, 5451.4276001019325, 5562.833115006556, 5563.248961390161, 5569.248151499577, 5570.693611851387, 5570.248016517799, 5708.143778433186, 5715.485606295453, 5744.368119506935, 5767.394423585547, 5648.85877853057, 5691.430856914359, 5692.430756924275, 5694.4590263924865, 5701.600887937804, 5704.258446401941, 5718.0, 5720.256366672306, 5721.828345149652, 5753.280839895013, 4273.18809426208, 4308.978455107705, 4319.0, 4342.392065110887, 4344.066025804467, 3872.8644497442456, 3880.049387899926, 3889.7082718796205, 3911.8630847920185, 3921.921471595277, 5373.785048598091, 5380.946190538045, 5385.461453854661, 5388.5419739321815, 5442.945570544323, 5539.667619942817, 5634.915476267859, 5642.943570564324, 5688.829335119953, 5702.48677619008, 5415.404305526389, 5432.619716619799, 5434.076207044733, 5440.863978400572, 5487.890242195213, 4954.083494553519, 4955.207166853286, 4960.454350021495, 4962.354893863847, 4968.180250258667, 5661.886762264649, 5724.914126288026, 5933.050711886164, 5938.079597662369, 5945.10823376497, 5598.636088654224, 5692.117721753135, 5712.143178523254, 5746.109353050284, 5818.359980402237, 5968.731407086605, 5976.551758618034, 5979.431953964367, 5982.162497250301, 5990.251218597676, 5587.413321601336, 5647.943520564741, 5648.181013753065, 5649.039663257338, 5650.0, 5703.657780533182, 5750.654960702372, 5750.971245143747, 5760.94239057604, 5762.827115186551, 5409.323834520685, 5468.890622187613, 5536.667799932017, 5586.16207568868, 5592.720363981866, 5571.247881535941, 5597.27235459404, 5600.887982240414, 5601.991641504568, 5634.098544232903, 5561.777528898799, 5563.499285064364, 5581.469760372758, 5602.215689803512, 5616.21373007771, 5442.918356224739, 5493.23094766741, 5513.255710479194, 5627.831165065055, 5691.544676425959, 5355.277037599874, 5369.1140961740875, 5479.3972663007835, 5554.2779438672715, 5554.694491802989], "value": 5258.581909314209, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.6981932186804, 582.4845012164235, 594.1859652276382, 607.9544034197434, 622.4895585619794, 31255.0, 42665.57334426655, 43548.3467747984, 43582.34626480597, 43635.0, 44028.0, 44225.33661995073, 44272.55727442724, 44314.33528497075, 44400.0, 7915.445918785687, 8091.676332946675, 8478.703245386429, 8627.482351058925, 8636.222739953402, 10128.088472037514, 10378.32540884844, 10380.377177369382, 10663.200259980495, 10666.146708263359, 10473.79052418955, 10534.420606866619, 10548.68353949379, 10549.050585447309, 10550.314229575053, 10305.330153539995, 10356.275060745751, 10359.274850760374, 10359.689209323695, 10367.792644147075, 10177.18582513397, 10220.591176352937, 10246.333988290811, 10252.846207306897, 10256.38461692301, 40209.0, 40395.0, 40510.0, 40514.17686204128, 40537.391939120935, 3439.6216416194197, 3525.1363415962996, 3536.7877927324444, 3649.908752281188, 3850.306944749944, 30244.09267721972, 30472.0, 30543.38913221723, 30649.0, 30809.845950770326, 3960.6237407446247, 4072.9389059164137, 4132.297509423405, 4136.152088821785, 4162.62536371728, 339518.0, 340096.0, 340264.0, 340944.0, 342730.44504214544, 56306.71846640741, 56546.0, 56635.716821415626, 56640.43359566434, 56682.0, 57955.0, 58109.12836307459, 58393.70803146042, 58413.41586584165, 58418.4158158413, 16303.0, 16869.15654217284, 16890.493285201464, 16891.155442228086, 16892.40876569314, 11628.825567616492, 11727.589534366427, 11883.881161188277, 11946.402679866145, 12990.480380784662, 15870.127143007245, 16079.678406431805, 16133.435329763402, 16133.919330403507, 16137.112458814643, 6084.4828189603495, 6175.164469576297, 6226.439620434183, 6288.654124023223, 6309.2428908530355, 924.9861252081224, 941.2893265584577, 1028.4240825137947, 1045.3936716704293, 1074.4735079810837, 30714.385712286075, 31079.84460077685, 31801.52297715536, 32256.83871580674, 34168.316633667186, 1050.5850189175385, 1092.4919912240846, 1110.0897264243404, 1140.4525827602797, 1155.734759870646, 14592.489262875748, 15593.220338983232, 15602.687946241012, 15923.283452244677, 16113.27490262941, 468076.0, 468501.0, 469032.0, 470818.0, 471880.0, 53794.46205537973, 53870.0, 53878.46121538813, 53881.73059134679, 54279.45720542823, 1226.6565361698738, 1256.7172386213213, 1267.6007057776771, 1328.2030781531005, 1359.238826257299, 29603.25991850135, 30914.536281955337, 31719.742051142148, 31758.841205793822, 32293.18722629949, 46490.0, 46867.29699054585, 47078.293825593326, 47099.52900470951, 47176.7641161792, 375924.0, 377703.0, 377855.0, 378745.0, 379635.0, 26507.469850603266, 26562.0, 26717.866410667822, 26922.32694182661, 28081.859590701915, 45205.77397112994, 45229.09541809211, 45327.32009019933, 45509.31736023896, 45533.0, 37292.254154916205, 37908.62091379051, 38535.80732096434, 39703.0, 40040.0, 36948.630513694516, 38029.809850950565, 38133.618663814115, 38849.41725874058, 39048.21903561856, 39028.219435611696, 39088.0, 39148.412773807846, 39189.2162156761, 39201.215975679756, 32639.510407343434, 33970.66029339675, 35133.121671958404, 35276.647233527336, 35337.116572085906, 26149.60775588406, 27768.583471248352, 27932.30169245785, 27946.580801288404, 28010.0], "value": 19524.583472457252, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.882388223827, 385.5931991748704, 396.7302234480553, 399.26734442298385, 416.5605286422823, 13601.45594176233, 18406.539836504093, 18413.907930460347, 19196.23215071399, 19370.934598597072, 18030.27878884843, 18836.0, 18849.0, 18952.24191032357, 18976.715349269773, 5460.153676180188, 5779.104238842965, 5781.624194427349, 5782.508486778629, 5796.507296879749, 4115.176964607091, 4340.392345071693, 5641.210230567724, 6083.17877086592, 6353.0788035734795, 6440.066190402389, 6454.80635580931, 6456.160699109109, 6463.289038205794, 6464.482841372679, 6123.90814137786, 6238.500919926418, 6262.436380725757, 6291.245050593935, 6300.527460440485, 4832.395950506187, 5101.948980510185, 5536.861578460531, 5550.056490396642, 5552.41699621542, 13241.073124881263, 13271.86728132716, 13290.069695121345, 13456.865431345659, 19308.71036934447, 2315.386422598013, 2350.553394854989, 2407.1815582701965, 2459.754024597526, 2714.429969706364, 9831.0, 10114.089731924161, 10257.384556926609, 10576.52405641748, 10607.15142788575, 1891.4609336339076, 1908.5811520148113, 1910.732497450358, 1917.8561607879465, 1954.6774782160926, 77495.70051593789, 80460.0, 82059.0, 82289.0, 83590.0, 10780.676579702622, 10841.186910981707, 11071.72320691989, 11119.777604447865, 11187.32876027441, 15661.608459788597, 15662.373505059897, 15682.215889205494, 15686.215689215494, 15701.214939252992, 7625.313721765067, 7837.647305871249, 7905.249001344863, 7912.248336408032, 7964.681412743425, 7386.224446433154, 7395.630218489054, 7415.962920185472, 7569.1295501018085, 7602.543847369176, 4657.3246879202325, 4776.331313616027, 4804.390529172766, 4849.806007759721, 4874.683145595596, 1905.1902941249914, 1939.8545109116872, 1960.617679552502, 1971.8225359717694, 2008.4777957731096, 829.668132746906, 908.4458480326995, 914.5884352041608, 933.2394098809449, 1015.4465816130227, 17585.648287034186, 19058.714119288223, 19169.8083019168, 19192.13635386411, 19340.226390944485, 911.5670056723136, 944.5182956691999, 947.393668052447, 949.2216382566229, 964.5804075227298, 9880.703578892644, 10363.407652459855, 10608.734781630366, 10624.0, 10692.358458492516, 364223.0, 433280.0, 446217.0, 446659.0, 447450.0, 90744.5462772682, 94278.52860735789, 94370.0, 94794.52602736941, 99729.07044168569, 985.7683444390562, 1007.9647212347533, 1015.6851376073441, 1051.0330495943597, 1059.1050562274866, 16432.83567164361, 16664.50006499807, 16865.241064151898, 17212.913935430242, 17491.21289541999, 39512.60487395089, 40468.392974106, 40705.0, 41365.0, 41592.0, 55429.44570554243, 55511.72244138754, 55738.0, 57272.0, 58059.709701451226, 8211.71259005932, 8335.666573337, 8383.916160838313, 8437.198466145706, 8786.209241168326, 11823.70440738954, 11918.821217681569, 11989.76020479603, 12081.879181208076, 12343.506259749509, 10986.945065274942, 11086.833697494705, 11122.833157502806, 11193.664679389289, 11558.711032223926, 10274.332168409328, 10319.0, 10391.298262451666, 10415.739606509898, 10797.190210734068, 10754.139668826632, 10927.945360273148, 11055.0603198729, 11179.441027948733, 11376.374299413612, 8105.635246413807, 8149.857337799281, 8378.958105209435, 8463.57682115904, 8500.234978851933, 10913.508892099715, 10925.508352124014, 10967.616133435291, 11010.614628487965, 11498.94250528742], "value": 8904.469286988427, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1261.9179753316039, 1387.2300873015479, 1420.7158568286343, 1501.4594745891477, 1698.804637466691, 6923.619200943946, 7558.395328373731, 7784.260495252942, 7796.92203077969, 7997.640106195221, 7813.062432508107, 7881.7241396551135, 7892.842143157133, 7907.0, 7911.129775724666, 1923.422973108062, 1988.3935399703084, 2253.4479052632128, 2288.8168946484243, 2289.7710228977135, 2216.645336746121, 2312.3294244669028, 2321.257197696738, 2342.8711420871846, 2344.402177444749, 2287.3938406322336, 2294.8852557372147, 2304.032306431303, 2306.4464528513204, 2323.5236776460783, 2276.362618466832, 2279.32759835848, 2290.6449500327476, 2296.0586159674535, 2297.3337732057685, 2206.9668954965687, 2215.036459140279, 2216.3240211735415, 2220.0897631970815, 2244.8091912187483, 7702.9229707703325, 7825.608719563999, 7826.608669566556, 7827.373810095236, 7836.059672839296, 4788.928166077511, 4934.851954441372, 4936.851894443173, 4938.950610493885, 4940.5059494050665, 2981.8956336528117, 3124.6875312468796, 3155.8422078895965, 3158.115727596277, 3162.8892988745515, 1031.9896801031969, 1046.9581216751321, 1082.880883102858, 1087.1140020882956, 1098.4288170151556, 10246.897531024744, 10508.579656813794, 10516.158707303397, 10608.681739547748, 10753.30103543275, 4221.831126754895, 4314.0, 4373.562643735601, 4428.601425871687, 4446.377072368627, 8301.667933282723, 8406.74779756596, 8413.074561798197, 8416.621252043551, 8419.158084191531, 4986.152354099811, 4995.150824359867, 4997.450280469146, 4998.575121114746, 5000.724960127155, 3967.5238971323047, 4248.808803603845, 4526.502084770673, 4711.2226482629985, 4711.45818230901, 3407.6592340765724, 3457.533233013511, 3519.225770330523, 3543.76965497247, 3565.3047655707405, 1089.0634054712941, 1115.9944200278946, 1121.2655710509466, 1127.8702949160788, 1128.4696192789377, 973.2846357926918, 981.6367943860818, 981.788915383196, 1000.5247507433911, 1001.1240164855751, 5357.571394288448, 5648.124540696116, 5654.830355089354, 5667.631603945731, 5807.5063619591965, 995.8406654935176, 1012.8987101289812, 1032.2155162076726, 1046.3669479964512, 1051.164324362134, 3826.081740382344, 3876.9806150969066, 3888.591697871739, 3896.298666240104, 3982.8008599569907, 9260.166585007382, 9485.810283794286, 9508.334416590911, 9535.189508891823, 9587.280953928483, 9411.858822117674, 9447.291453141042, 9453.480058596842, 9457.38526995743, 9480.431174129575, 7356.816079598053, 7458.440616953641, 7549.169591344948, 7556.168821429638, 7562.773116806505, 5369.4093649697725, 5406.107992181246, 5523.502884740393, 5675.0636145035605, 5792.53659707214, 8763.956180219058, 8799.736007919773, 8808.986966498935, 8842.867356989522, 8875.112488751074, 8940.15068568485, 8947.955260223658, 9004.684836030707, 9029.187373136449, 9044.005159432325, 5952.910706339322, 6128.203333566787, 6489.383508566679, 6762.932370676231, 6894.655267236719, 7440.627968601657, 7650.65572049248, 7663.27198916102, 7707.653155607899, 7717.2668596483245, 6816.386525212754, 6874.072000279898, 6922.169339679271, 6943.236244013256, 7099.183593886769, 6800.829979250559, 6898.586084834926, 6935.757248496278, 6938.23679395256, 6967.895481567679, 6422.747564224931, 6523.608583485006, 6578.5395022347975, 6580.7038683260325, 6590.2421221560135, 4941.851744447672, 4971.552560269593, 5039.26930595069, 5044.4198917125, 5044.9243261350375, 4848.515148485123, 4880.463149053672, 4989.301497790239, 5052.621053421081, 5239.790408383622], "value": 4281.780384737894, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.6097031136859, 330.75358857651054, 336.77436117801074, 337.6404129601973, 342.4503671607069, 5153.969206158774, 5290.867728306795, 5298.20526920962, 5326.280952071474, 5342.038433082043, 5213.400458947222, 5228.490324644173, 5231.398389185245, 5235.214717792333, 5258.737063146837, 4188.790560471979, 4189.476315460567, 4205.663546916239, 4223.788810559475, 4232.53442121368, 4143.171365726852, 4150.156823030864, 4191.685623578229, 4256.808443620029, 4257.3183592480955, 4128.534370298546, 4140.784680196096, 4148.315527937887, 4159.958400415987, 4181.937270940938, 4122.237386083569, 4158.604932531404, 4163.292240319138, 4171.645410140141, 4195.55946625603, 3731.4962480065115, 3731.8134093295225, 3736.290104880064, 3751.1559899022773, 3752.924941501182, 4982.725950072744, 5093.414257360414, 5112.36095488064, 5138.409082955471, 5147.922781158286, 4739.834105806281, 4762.738049407281, 4784.40194975628, 4785.377900872899, 4787.40157480315, 5363.731813409353, 5514.641548299348, 5528.75120619569, 5553.0837411827, 5588.798408342226, 4036.2936486114813, 4042.9595704042877, 4052.250333688248, 4058.939115913264, 4081.632653061209, 5399.218257974859, 5617.775288988395, 5706.914396284059, 5716.8856622867725, 5726.398728133528, 4002.199560087994, 4008.8596899108393, 4011.2579172853116, 4012.9598704012587, 4017.7589344639414, 4155.439015732898, 4161.10536234711, 4161.542230354658, 4174.079923235346, 4176.2691528982305, 4549.158405694957, 4710.411198600175, 4712.693674911188, 4715.4577223619035, 4724.622030237572, 5457.617966742369, 5490.313710786152, 5527.751251193706, 5530.474604912527, 5558.666480011212, 1382.9377678004514, 1395.1768456610648, 1405.9015868889285, 1414.5190635184088, 1427.8286605607393, 940.5908429833045, 965.710286913923, 976.9609215631295, 986.5461887531673, 997.6957028106498, 5164.992826398891, 5204.319775315716, 5213.426523082458, 5235.921461178085, 5257.238824993594, 5465.699386533699, 5482.5613950883835, 5519.736907867835, 5555.416681248492, 5557.666540007613, 5021.573166280834, 5121.8463446096675, 5146.588272938156, 5174.843345559206, 5184.196449550326, 2857.1143045590225, 2899.6078235455834, 2904.6369203849517, 2907.956380654292, 2914.781391395654, 5636.774529018875, 5643.795372447471, 5645.576581756384, 5645.717714114277, 5666.801661941812, 5238.842834714888, 5422.267993820784, 5517.944820551824, 5565.387807341189, 5581.5813813963305, 5656.830295091154, 5677.659340439587, 5682.40334764852, 5684.118961560965, 5693.914591281134, 5247.658902171346, 5521.723913804374, 5524.668519888659, 5541.224228607917, 5553.750081246434, 5429.805442802577, 5437.374701909331, 5444.673319600678, 5451.236826844324, 5456.372517160577, 5633.338165241182, 5662.462066103713, 5735.254416925773, 5755.913661295168, 5787.363390027178, 4175.812088456088, 4186.727862688916, 4194.958050419456, 4198.916021679488, 4203.957960420479, 5559.24750793221, 5720.283914825619, 5720.856978575569, 5731.168980497888, 5735.9388513125205, 5454.2091396746455, 5486.91769623448, 5502.312210973629, 5504.22940788298, 5518.668879867221, 5479.17812328138, 5488.588355873405, 5496.780128794803, 5503.367112782082, 5519.834404967857, 5274.865903830541, 5471.9726401369335, 5499.945000549943, 5501.504864562208, 5523.8180918537755, 5487.451254874481, 5491.615586908878, 5517.69652669107, 5537.754005348765, 5560.471755183251, 5392.007435873128, 5398.62209645321, 5420.186971954238, 5423.183233616783, 5450.972745136249], "value": 4205.22991956581, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.5066554742776, 750.4296734481799, 772.9149793522712, 808.4906508899393, 815.2092470303803, 14042.0, 15802.762958555631, 16340.019598824048, 16361.999999999985, 16373.5906602335, 15039.924800375982, 15164.84835151648, 15188.392464301414, 15227.543173704778, 15360.078395296263, 664.6444152378479, 758.6965213914438, 775.7284950267418, 776.1539921485579, 776.4487214078011, 671.4863129705778, 684.4866350237322, 684.750066225829, 685.475611157465, 756.6292516666821, 819.4673462249556, 835.4152093534519, 839.8530257204995, 840.9495430274203, 841.0, 832.2883934236231, 833.5498830631452, 833.7832163637468, 833.791552111972, 834.678648720244, 513.0815839647065, 516.4886762105489, 581.1776336483913, 610.1579819848581, 610.4810910725892, 12426.378681065911, 12732.299723515203, 12941.54704585335, 12942.352882355844, 13035.934820325932, 12606.495740170381, 12710.682232944158, 12814.55149069778, 13135.86864131356, 13497.932510337483, 11172.329660220332, 11449.885501145049, 11483.77032459346, 11627.767444651145, 11684.065274778082, 3580.23025049613, 3589.174489867319, 3637.0907273181706, 3679.1537946272238, 3757.530308711411, 59922.101168482506, 60058.39941600528, 60476.39523604796, 60625.0, 62221.68889155571, 9635.277354198462, 9655.275854310954, 9943.850842237372, 9969.900300997042, 10746.032857042746, 16699.74950375745, 16761.832381676028, 16783.916080419764, 16821.327146913987, 16822.915885420494, 7759.961200194076, 7907.723229686933, 8058.556779377191, 8092.473989190684, 8162.428629995843, 4513.954860451419, 4519.864404067883, 4571.748553829505, 4634.37435946143, 4864.197407427735, 3129.7965632234286, 3189.9154287542347, 3191.808491490518, 3210.3739770744482, 3216.8230747308653, 562.9408912064256, 569.7663957777291, 574.1645905207912, 574.8476653686777, 576.9884602307931, 665.298110493434, 678.5080816408065, 714.7462650758906, 737.7049180327912, 752.6124046116255, 8919.0, 9393.859092113624, 9418.576164072632, 9558.808823823485, 9655.420674759536, 571.4428432278495, 638.9616623002635, 655.6983787457727, 656.143732429175, 716.6667499612705, 4487.282034874404, 4533.909321813545, 4641.327007583949, 4669.299605059268, 4706.905861882811, 81597.59201203956, 82425.17574824295, 83352.0, 85840.0, 87562.1243787554, 56729.71635141798, 61459.0, 63350.0, 63513.04730429047, 63941.0, 58824.0, 59154.0, 59254.70372648109, 59345.40654593485, 59665.40334596685, 9173.0, 9474.147326740627, 9590.184834289164, 9702.175315098295, 9838.60645574169, 35800.82099589486, 36107.81946090253, 36314.0, 37282.627173729, 37786.0, 46077.76961115307, 47145.76427117842, 56903.0, 58283.70858145682, 59000.40999589949, 12461.87538124607, 12778.105532612628, 13000.479980800663, 13085.214887106804, 13144.539941102015, 13400.865991339962, 13630.182189068688, 13814.861851381358, 13869.167849928634, 14171.503997360043, 12108.697282568006, 12410.627681169579, 12503.187292825936, 12531.373431328215, 12804.167729097579, 12725.61823145307, 12745.490180393052, 12822.67943301425, 12861.421236044212, 12875.098743088269, 12543.874561254635, 12586.0, 12669.74660506803, 12841.807372889602, 13650.658733531343, 10633.627823026158, 10706.785864282827, 10782.838257425989, 11215.55137794479, 11544.365059921785, 11184.720381990515, 11235.719107022063, 11280.717982050515, 11380.0, 11419.657410277705], "value": 6804.637769049651, "unit": "score"}], "name": "dromaeo_css", "value": 6943.1103894958815, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 114.0, 113.0, 112.0, 114.0, 112.0, 113.0, 111.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 126.0, 124.0, 164.0, 126.0, 123.0, 125.0, 121.0, 148.0, 122.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 159.0, 160.0, 160.0, 161.0, 162.0, 161.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 108.0, 77.0, 76.0, 77.0, 78.0, 103.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 108.0, 82.0, 83.0, 83.0, 99.0, 83.0, 82.0, 109.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 149.0, 146.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 51.0, 51.0, 53.0, 53.0, 54.0, 52.0, 52.0, 53.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 63.0, 63.0, 62.0, 63.0, 63.0, 63.0, 62.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 80.0, 81.0, 81.0, 80.0, 83.0, 80.0, 81.0, 87.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 141.0, 133.0, 141.0, 135.0, 139.0, 136.0, 130.0, 179.0, 134.0], "value": 140.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 163.0, 161.0, 164.0, 167.0, 168.0, 164.0, 163.0, 161.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 74.0, 74.0, 65.0, 65.0, 68.0, 63.0, 65.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1505.9, "alertThreshold": 2.0}]} 13:30:42 INFO - Return code: 0 13:30:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:30:42 INFO - # TBPL SUCCESS # 13:30:42 INFO - Running post-action listener: _resource_record_post_action 13:30:42 INFO - [mozharness: 2016-11-24 21:30:42.869417Z] Finished run-tests step (success) 13:30:42 INFO - Running post-run listener: _resource_record_post_run 13:30:42 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 391581696; Read time: 24; Write time: 216608 13:30:42 INFO - TinderboxPrint: CPU usage
13.1% 13:30:42 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 13:30:42 INFO - TinderboxPrint: I/O write bytes / time
391,581,696 / 216,608 13:30:42 INFO - TinderboxPrint: CPU idle
8,308.0 (86.9%) 13:30:42 INFO - TinderboxPrint: CPU user
1,199.6 (12.5%) 13:30:42 INFO - TinderboxPrint: Swap in / out
0 / 0 13:30:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103972864; Read time: 0; Write time: 71696 13:30:42 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287608832; Read time: 8; Write time: 144912 13:30:43 INFO - Running post-run listener: _upload_blobber_files 13:30:43 INFO - Blob upload gear active. 13:30:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:30:43 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 13:30:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:30:43 INFO - (blobuploader) - INFO - Open directory for files ... 13:30:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:30:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:30:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:30:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:30:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:30:44 INFO - (blobuploader) - INFO - Done attempting. 13:30:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:30:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:30:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:30:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:30:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:30:48 INFO - (blobuploader) - INFO - Done attempting. 13:30:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:30:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:30:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:30:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:30:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:30:49 INFO - (blobuploader) - INFO - Done attempting. 13:30:49 INFO - (blobuploader) - INFO - Iteration through files over. 13:30:49 INFO - Return code: 0 13:30:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:30:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:30:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca04867614e6f8e9d80eca658f79e3a688acd18ab156b1373ac0e4339a15bfb835b4284acb34b70c33f5036b6a3320f95f49496c64672a265ce29db56d9268b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43ddc2e582b8c35bb2c595d8436fbe9b3fc3b74037db9017a9667ceb66a16e174e659c4d8763393f0144728a7fc9b4000cd35ed281f59743b6c35839f43bc179", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8267cfcc9d72eb057fee8ce3735784ce1aa70fe2c84b576541fad3f29392b40af5bd592b9ce7a766cedfc1dd3915f527cefe00f8631ad9b094dd187216402c06"} 13:30:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:30:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:30:49 INFO - Contents: 13:30:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca04867614e6f8e9d80eca658f79e3a688acd18ab156b1373ac0e4339a15bfb835b4284acb34b70c33f5036b6a3320f95f49496c64672a265ce29db56d9268b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43ddc2e582b8c35bb2c595d8436fbe9b3fc3b74037db9017a9667ceb66a16e174e659c4d8763393f0144728a7fc9b4000cd35ed281f59743b6c35839f43bc179", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8267cfcc9d72eb057fee8ce3735784ce1aa70fe2c84b576541fad3f29392b40af5bd592b9ce7a766cedfc1dd3915f527cefe00f8631ad9b094dd187216402c06"} 13:30:49 INFO - Running post-run listener: copy_logs_to_upload_dir 13:30:49 INFO - Copying logs to upload dir... 13:30:49 INFO - mkdir: /builds/slave/test/build/upload/logs 13:30:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.364143 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-11-24 13:30:49.691191) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 13:30:49.694695) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca04867614e6f8e9d80eca658f79e3a688acd18ab156b1373ac0e4339a15bfb835b4284acb34b70c33f5036b6a3320f95f49496c64672a265ce29db56d9268b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43ddc2e582b8c35bb2c595d8436fbe9b3fc3b74037db9017a9667ceb66a16e174e659c4d8763393f0144728a7fc9b4000cd35ed281f59743b6c35839f43bc179", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8267cfcc9d72eb057fee8ce3735784ce1aa70fe2c84b576541fad3f29392b40af5bd592b9ce7a766cedfc1dd3915f527cefe00f8631ad9b094dd187216402c06"} build_url:https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011475 build_url: 'https://queue.taskcluster.net/v1/task/fZet-_qvTg2KxLyN1gEh_Q/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/sha512/ca04867614e6f8e9d80eca658f79e3a688acd18ab156b1373ac0e4339a15bfb835b4284acb34b70c33f5036b6a3320f95f49496c64672a265ce29db56d9268b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43ddc2e582b8c35bb2c595d8436fbe9b3fc3b74037db9017a9667ceb66a16e174e659c4d8763393f0144728a7fc9b4000cd35ed281f59743b6c35839f43bc179", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8267cfcc9d72eb057fee8ce3735784ce1aa70fe2c84b576541fad3f29392b40af5bd592b9ce7a766cedfc1dd3915f527cefe00f8631ad9b094dd187216402c06"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 13:30:49.720494) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 13:30:49.720898) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1480020588.830555-1811462043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 13:30:49.806186) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 13:30:49.806520) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 13:30:49.806814) ========= ========= Total master_lag: 0.17 =========