builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-065 starttime: 1476422022.89 results: success (0) buildid: 20161013183004 builduid: 3ece2ea886dd465a8bec2f1829d17c4c revision: a15521c1e84ffabb1cbedb6a93e494eb13c99054 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 22:13:42.887534) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 22:13:42.887988) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 22:13:42.888373) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 22:13:42.902875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 22:13:42.903161) ========= 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=523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-13 22:13:43-- 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% 68.8M=0s 2016-10-13 22:13:43 (68.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.310183 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 22:13:43.224003) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 22:13:43.224327) ========= 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=523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019288 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 22:13:43.274361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 22:13:43.274967) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a15521c1e84ffabb1cbedb6a93e494eb13c99054 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a15521c1e84ffabb1cbedb6a93e494eb13c99054 --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=523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-13 22:13:43,614 truncating revision to first 12 chars 2016-10-13 22:13:43,614 Setting DEBUG logging. 2016-10-13 22:13:43,614 attempt 1/10 2016-10-13 22:13:43,614 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/a15521c1e84f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 22:13:44,199 unpacking tar archive at: mozilla-inbound-a15521c1e84f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.937535 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 22:13:44.226318) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 22:13:44.226660) ========= script_repo_revision: a15521c1e84ffabb1cbedb6a93e494eb13c99054 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 22:13:44.227069) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 22:13:44.227372) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 22:13:44.237675) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-13 22:13:44.238089) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:13:44 INFO - MultiFileLogger online at 20161013 22:13:44 in /builds/slave/test 22:13:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:13:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:13:44 INFO - {'append_to_log': False, 22:13:44 INFO - 'base_work_dir': '/builds/slave/test', 22:13:44 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:13:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:13:44 INFO - 'branch': 'Mozilla-Inbound', 22:13:44 INFO - 'buildbot_json_path': 'buildprops.json', 22:13:44 INFO - 'config_files': ('talos/linux_config.py',), 22:13:44 INFO - 'default_actions': ('clobber', 22:13:44 INFO - 'read-buildbot-config', 22:13:44 INFO - 'download-and-extract', 22:13:44 INFO - 'populate-webroot', 22:13:44 INFO - 'create-virtualenv', 22:13:44 INFO - 'install', 22:13:44 INFO - 'run-tests'), 22:13:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:13:44 INFO - 'download_minidump_stackwalk': True, 22:13:44 INFO - 'download_symbols': 'ondemand', 22:13:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:13:44 INFO - 'tooltool.py': '/tools/tooltool.py', 22:13:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:13:44 INFO - '/tools/misc-python/virtualenv.py')}, 22:13:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:13:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:13:44 INFO - 'installer_path': 'installer.exe', 22:13:44 INFO - 'log_level': 'info', 22:13:44 INFO - 'log_name': 'talos', 22:13:44 INFO - 'log_to_console': True, 22:13:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:13:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:13:44 INFO - 'opt_config_files': (), 22:13:44 INFO - 'pip_index': False, 22:13:44 INFO - 'sps_profile': False, 22:13:44 INFO - 'sps_profile_interval': 0, 22:13:44 INFO - 'suite': 'dromaeojs', 22:13:44 INFO - 'system_bits': '32', 22:13:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:13:44 INFO - 'title': 'talos-linux64-ix-065', 22:13:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:13:44 INFO - 'use_talos_json': True, 22:13:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:13:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:13:44 INFO - 'work_dir': 'build'} 22:13:44 INFO - [mozharness: 2016-10-14 05:13:44.666728Z] Running clobber step. 22:13:44 INFO - Running pre-action listener: _resource_record_pre_action 22:13:44 INFO - Running main action method: clobber 22:13:44 INFO - rmtree: /builds/slave/test/build 22:13:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:13:45 INFO - Running post-action listener: _resource_record_post_action 22:13:45 INFO - [mozharness: 2016-10-14 05:13:45.127736Z] Finished clobber step (success) 22:13:45 INFO - [mozharness: 2016-10-14 05:13:45.127837Z] Running read-buildbot-config step. 22:13:45 INFO - Running pre-action listener: _resource_record_pre_action 22:13:45 INFO - Running main action method: read_buildbot_config 22:13:45 INFO - Using buildbot properties: 22:13:45 INFO - { 22:13:45 INFO - "project": "", 22:13:45 INFO - "product": "firefox", 22:13:45 INFO - "script_repo_revision": "production", 22:13:45 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 22:13:45 INFO - "repository": "", 22:13:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 22:13:45 INFO - "buildid": "20161013183004", 22:13:45 INFO - "pgo_build": "True", 22:13:45 INFO - "basedir": "/builds/slave/test", 22:13:45 INFO - "buildnumber": 1685, 22:13:45 INFO - "slavename": "talos-linux64-ix-065", 22:13:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:13:45 INFO - "platform": "ubuntu64_hw", 22:13:45 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:13:45 INFO - "branch": "mozilla-inbound", 22:13:45 INFO - "repo_path": "integration/mozilla-inbound", 22:13:45 INFO - "revision": "a15521c1e84ffabb1cbedb6a93e494eb13c99054", 22:13:45 INFO - "stage_platform": "linux64-pgo", 22:13:45 INFO - "builduid": "3ece2ea886dd465a8bec2f1829d17c4c", 22:13:45 INFO - "slavebuilddir": "test" 22:13:45 INFO - } 22:13:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 22:13:45 INFO - Running post-action listener: _resource_record_post_action 22:13:45 INFO - [mozharness: 2016-10-14 05:13:45.130265Z] Finished read-buildbot-config step (success) 22:13:45 INFO - [mozharness: 2016-10-14 05:13:45.130354Z] Running download-and-extract step. 22:13:45 INFO - Running pre-action listener: _resource_record_pre_action 22:13:45 INFO - Running main action method: download_and_extract 22:13:45 INFO - mkdir: /builds/slave/test/build/tests 22:13:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:45 INFO - trying https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:13:45 INFO - Downloading https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:13:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:13:45 INFO - Downloaded 1361 bytes. 22:13:45 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:13:45 INFO - Using the following test package requirements: 22:13:45 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:13:45 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:13:45 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:13:45 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:45 INFO - u'jsshell-linux-x86_64.zip'], 22:13:45 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:13:45 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:13:45 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:13:45 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:13:45 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:13:45 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:13:45 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:13:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:13:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:13:45 INFO - Fetch https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:13:46 INFO - Http code: 200 22:13:46 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 22:13:46 INFO - x-amz-cf-id: 7w3wsIuEYnZEVrDVwudOMxR3L1JK4JjHu_Fdnl-egKAQ6fIM6MPtOA== 22:13:46 INFO - x-amz-version-id: 897.OPj6zEYl73Vd3k9HKkjIIlG.kM_p 22:13:46 INFO - Expected file size: 22122168 22:13:46 INFO - Obtained file size: 22122168 22:13:50 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:13:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:13:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:13:50 INFO - Fetch https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:13:51 INFO - Http code: 200 22:13:51 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 22:13:51 INFO - x-amz-cf-id: WeyDX1a5aUMRYAaq0ptXZSjqgk2rHZgVaMDFIth2VljX84nKKV-kkw== 22:13:51 INFO - x-amz-version-id: 897.OPj6zEYl73Vd3k9HKkjIIlG.kM_p 22:13:51 INFO - Expected file size: 22122168 22:13:51 INFO - Obtained file size: 22122168 22:13:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 22:13:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:13:55 INFO - Fetch https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:13:56 INFO - Http code: 200 22:13:56 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 22:13:56 INFO - x-amz-cf-id: rBer29Tgabs3RKvJ65Z78_HGQaT8iR4nwr5cXRqvzCw7MR291jbG4Q== 22:13:56 INFO - x-amz-version-id: Zocu9ahlGc9hxufhEQG2zZYqbc5Xnw.d 22:13:56 INFO - Expected file size: 14409006 22:13:56 INFO - Obtained file size: 14409006 22:13:56 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')]} 22:13:56 INFO - trying https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:13:56 INFO - Downloading https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:13:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:13:58 INFO - Downloaded 59682981 bytes. 22:13:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:13:58 INFO - mkdir: /builds/slave/test/properties 22:13:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:13:58 INFO - Writing to file /builds/slave/test/properties/build_url 22:13:58 INFO - Contents: 22:13:58 INFO - build_url:https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:13:58 INFO - Running post-action listener: _resource_record_post_action 22:13:58 INFO - Running post-action listener: set_extra_try_arguments 22:13:58 INFO - [mozharness: 2016-10-14 05:13:58.787975Z] Finished download-and-extract step (success) 22:13:58 INFO - [mozharness: 2016-10-14 05:13:58.788201Z] Running populate-webroot step. 22:13:58 INFO - Running pre-action listener: _resource_record_pre_action 22:13:58 INFO - Running main action method: populate_webroot 22:13:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:13:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:13:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:13:58 INFO - '--tppagecycles', 22:13:58 INFO - '7'], 22:13:58 INFO - 'tests': ['tsvgm']}}, 22:13:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:13:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:13:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:13:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:13:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:13:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:13:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:58 INFO - 'talos_options': ['--disable-e10s'], 22:13:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:13:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:13:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:58 INFO - 'talos_options': ['--disable-e10s'], 22:13:58 INFO - 'tests': ['damp', 'tps']}, 22:13:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:58 INFO - 'tests': ['damp', 'tps']}, 22:13:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:13:58 INFO - 'tests': ['dromaeo_dom']}, 22:13:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:13:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:13:58 INFO - 'tests': ['basic_compositor_video']}, 22:13:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:13:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:13:58 INFO - 'tests': ['a11yr', 22:13:58 INFO - 'ts_paint', 22:13:58 INFO - 'tpaint', 22:13:58 INFO - 'sessionrestore', 22:13:58 INFO - 'sessionrestore_no_auto_restore', 22:13:58 INFO - 'tabpaint']}, 22:13:58 INFO - 'other-e10s': {'tests': ['a11yr', 22:13:58 INFO - 'ts_paint', 22:13:58 INFO - 'tpaint', 22:13:58 INFO - 'sessionrestore', 22:13:58 INFO - 'sessionrestore_no_auto_restore', 22:13:58 INFO - 'tabpaint']}, 22:13:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:13:58 INFO - 'ts_paint', 22:13:58 INFO - 'tpaint', 22:13:58 INFO - 'sessionrestore', 22:13:58 INFO - 'sessionrestore_no_auto_restore', 22:13:58 INFO - 'tabpaint']}, 22:13:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:13:58 INFO - 'ts_paint', 22:13:58 INFO - 'tpaint', 22:13:58 INFO - 'sessionrestore', 22:13:58 INFO - 'sessionrestore_no_auto_restore', 22:13:58 INFO - 'tabpaint']}, 22:13:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:13:58 INFO - 'tests': ['a11yr', 22:13:58 INFO - 'ts_paint', 22:13:58 INFO - 'tpaint', 22:13:58 INFO - 'sessionrestore', 22:13:58 INFO - 'sessionrestore_no_auto_restore', 22:13:58 INFO - 'tabpaint']}, 22:13:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:13:58 INFO - 'tests': ['a11yr', 22:13:58 INFO - 'ts_paint', 22:13:58 INFO - 'tpaint', 22:13:58 INFO - 'sessionrestore', 22:13:58 INFO - 'sessionrestore_no_auto_restore', 22:13:58 INFO - 'tabpaint']}, 22:13:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:13:58 INFO - 'tests': ['tsvgx', 22:13:58 INFO - 'tsvgr_opacity', 22:13:58 INFO - 'tart', 22:13:58 INFO - 'tscrollx', 22:13:58 INFO - 'cart']}, 22:13:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:13:58 INFO - 'tsvgr_opacity', 22:13:58 INFO - 'tart', 22:13:58 INFO - 'tscrollx', 22:13:58 INFO - 'cart']}, 22:13:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:58 INFO - 'talos_options': ['--disable-e10s'], 22:13:58 INFO - 'tests': ['tp5o']}, 22:13:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:58 INFO - 'tests': ['tp5o']}, 22:13:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:58 INFO - 'talos_options': ['--disable-e10s', 22:13:58 INFO - '--xperf_path', 22:13:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:13:58 INFO - 'tests': ['tp5n']}, 22:13:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:58 INFO - 'talos_options': ['--xperf_path', 22:13:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:13:58 INFO - 'tests': ['tp5n']}}, 22:13:58 INFO - 'talos.zip': {'path': '', 22:13:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:13:58 INFO - Running post-action listener: _resource_record_post_action 22:13:58 INFO - [mozharness: 2016-10-14 05:13:58.807712Z] Finished populate-webroot step (success) 22:13:58 INFO - [mozharness: 2016-10-14 05:13:58.807799Z] Running create-virtualenv step. 22:13:58 INFO - Running pre-action listener: _resource_record_pre_action 22:13:58 INFO - Running main action method: create_virtualenv 22:13:58 INFO - Creating virtualenv /builds/slave/test/build/venv 22:13:58 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 22:13:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:13:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:13:58 INFO - Using real prefix '/usr' 22:13:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:13:59 INFO - Installing distribute.............................................................................................................................................................................................done. 22:14:01 INFO - Installing pip.................done. 22:14:01 INFO - Return code: 0 22:14:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:14:01 INFO - Reading from file tmpfile_stdout 22:14:01 INFO - Output received: 22:14:01 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 22:14:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:14: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')]} 22:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14: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')]} 22:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2724daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd5f60>, '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 0x1bd6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd71d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', '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 22:14:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:14:01 INFO - Using env: {'DISPLAY': ':0', 22:14:01 INFO - 'HOME': '/home/cltbld', 22:14:01 INFO - 'LANG': 'en_US.UTF-8', 22:14:01 INFO - 'LANGUAGE': 'en_US:en', 22:14:01 INFO - 'LOGNAME': 'cltbld', 22:14:01 INFO - 'MAIL': '/var/mail/cltbld', 22:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:01 INFO - 'MOZ_NO_REMOTE': '1', 22:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:01 INFO - 'NO_EM_RESTART': '1', 22:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:01 INFO - 'PWD': '/builds/slave/test', 22:14:01 INFO - 'SHELL': '/bin/bash', 22:14:01 INFO - 'SHLVL': '1', 22:14:01 INFO - 'TERM': 'linux', 22:14:01 INFO - 'TMOUT': '86400', 22:14:01 INFO - 'USER': 'cltbld', 22:14:01 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', 22:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:01 INFO - '_': '/tools/buildbot/bin/python'} 22:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:01 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 22:14:01 INFO - Cleaning up... 22:14:01 INFO - Return code: 0 22:14:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:14: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')]} 22:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14: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')]} 22:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2724daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd5f60>, '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 0x1bd6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd71d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', '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 22:14:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:14:01 INFO - Using env: {'DISPLAY': ':0', 22:14:01 INFO - 'HOME': '/home/cltbld', 22:14:01 INFO - 'LANG': 'en_US.UTF-8', 22:14:01 INFO - 'LANGUAGE': 'en_US:en', 22:14:01 INFO - 'LOGNAME': 'cltbld', 22:14:01 INFO - 'MAIL': '/var/mail/cltbld', 22:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:01 INFO - 'MOZ_NO_REMOTE': '1', 22:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:01 INFO - 'NO_EM_RESTART': '1', 22:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:01 INFO - 'PWD': '/builds/slave/test', 22:14:01 INFO - 'SHELL': '/bin/bash', 22:14:01 INFO - 'SHLVL': '1', 22:14:01 INFO - 'TERM': 'linux', 22:14:01 INFO - 'TMOUT': '86400', 22:14:01 INFO - 'USER': 'cltbld', 22:14:01 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', 22:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:01 INFO - '_': '/tools/buildbot/bin/python'} 22:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:02 INFO - Downloading/unpacking psutil>=3.1.1 22:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:14:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:14:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:14:04 INFO - Installing collected packages: psutil 22:14:04 INFO - Running setup.py install for psutil 22:14:04 INFO - building 'psutil._psutil_linux' extension 22:14:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:14:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:14:04 INFO - building 'psutil._psutil_posix' extension 22:14:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:14:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:14:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:14:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:14:04 INFO - Successfully installed psutil 22:14:04 INFO - Cleaning up... 22:14:04 INFO - Return code: 0 22:14:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2724daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd5f60>, '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 0x1bd6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd71d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', '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 22:14:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:14:04 INFO - Using env: {'DISPLAY': ':0', 22:14:04 INFO - 'HOME': '/home/cltbld', 22:14:04 INFO - 'LANG': 'en_US.UTF-8', 22:14:04 INFO - 'LANGUAGE': 'en_US:en', 22:14:04 INFO - 'LOGNAME': 'cltbld', 22:14:04 INFO - 'MAIL': '/var/mail/cltbld', 22:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:04 INFO - 'MOZ_NO_REMOTE': '1', 22:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:04 INFO - 'NO_EM_RESTART': '1', 22:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:04 INFO - 'PWD': '/builds/slave/test', 22:14:04 INFO - 'SHELL': '/bin/bash', 22:14:04 INFO - 'SHLVL': '1', 22:14:04 INFO - 'TERM': 'linux', 22:14:04 INFO - 'TMOUT': '86400', 22:14:04 INFO - 'USER': 'cltbld', 22:14:04 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', 22:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:04 INFO - '_': '/tools/buildbot/bin/python'} 22:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:14:04 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 22:14:04 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 22:14:04 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 22:14:04 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 22:14:04 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 22:14:04 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 22:14:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:14:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:14:06 INFO - Installing collected packages: mozsystemmonitor 22:14:06 INFO - Running setup.py install for mozsystemmonitor 22:14:06 INFO - Successfully installed mozsystemmonitor 22:14:06 INFO - Cleaning up... 22:14:06 INFO - Return code: 0 22:14:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:14: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')]} 22:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14: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')]} 22:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2724daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd5f60>, '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 0x1bd6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd71d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', '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 22:14:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:14:06 INFO - Using env: {'DISPLAY': ':0', 22:14:06 INFO - 'HOME': '/home/cltbld', 22:14:06 INFO - 'LANG': 'en_US.UTF-8', 22:14:06 INFO - 'LANGUAGE': 'en_US:en', 22:14:06 INFO - 'LOGNAME': 'cltbld', 22:14:06 INFO - 'MAIL': '/var/mail/cltbld', 22:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:06 INFO - 'MOZ_NO_REMOTE': '1', 22:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:06 INFO - 'NO_EM_RESTART': '1', 22:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:06 INFO - 'PWD': '/builds/slave/test', 22:14:06 INFO - 'SHELL': '/bin/bash', 22:14:06 INFO - 'SHLVL': '1', 22:14:06 INFO - 'TERM': 'linux', 22:14:06 INFO - 'TMOUT': '86400', 22:14:06 INFO - 'USER': 'cltbld', 22:14:06 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', 22:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:06 INFO - '_': '/tools/buildbot/bin/python'} 22:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:07 INFO - Downloading/unpacking jsonschema==2.5.1 22:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:14:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:09 INFO - Downloading functools32-3.2.3-2.tar.gz 22:14:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:14:09 INFO - warning: no files found matching '*.txt' 22:14:09 INFO - no previously-included directories found matching 'build' 22:14:09 INFO - no previously-included directories found matching 'dist' 22:14:09 INFO - no previously-included directories found matching '.git*' 22:14:09 INFO - Installing collected packages: jsonschema, functools32 22:14:09 INFO - Running setup.py install for functools32 22:14:09 INFO - warning: no files found matching '*.txt' 22:14:09 INFO - no previously-included directories found matching 'build' 22:14:09 INFO - no previously-included directories found matching 'dist' 22:14:09 INFO - no previously-included directories found matching '.git*' 22:14:09 INFO - Successfully installed jsonschema functools32 22:14:09 INFO - Cleaning up... 22:14:09 INFO - Return code: 0 22:14:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:09 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 0x7f2724daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd5f60>, '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 0x1bd6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd71d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', '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 22:14:09 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 22:14:09 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 22:14:09 INFO - Using env: {'DISPLAY': ':0', 22:14:09 INFO - 'HOME': '/home/cltbld', 22:14:09 INFO - 'LANG': 'en_US.UTF-8', 22:14:09 INFO - 'LANGUAGE': 'en_US:en', 22:14:09 INFO - 'LOGNAME': 'cltbld', 22:14:09 INFO - 'MAIL': '/var/mail/cltbld', 22:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:09 INFO - 'MOZ_NO_REMOTE': '1', 22:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:09 INFO - 'NO_EM_RESTART': '1', 22:14:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:09 INFO - 'PWD': '/builds/slave/test', 22:14:09 INFO - 'SHELL': '/bin/bash', 22:14:09 INFO - 'SHLVL': '1', 22:14:09 INFO - 'TERM': 'linux', 22:14:09 INFO - 'TMOUT': '86400', 22:14:09 INFO - 'USER': 'cltbld', 22:14:09 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', 22:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:09 INFO - '_': '/tools/buildbot/bin/python'} 22:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:14:09 INFO - Cleaning up... 22:14:09 INFO - Return code: 0 22:14:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:09 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 0x7f2724daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd5f60>, '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 0x1bd6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd71d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', '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 22:14:09 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 22:14:09 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 22:14:09 INFO - Using env: {'DISPLAY': ':0', 22:14:09 INFO - 'HOME': '/home/cltbld', 22:14:09 INFO - 'LANG': 'en_US.UTF-8', 22:14:09 INFO - 'LANGUAGE': 'en_US:en', 22:14:09 INFO - 'LOGNAME': 'cltbld', 22:14:09 INFO - 'MAIL': '/var/mail/cltbld', 22:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:09 INFO - 'MOZ_NO_REMOTE': '1', 22:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:09 INFO - 'NO_EM_RESTART': '1', 22:14:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:09 INFO - 'PWD': '/builds/slave/test', 22:14:09 INFO - 'SHELL': '/bin/bash', 22:14:09 INFO - 'SHLVL': '1', 22:14:09 INFO - 'TERM': 'linux', 22:14:09 INFO - 'TMOUT': '86400', 22:14:09 INFO - 'USER': 'cltbld', 22:14:09 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', 22:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:09 INFO - '_': '/tools/buildbot/bin/python'} 22:14:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:10 INFO - Downloading/unpacking blobuploader==1.2.4 22:14:10 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 22:14:10 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 22:14:10 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 22:14:10 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 22:14:10 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 22:14:10 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 22:14:11 INFO - Downloading blobuploader-1.2.4.tar.gz 22:14:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:14:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:14:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:12 INFO - Downloading docopt-0.6.1.tar.gz 22:14:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:14:12 INFO - Installing collected packages: blobuploader, requests, docopt 22:14:12 INFO - Running setup.py install for blobuploader 22:14:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:14:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:14:12 INFO - Running setup.py install for requests 22:14:13 INFO - Running setup.py install for docopt 22:14:13 INFO - Successfully installed blobuploader requests docopt 22:14:13 INFO - Cleaning up... 22:14:13 INFO - Return code: 0 22:14:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:13 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 0x7f2724daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd5f60>, '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 0x1bd6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd71d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', '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 22:14:13 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 22:14:13 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 22:14:13 INFO - Using env: {'DISPLAY': ':0', 22:14:13 INFO - 'HOME': '/home/cltbld', 22:14:13 INFO - 'LANG': 'en_US.UTF-8', 22:14:13 INFO - 'LANGUAGE': 'en_US:en', 22:14:13 INFO - 'LOGNAME': 'cltbld', 22:14:13 INFO - 'MAIL': '/var/mail/cltbld', 22:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:13 INFO - 'MOZ_NO_REMOTE': '1', 22:14:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:13 INFO - 'NO_EM_RESTART': '1', 22:14:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:13 INFO - 'PWD': '/builds/slave/test', 22:14:13 INFO - 'SHELL': '/bin/bash', 22:14:13 INFO - 'SHLVL': '1', 22:14:13 INFO - 'TERM': 'linux', 22:14:13 INFO - 'TMOUT': '86400', 22:14:13 INFO - 'USER': 'cltbld', 22:14:13 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', 22:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:13 INFO - '_': '/tools/buildbot/bin/python'} 22:14:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:14:13 INFO - Running setup.py (path:/tmp/pip-L8rjw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:14:13 INFO - Running setup.py (path:/tmp/pip-hKgU6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:14:13 INFO - Running setup.py (path:/tmp/pip-N62j_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:14:13 INFO - Running setup.py (path:/tmp/pip-PK6UFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:14:13 INFO - Running setup.py (path:/tmp/pip-tP3f8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:14:13 INFO - Running setup.py (path:/tmp/pip-d68CwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:14:13 INFO - Running setup.py (path:/tmp/pip-3qIsem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:14:14 INFO - Running setup.py (path:/tmp/pip-cVRwu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:14:14 INFO - Running setup.py (path:/tmp/pip-0Qlq2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:14:14 INFO - Running setup.py (path:/tmp/pip-Hj0I1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:14:14 INFO - Running setup.py (path:/tmp/pip-0b0dEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:14:14 INFO - Running setup.py (path:/tmp/pip-lD5DH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:14:14 INFO - Running setup.py (path:/tmp/pip-3ZtFZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:14:14 INFO - Running setup.py (path:/tmp/pip-_Sbp9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:14:14 INFO - Running setup.py (path:/tmp/pip-goqAJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:14:14 INFO - Running setup.py (path:/tmp/pip-2gjhvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:14:14 INFO - Running setup.py (path:/tmp/pip-ey89Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:14:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:14:14 INFO - Running setup.py install for manifestparser 22:14:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:14:14 INFO - Running setup.py install for mozcrash 22:14:14 INFO - Running setup.py install for mozdebug 22:14:15 INFO - Running setup.py install for mozdevice 22:14:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:14:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:14:15 INFO - Running setup.py install for mozfile 22:14:15 INFO - Running setup.py install for mozhttpd 22:14:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:14:15 INFO - Running setup.py install for mozinfo 22:14:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:14:15 INFO - Running setup.py install for mozInstall 22:14:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:14:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:14:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:14:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:14:15 INFO - Running setup.py install for mozleak 22:14:15 INFO - Running setup.py install for mozlog 22:14:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:14:15 INFO - Running setup.py install for moznetwork 22:14:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:14:15 INFO - Running setup.py install for mozprocess 22:14:16 INFO - Running setup.py install for mozprofile 22:14:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:14:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:14:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:14:16 INFO - Running setup.py install for mozrunner 22:14:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:14:16 INFO - Running setup.py install for mozscreenshot 22:14:16 INFO - Running setup.py install for moztest 22:14:16 INFO - Running setup.py install for mozversion 22:14:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:14:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:14:16 INFO - Cleaning up... 22:14:16 INFO - Return code: 0 22:14:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:14:16 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')]} 22:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:16 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')]} 22:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:16 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 0x7f2724daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd5f60>, '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 0x1bd6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd71d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', '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 22:14:16 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 22:14:16 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 22:14:16 INFO - Using env: {'DISPLAY': ':0', 22:14:16 INFO - 'HOME': '/home/cltbld', 22:14:16 INFO - 'LANG': 'en_US.UTF-8', 22:14:16 INFO - 'LANGUAGE': 'en_US:en', 22:14:16 INFO - 'LOGNAME': 'cltbld', 22:14:16 INFO - 'MAIL': '/var/mail/cltbld', 22:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:16 INFO - 'MOZ_NO_REMOTE': '1', 22:14:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:16 INFO - 'NO_EM_RESTART': '1', 22:14:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:16 INFO - 'PWD': '/builds/slave/test', 22:14:16 INFO - 'SHELL': '/bin/bash', 22:14:16 INFO - 'SHLVL': '1', 22:14:16 INFO - 'TERM': 'linux', 22:14:16 INFO - 'TMOUT': '86400', 22:14:16 INFO - 'USER': 'cltbld', 22:14:16 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', 22:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:16 INFO - '_': '/tools/buildbot/bin/python'} 22:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:14:16 INFO - Running setup.py (path:/tmp/pip-46df6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:14:16 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)) 22:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:14:16 INFO - Running setup.py (path:/tmp/pip-6GE6Qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:14:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:14:16 INFO - Running setup.py (path:/tmp/pip-I_gy0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:14:17 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)) 22:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:14:17 INFO - Running setup.py (path:/tmp/pip-mK9LTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:14:17 INFO - Running setup.py (path:/tmp/pip-ZBt1kT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:14:17 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)) 22:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:14:17 INFO - Running setup.py (path:/tmp/pip-FeqtyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:14:17 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)) 22:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:14:17 INFO - Running setup.py (path:/tmp/pip-pryJeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:14:17 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)) 22:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:14:17 INFO - Running setup.py (path:/tmp/pip-SIKJ31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:14:17 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)) 22:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:14:17 INFO - Running setup.py (path:/tmp/pip-cYxmlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:14:17 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)) 22:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:14:17 INFO - Running setup.py (path:/tmp/pip-i3DhvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:14:17 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)) 22:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:14:17 INFO - Running setup.py (path:/tmp/pip-9M3p_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:14:17 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)) 22:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:14:17 INFO - Running setup.py (path:/tmp/pip-sOCf9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:14:17 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)) 22:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:14:17 INFO - Running setup.py (path:/tmp/pip-b5Y_RE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:14:17 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)) 22:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:14:17 INFO - Running setup.py (path:/tmp/pip-pHhMkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:14:17 INFO - Running setup.py (path:/tmp/pip-cw3AQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:14:17 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)) 22:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:14:17 INFO - Running setup.py (path:/tmp/pip-wJXBoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:14:18 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)) 22:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:14:18 INFO - Running setup.py (path:/tmp/pip-UYE6x2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:14:18 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)) 22:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:14:18 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)) 22:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:14:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:14:18 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 22:14:18 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 22:14:18 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 22:14:18 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 22:14:18 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 22:14:18 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 22:14:19 INFO - Downloading blessings-1.6.tar.gz 22:14:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:14:20 INFO - Installing collected packages: blessings 22:14:20 INFO - Running setup.py install for blessings 22:14:20 INFO - Successfully installed blessings 22:14:20 INFO - Cleaning up... 22:14:20 INFO - Return code: 0 22:14:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:14:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:14:20 INFO - Reading from file tmpfile_stdout 22:14:20 INFO - Current package versions: 22:14:20 INFO - argparse == 1.2.1 22:14:20 INFO - blessings == 1.6 22:14:20 INFO - blobuploader == 1.2.4 22:14:20 INFO - docopt == 0.6.1 22:14:20 INFO - functools32 == 3.2.3-2 22:14:20 INFO - jsonschema == 2.5.1 22:14:20 INFO - manifestparser == 1.1 22:14:20 INFO - mozInstall == 1.12 22:14:20 INFO - mozcrash == 0.17 22:14:20 INFO - mozdebug == 0.1 22:14:20 INFO - mozdevice == 0.48 22:14:20 INFO - mozfile == 1.2 22:14:20 INFO - mozhttpd == 0.7 22:14:20 INFO - mozinfo == 0.9 22:14:20 INFO - mozleak == 0.1 22:14:20 INFO - mozlog == 3.4 22:14:20 INFO - moznetwork == 0.27 22:14:20 INFO - mozprocess == 0.23 22:14:20 INFO - mozprofile == 0.28 22:14:20 INFO - mozrunner == 6.12 22:14:20 INFO - mozscreenshot == 0.1 22:14:20 INFO - mozsystemmonitor == 0.3 22:14:20 INFO - moztest == 0.7 22:14:20 INFO - mozversion == 1.4 22:14:20 INFO - psutil == 3.1.1 22:14:20 INFO - requests == 1.2.3 22:14:20 INFO - wsgiref == 0.1.2 22:14:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:20 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 0x7f2724daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd5f60>, '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 0x1bd6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd71d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', '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 22:14:20 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 22:14:20 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 22:14:20 INFO - Using env: {'DISPLAY': ':0', 22:14:20 INFO - 'HOME': '/home/cltbld', 22:14:20 INFO - 'LANG': 'en_US.UTF-8', 22:14:20 INFO - 'LANGUAGE': 'en_US:en', 22:14:20 INFO - 'LOGNAME': 'cltbld', 22:14:20 INFO - 'MAIL': '/var/mail/cltbld', 22:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:20 INFO - 'MOZ_NO_REMOTE': '1', 22:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:20 INFO - 'NO_EM_RESTART': '1', 22:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:20 INFO - 'PWD': '/builds/slave/test', 22:14:20 INFO - 'SHELL': '/bin/bash', 22:14:20 INFO - 'SHLVL': '1', 22:14:20 INFO - 'TERM': 'linux', 22:14:20 INFO - 'TMOUT': '86400', 22:14:20 INFO - 'USER': 'cltbld', 22:14:20 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', 22:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:20 INFO - '_': '/tools/buildbot/bin/python'} 22:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:20 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)) 22:14:20 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)) 22:14:20 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)) 22:14:20 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)) 22:14:20 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)) 22:14:20 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)) 22:14:20 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)) 22:14:20 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)) 22:14:20 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)) 22:14:20 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)) 22:14:20 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)) 22:14:20 INFO - Cleaning up... 22:14:20 INFO - Return code: 0 22:14:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2724daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd5f60>, '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 0x1bd6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd71d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', '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 22:14:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:14:20 INFO - Using env: {'DISPLAY': ':0', 22:14:20 INFO - 'HOME': '/home/cltbld', 22:14:20 INFO - 'LANG': 'en_US.UTF-8', 22:14:20 INFO - 'LANGUAGE': 'en_US:en', 22:14:20 INFO - 'LOGNAME': 'cltbld', 22:14:20 INFO - 'MAIL': '/var/mail/cltbld', 22:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:20 INFO - 'MOZ_NO_REMOTE': '1', 22:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:20 INFO - 'NO_EM_RESTART': '1', 22:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:20 INFO - 'PWD': '/builds/slave/test', 22:14:20 INFO - 'SHELL': '/bin/bash', 22:14:20 INFO - 'SHLVL': '1', 22:14:20 INFO - 'TERM': 'linux', 22:14:20 INFO - 'TMOUT': '86400', 22:14:20 INFO - 'USER': 'cltbld', 22:14:20 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', 22:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:20 INFO - '_': '/tools/buildbot/bin/python'} 22:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:14:20 INFO - Cleaning up... 22:14:20 INFO - Return code: 0 22:14:20 INFO - Running post-action listener: _resource_record_post_action 22:14:20 INFO - Running post-action listener: _start_resource_monitoring 22:14:20 INFO - Starting resource monitoring. 22:14:20 INFO - [mozharness: 2016-10-14 05:14:20.965213Z] Finished create-virtualenv step (success) 22:14:20 INFO - [mozharness: 2016-10-14 05:14:20.965679Z] Running install step. 22:14:20 INFO - Running pre-action listener: _resource_record_pre_action 22:14:20 INFO - Running main action method: install 22:14:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:14:21 INFO - Reading from file tmpfile_stdout 22:14:21 INFO - Detecting whether we're running mozinstall >=1.0... 22:14:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:14:21 INFO - Reading from file tmpfile_stdout 22:14:21 INFO - Output received: 22:14:21 INFO - Usage: mozinstall [options] installer 22:14:21 INFO - Options: 22:14:21 INFO - -h, --help show this help message and exit 22:14:21 INFO - -d DEST, --destination=DEST 22:14:21 INFO - Directory to install application into. [default: 22:14:21 INFO - "/builds/slave/test"] 22:14:21 INFO - --app=APP Application being installed. [default: firefox] 22:14:21 INFO - mkdir: /builds/slave/test/build/application 22:14:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:14:38 INFO - Reading from file tmpfile_stdout 22:14:38 INFO - Output received: 22:14:38 INFO - /builds/slave/test/build/application/firefox/firefox 22:14:38 INFO - Running post-action listener: _resource_record_post_action 22:14:38 INFO - [mozharness: 2016-10-14 05:14:38.259905Z] Finished install step (success) 22:14:38 INFO - [mozharness: 2016-10-14 05:14:38.260148Z] Running run-tests step. 22:14:38 INFO - Running pre-action listener: _resource_record_pre_action 22:14:38 INFO - Running main action method: run_tests 22:14:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:14:38 INFO - Python 2.7.3 22:14:38 INFO - Return code: 0 22:14:38 INFO - grabbing minidump binary from tooltool 22:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:38 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 0x1bd5f60>, '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 0x1bd6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd71d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:14:38 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 22:14:38 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 22:14:38 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 22:14:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:14:38 INFO - Return code: 0 22:14:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:14:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:14:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:14:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:14:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:14:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 22:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 22:14:38 INFO - Using env: {'DISPLAY': ':0', 22:14:38 INFO - 'HOME': '/home/cltbld', 22:14:38 INFO - 'LANG': 'en_US.UTF-8', 22:14:38 INFO - 'LANGUAGE': 'en_US:en', 22:14:38 INFO - 'LOGNAME': 'cltbld', 22:14:38 INFO - 'MAIL': '/var/mail/cltbld', 22:14:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:14:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:38 INFO - 'MOZ_NO_REMOTE': '1', 22:14:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:38 INFO - 'NO_EM_RESTART': '1', 22:14:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:38 INFO - 'PWD': '/builds/slave/test', 22:14:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:14:38 INFO - 'SHELL': '/bin/bash', 22:14:38 INFO - 'SHLVL': '1', 22:14:38 INFO - 'TERM': 'linux', 22:14:38 INFO - 'TMOUT': '86400', 22:14:38 INFO - 'USER': 'cltbld', 22:14:38 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338', 22:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:38 INFO - '_': '/tools/buildbot/bin/python'} 22:14:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 22:14:38 INFO - mozversion application_buildid: 20161013183004 22:14:38 INFO - mozversion application_changeset: a15521c1e84ffabb1cbedb6a93e494eb13c99054 22:14:38 INFO - mozversion application_display_name: Nightly 22:14:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:14:38 INFO - mozversion application_name: Firefox 22:14:38 INFO - mozversion application_remotingname: firefox 22:14:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:14:38 INFO - mozversion application_vendor: Mozilla 22:14:38 INFO - mozversion application_version: 52.0a1 22:14:38 INFO - mozversion platform_buildid: 20161013183004 22:14:38 INFO - mozversion platform_changeset: a15521c1e84ffabb1cbedb6a93e494eb13c99054 22:14:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:14:38 INFO - mozversion platform_version: 52.0a1 22:14:38 INFO - using testdate: 1476422078 22:14:38 INFO - actual date: 1476422078 22:14:38 INFO - starting webserver on 'localhost:40410' 22:14:38 INFO - SUITE-START | Running 2 tests 22:14:38 INFO - TEST-START | dromaeo_css 22:14:38 INFO - operating with platform_type : linux_ 22:14:38 INFO - Initialising browser for dromaeo_css test... 22:14:38 INFO - TEST-INFO | started process 16231 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNtL8Hw/profile http://localhost:40410/getInfo.html) 22:14:42 INFO - PROCESS | 16231 | __metrics Screen width/height:1600/1200 22:14:42 INFO - PROCESS | 16231 | colorDepth:24 22:14:42 INFO - PROCESS | 16231 | Browser inner width/height: 1024/697 22:14:42 INFO - PROCESS | 16231 | __metrics 22:14:43 INFO - PROCESS | 16231 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:14:43 INFO - PROCESS | 16231 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:14:43 INFO - PROCESS | 16231 | console.error: PushService: 22:14:43 INFO - PROCESS | 16231 | stateChangeProcessEnqueue: Error transitioning state 22:14:43 INFO - PROCESS | 16231 | UnknownError 22:14:44 INFO - TEST-INFO | 16231: exit 0 22:14:44 INFO - Browser initialized. 22:14:44 INFO - Running cycle 1/1 for dromaeo_css test... 22:14:44 INFO - TEST-INFO | started process 16314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNtL8Hw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:14:56 INFO - PROCESS | 16314 | RSS: Main: 172212224 22:14:56 INFO - PROCESS | 16314 | 22:15:47 INFO - PROCESS | 16314 | 1476422147801 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] 22:17:58 INFO - PROCESS | 16314 | Cycle 1(1): loaded http://localhost:40410/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40410/tests/dromaeo/cssquery-ext.html) 22:18:00 INFO - PROCESS | 16314 | RSS: Main: 319283200 22:18:00 INFO - PROCESS | 16314 | 22:21:02 INFO - PROCESS | 16314 | Cycle 1(1): loaded http://localhost:40410/tests/dromaeo/cssquery-ext.html (next: http://localhost:40410/tests/dromaeo/cssquery-jquery.html) 22:21:03 INFO - PROCESS | 16314 | RSS: Main: 271962112 22:21:03 INFO - PROCESS | 16314 | 22:24:05 INFO - PROCESS | 16314 | Cycle 1(1): loaded http://localhost:40410/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40410/tests/dromaeo/cssquery-mootools.html) 22:24:06 INFO - PROCESS | 16314 | RSS: Main: 266719232 22:24:06 INFO - PROCESS | 16314 | 22:27:08 INFO - PROCESS | 16314 | Cycle 1(1): loaded http://localhost:40410/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40410/tests/dromaeo/cssquery-prototype.html) 22:27:08 INFO - PROCESS | 16314 | RSS: Main: 250777600 22:27:08 INFO - PROCESS | 16314 | 22:30:11 INFO - PROCESS | 16314 | Cycle 1(1): loaded http://localhost:40410/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40410/tests/dromaeo/cssquery-yui.html) 22:30:12 INFO - PROCESS | 16314 | RSS: Main: 219332608 22:30:12 INFO - PROCESS | 16314 | 22:33:14 INFO - PROCESS | 16314 | Cycle 1(1): loaded http://localhost:40410/tests/dromaeo/cssquery-yui.html (next: http://localhost:40410/tests/dromaeo/cssquery-dojo.html) 22:33:14 INFO - PROCESS | 16314 | RSS: Main: 308858880 22:33:14 INFO - PROCESS | 16314 | 22:33:14 INFO - PROCESS | 16314 | __start_tp_report 22:33:14 INFO - PROCESS | 16314 | _x_x_mozilla_page_load 22:33:14 INFO - PROCESS | 16314 | _x_x_mozilla_page_load_details 22:33:14 INFO - PROCESS | 16314 | |i|pagename|runs| 22:33:14 INFO - PROCESS | 16314 | |0;dojo.html;2927.0926012935993;2943.20533455967;2991.356858275471;2994.955075673864;2998.400319936012;5052.317937078494;5083.313752643397;5123.180291153416;5166.199239117938;5248.422673505921;5067.670601410915;5150.819721309755;5224.033553792541;5230.34620672416;5241.528262456378;4680.134175177586;4701.106789709944;4751.049790041988;4769.284607308914;4781.665283430161;4737.786799594027;4767.856964291077;4825.7587120644;4862.367892174012;4870.512948705136;4590;4739.620830333565;4753.71477711335;4773.403324584427;4863.489333619955;4615.607673347769;4673.112108699336;4681.648876334254;4685.1800934836265;4685.2972054191805;4649.767511624439;4653;4661.207594708873;4662.393888794435;4664.323673067386;5016.097102521545;5053;5064.265681476202;5065.037642847848;5077;5403.081476149025;5451.100568406208;5460.153676180159;5464.644798088151;5520.089185284423;5490.615656904019;5505.697186654733;5505.972470137664;5523.502884740393;5561.972190139064;4903.6077113831525;5195.766190521435;5197.896042079137;5214.0614689355525;5279.313689220415;5406.324209473816;5624.971875140598;5631.042722737145;5663.716814159358;5779.133130030529;5503.642263252876;5506.2841830562575;5509.531689806331;5555.444455554493;5569.0254205513875;5570.080936645408;5575;5576.0241957657245;5577.9163312550345;5583.972080139654;5341.893162136736;5397.595180361489;5451.754671039813;5551.750171242304;5623.2408624835125;5540.196671482693;5542.722863856791;5544.91682624761;5545.916811247835;5614.129809879475;4280.422143010716;4282.614564689193;4282.678799090081;4283.700140990163;4337.73973561581;3721.888343349704;3746.7002639788752;3767.8492860285282;3847.5575308839284;3887.5918028607157;5105.055564720538;5126.794928202905;5137.0753264412015;5139.7687104080405;5210.97394513025;5432.429594892558;5434.592405569598;5440.91838622421;5440.91838622421;5454.672719636835;5042.596592272609;5111.795528178905;5131;5142.742862856842;5189.195674670432;4659.5573420525;4717.056588682277;4808.759562021885;4810.687305325143;4860.538248866423;5717.142428635738;5749.885002299847;5761.9135712964335;5772.826815195551;5774.133879917962;5569;5570.080936645408;5571.3871474137;5571.554275658019;5572.60991730575;5560.582956278215;5585.050541407889;5622.746976385991;5703.344115426779;5733.168690539765;5406.7296635167295;5442.183672449164;5444.564434845123;5446.700431476307;5524.86187845291;5514.200440936122;5529.060059789926;5534.280543529477;5545.085060964896;5615.2700148982;5243.528082472596;5318.255444237887;5333.679979201261;5339.7063161526485;5409.675419474844;5355.384130824849;5356.062689029326;5362.865928351823;5416.891662166656;5432.511074003359;5312.495312945264;5321.787128514971;5327;5336.813211537577;5401.189821526646;5265.815696450606;5309.150535914235;5340.252364668871;5360.2227676987395;5381.784728610812;5229.320188375486;5301.655392399482;5337.146056630921;5347.759350829144;5351.705656188947 22:33:14 INFO - PROCESS | 16314 | |1;ext.html;558.8051228730662;565.0563558856709;584.3367777572454;590.4862769390629;612.7640858269566;31100;41487.17025659485;42606.147877042444;42674.359884601756;42681.35977960333;43344.78327608365;43736.78131609345;43795.78102109493;43824.780876095654;43864.34203486942;8091.312238459738;8293.917060829404;8779.561021948894;8940.687075952343;8942.508162051117;10763.730906727355;11061.557537698482;11093.55625774968;11097.72255693606;11110;10868.782624347508;10964.506597203104;10975.890241097566;10978;10979.231453798237;10855.24013319068;10912.836307455394;10923.781524369508;10962;11006.504707288192;10643.733906652318;10719;10729.517171727213;10738.838917416246;10743;41753.79123104365;41817.163656726996;42233.366499502226;42240.57759422397;42259;3424.5719285089363;3551.325248202859;3560.394732895414;3577.731670124725;3786.4320351947154;31548.842255788804;31764.364712705617;32004.839975800205;32005.83997080023;33268.50097248543;4340.262155433584;4449.5327990560845;4484.9327260090795;4572.0627271409285;4624.306354046887;323873;324399;324471;325303;325349;32775.34449311048;56186;56574;56598.71700641471;56601;33440.832795835864;35625.64374356275;35660.28679426397;35668.82165589155;35669.643303566634;13953.581392558239;14004.789928151085;14020.018598697994;14020.929895350459;14024.509142179975;10673;10840.945795270973;11733.765324693459;11952.880471195176;12034.097442691833;8042.155573664681;8049.959750201211;8050.919490805134;8156.592170391456;8189.549574773326;3098.907032788975;3127.108773999399;3169.8742775427645;3178.253110519026;3205;963.210167662524;972.4894430424084;981.1415011864618;1085.8654535565186;1159.9594014209463;31311.843440783105;31548;31667.524987125213;31857.362852742815;32266.193345166088;1077.4612693653173;1084.8915108489089;1164.931311611702;1166.9591564295208;1239.231676360662;15506.379744810081;16241.756373654405;16355.918220408821;16532.58668533272;16714.6657066858;506061;509329;510543;510566;512844;56716;57301;57396;57398.426015740144;57425.42574574285;1199.6401079676061;1222.413241644016;1244.2161438293997;1290.8128321393344;1291.283337747559;28274.010409635564;31779.682203178596;31782.52326215155;32221.51667725033;32708.836455817567;47209.52790472051;47619.28571071367;47855.76072119617;47985.760071199424;48043.519564805305;371179;371893;373389;373620;373672;25105;26517.734822651528;27466.725332747217;27506.449871002867;28719.85640071786;45364;45938.31092533548;46130.308045378675;46200.30699539442;46212.7689361551;37943.62056379401;39204.803975979936;39911.60088399079;39939;41164;37986;38081.80959095297;38482.230355392174;39433.40849887311;39576.2084758309;38942.80528597339;39161.608383915795;39997.80001099976;40175.59824401836;42678;31211.531827022158;34742.82628586841;35149.64850351464;35368.11579710528;35732.285354293286;27357.863210684616;27452.17643470699;27653.723462765116;27882.16353509398;27949.353453649375 22:33:14 INFO - PROCESS | 16314 | |2;jquery.html;342.6038891517069;363.37499500858513;364.5898364340117;366.8459247116211;381.7575839342019;14040.438382464701;17632.64734705305;18825.62348753024;20268;20401.693974590395;18825.62348753024;18989.240430382768;19069;19193;19260.325888593903;5448.8365349039495;5739.626924249931;5747.655140691572;5748.166515855199;5749.971250143764;4131.690123240754;4270.12462445198;4383.408239887606;5589.413111623282;5607.719614019303;6287.402696743825;6316.3683631636695;6422.133012043361;6428.935710642881;6443.710033048501;6175.59858609189;6234.0337247726675;6236;6248.593841400295;6440.935590644081;5404.972975135099;5406.243125962368;5409.24270602116;5410.810621628224;5414.620976531644;22329.218477353377;22945.77054229453;23120.42198945023;23121.190758323548;23166.53666926669;2215.3464727905143;2313.7574228913104;2322.88385580722;2390.5816482115733;2954.1116096883884;13491;13603.86396136036;14297.64255893611;14452.265728112694;14781.408743650241;1791.3819732192503;1805.5395874052165;1877.87793793403;1877.9248830046781;1901.3250296144945;75806.24193758047;76207.23792762058;77942.22057779407;78424;79793.60103199446;9496.857547136799;9723.471897306752;9897.03089073275;9941.32856006373;10261.640842570474;14058.648533786532;14062.156270623795;14069.648258793612;14069.71860562783;14093.365798539091;7422.810270970077;7625.466217364731;7651.655675494616;7807.6486558105025;7869.694728214164;7297.452691048086;7380.667869945865;7539.0576177977755;7606.581638009962;7640.732574359982;6101.664408457577;6255.843603909939;6269.7178626961895;6295.811125666238;6417.1657684500715;1646.761219623148;1705.7100292950229;1707.6338928856865;1758.34062226665;1768.965689457109;985.7929834734786;993.4883534979491;1009.7526106104051;1015.2537635267329;1061.076604554866;18892;19742;19836.404907852786;20020;20094.39716808498;981.9410835349902;990.1732053735068;997.0686182623065;1003.3127307794184;1025.3847691385108;10766.623168189075;11237.775244495228;11332.467013194624;11359.829602555968;11470.713232169262;319867;328824;428340;431382;431715;92067.53966230126;93338;94768.52615736877;94882;95131.82758930998;865.8138500222483;892.9598168082451;893.7765558610347;900.7658008917729;906.3655441191192;16644.334226631283;16824.915875420545;17444;17963.281468741105;18077.186526606598;38577.61422385852;39136.5208870764;39161.804190978866;39756;40109.79945100256;55845;55976;56921.43078569161;57154.712566678434;58095.419045809;8052.235037671412;8088.272055515032;8150.470219435718;8211.794705132419;8456.154384561742;12189.207701499374;12444.253344798979;12551.686207844878;12611.432485538357;13611.11527750693;11019.669409917715;11109.222354435113;11621.128415368712;11622;11628.6511404658;11188;11295.209335346775;11391.601293955004;11401.828972565252;11955.462004209658;11203.943980280372;11553.24903881245;11609.593664221711;11695.76608467809;12221.511139554319;8038.155993620586;8121.75634730959;8270.462419942685;8410.663573457237;8451;8561.315094792526;11413.543458261576;11443.599474018369;11717.472713727731;12067.698307542381 22:33:14 INFO - PROCESS | 16314 | |3;mootools.html;1399.1519385329834;1470.4779803169874;1530.9464168754096;1661.418503523766;1698.167897730111;8044.637991290391;8647;8655.43739656922;8656.307495400368;8657.13428657134;7544.660490277937;7759.650815713307;7767.922320776791;8159.388045896551;8482.194191551807;2220.245116660335;2270.6026445371995;2281.3726225288015;2282.6804247405375;2285.3486756274383;2253.211376018397;2270.20542810016;2275.0785931697687;2326.2090889097703;2326.720793504782;2281.064763446987;2288.107638021173;2297.24191016964;2301.5051763870765;2318.084356679111;2238.955220895573;2241.831862610311;2242.8654280743126;2251.7072780538588;2255.3008567344177;2136.2416342198608;2160.6650969099815;2164.967525487119;2166.306781829815;2166.328438184152;8494.490330580185;8523.914760852374;8526.976762788505;8549.102344253826;8565.100664430207;4940.925886111711;5056.241563765465;5091.516305950929;5093.0577843099145;5137.8715532112;3400.897973060812;3434.862605495777;3496.580410350749;3543.911402214965;3571.8749843755345;1086.8913108689146;1106.5960924262586;1114.504045699664;1123.4102096399374;1130.4969288666546;11736.647900562997;11747.060235181165;11822.172447928648;11841.171118021743;11867;4350.60844523988;4412.646988240933;4581.289900065495;4603.401557797465;4628.190066738374;9811.754706132404;9879.604815807432;9972.700818975442;9977.800443991226;9978.45118518474;5132.538071573502;5150.072986862326;5158.509941555546;5162.354705661793;5167.457416971164;4106.7125301229225;4599;4740.928886066712;4749.762511874393;4777.474477807438;3604.18905746205;3655.3603119453987;3723.646253605903;3741.214344987529;3750.5686846012513;1208.5588760102676;1228.3060071059822;1237.2143688757524;1241.4847838147248;1254.4355040231933;939.2204470289644;941.3363578677016;950.064186776025;964.8504481805331;981.5877331520778;5302.522772950453;5619.690916999522;5651.802186923438;5725.398833122462;6045.093236014545;432.2565187876847;463.9512851150648;464.64222548638037;468.11058987922536;474.5302150870613;3825.5026846509777;3957.5448823385104;3998.620131087542;4031.9596804031585;4272.081502476983;10526.684199474028;10607.098396636373;10691.41197234144;10692.89307106919;10724.463776811128;10665;10670.839937400946;10680.412577308323;10685.465726713634;10693.893061069446;7616.466847320745;7792.766217013499;7877.763667089882;7927.326177274881;7939.563324017119;5484.177373394023;5738.454846789548;5895.793647222326;5921.911171332347;5949.672767997628;9142.817143657223;9353.438793672402;9576.952115239379;9602.711918642452;9611.423314601147;9390;9641.27690423207;9696.0788725071;9762.51187440611;9830.950845245728;8115.959420202861;8174;8198;8229.83540329202;8292.87560686578;8323.250907418362;8325.458845175044;8337.749867503984;8339.082700903016;8340.541270230196;7404.296591823768;7435.739749108755;7534.8493030138;7570.432217583813;7605.543667379975;7314.743983960536;7326.890096648448;7330.6701198445135;7393.593352365671;7538.170801211752;6829.829254268683;6852.931470685229;6903.447724181953;6947.895781563179;6954.930450695429;4886.92669609949;5036.647434679538;5116.539511443988;5139.254808052886;5198.298229739088;5183.5593974512585;5186.870328241674;5238.856685988377;5259.868503287295;5277.102892508206 22:33:14 INFO - PROCESS | 16314 | |4;prototype.html;310.5341987019472;316.14482823961185;318.8676699169845;321.3781333120412;322.4470033891875;5060.645754797166;5186.170212765958;5226.86932826679;5299.761510732017;5305.336832895888;5062.5193655108915;5173.896522069556;5199.584033277338;5206.973965130179;5209.921851172236;4053.7028150991696;4064.715469917107;4092.5702801205966;4094.160697057096;4094.61101195386;3818.2745278397156;3886.650201481866;4065.26825171469;4072.511298644167;4090.3004017348558;4049.2711311963835;4052.5744796796353;4055.878323650295;4056.9917890644174;4067.491563554556;4024;4041.8383264669233;4047.1096358801015;4047.271491131595;4053.756774593534;3588.5155504006884;3588.946165807515;3589.94615080774;3614.710823134143;3617.4212126059706;5027.597792176617;5083.262926875583;5109.795608175668;5115.565176959963;5148.330717006766;4617.261238201905;4622.850374575804;4638.79125439356;4642.326862604903;4646.047560250141;5308.761655390209;5454.754536045887;5457.370848385819;5482;5498.422665620133;3830.559485659157;3858.131920317934;3858.6913046956174;3870.9225815483815;3886.300465916134;5588.2455868458055;5625.887482250373;5680.772769089232;5682.318121825366;5685.374608793029;3923.1761330120426;3933.940990885139;3934.8622798201927;3936.193080418507;3947.2894878921497;3874.845006199777;3903.414487826792;3940.7832569208967;3974.324364857981;3998.9600103998587;4545.931811022837;4553.2942393929;4557.817687292471;4558.316252562142;4573.245414506569;5365.114756065205;5392.676439413648;5445.537129343971;5489.670619762827;5538;1283.1146508908823;1298.2729671384054;1366.9863301367059;1373.7321222361743;1400.7128538649552;886.7162507997378;904.1817155474175;912.7854954085784;914.5244472874068;919.9310051746146;4608.470025946992;4634.884127896829;4651.37206477128;4659.084665677675;4695;4529.207388706963;4910.803567857246;4918.6556941014505;4930.383702037246;4938.382657191694;4632.2356811126465;4638.744869032168;4645.488996210414;4648.233041548175;4656.231721765871;2591.8444893306464;2593.9092131775296;2612.4644447888136;2624.934376640599;2626.7898568114506;4702.835400760957;5026.321446604661;5043.2435134730085;5048.495150484996;5064.784451731558;4936.753162341868;4987.675801072991;4987.800487980513;4993.350864387607;5024.974875125674;5059.785651443627;5060;5101.8724531887;5124.564412024945;5156.355455568054;4618.709416597149;4731.645126615586;4860.708357498562;4893.165063101337;4907.55831975124;4802.831900883592;4822.493638167942;4841.588464980516;4843.329051477234;4859.829905953275;5008.1235783736975;5042.991401719597;5072.9746351268;5074.517920797518;5075.441701412916;3575.73182011345;3659.5608526976935;3661.718398560589;3693.2244228711197;3722.7394082415053;4894.828680996148;4941.827036053721;4942.678725882806;4954.826581069645;4980.601551875914;4748.382710247645;4763.642726795573;4774.522547745198;4823.300621409946;4833.709977401367;4627.62978961689;4720.315554244684;4788.712677239377;4882.414110306786;4899.31409602663;4727;4761.857144285677;4765.425930552086;4771.809127634856;4773.522647735199;4816.903661926812;4840.806367745251;4846.951530484791;4860.441049279378;4876.317315575751;4485;4677.32178834074;4684.672072954861;4693.765311734468;4705.317728929218 22:33:14 INFO - PROCESS | 16314 | |5;yui.html;710.3180946291559;718.5006420537725;726.5713229194774;750.8273097187644;765.265345268542;15468.767968480483;16603.833961660366;16687.66624667506;16722.331106755715;16826.66346673067;13745.587632371045;13782.862171378283;13991.160530368184;14004.579862604112;14084;660.5541259649741;793.183021487867;802.2498963469146;802.9277365037145;803.333233416266;678.2437582095977;789.3606178995004;800.6997375984006;808.640155130967;814.1817473439186;862.5385418800943;867.8220964702252;871.363904349825;871.8866547348836;872.2411501993274;695.8817001109824;850.1243718969471;853.1766844994579;853.4580541356253;853.8164294676643;521.1947541049088;607.2288193993603;616.6947361056261;619.9256089269271;622.3993845938691;14043.64890877726;14103.153810771284;14112.92943535286;14149.434022639081;14204.502842400467;13699.45202191911;14039.578812635535;14295.428182872673;14313.355898984571;14342.71314573713;12649.557265495663;12949.80575291362;13029.609111726664;13153.21080735159;13506.189628622315;4384.561543845622;4393.6045755881805;4435.090806384684;4475.440569928759;4475.888102797424;73530;73672;73723.26276737217;73899.63050184715;73904;10870.402127882884;11013.449327533592;11149.554017839358;11319.490622921989;11451.942740286246;20390.08244628995;20465.2837150702;20499.8975005124;20522.28172014002;20533.794662053486;8306.252437280673;8337;8385.790355241046;8457.57712114404;8739.519326437106;4418.33724941255;4647.1635105680625;4690.226112691368;4726.550977657117;4865.829695960624;3281.950770738441;3425.400554902882;3426.5031570422148;3440.535527703728;3442.9311413771584;599.9160117583542;603.2128072864954;608.2214765100679;623.9407256310643;637.0794202377613;561.9606627536033;582.5659883386904;608.0484042473515;640.9070684750685;660.920689517261;8866.113388661082;9261.536923153815;9335.206507446806;9351.812963740824;9574.329796914288;610.8014895159091;645.7513857164931;656.6486929492698;681.2914568848342;684.94177994871;4491.348754430589;4542.523035081335;4546.226801650991;4547.3179023146795;4581.862544123682;66655;68880.6555967217;86065;115902.42048789702;121030.39484802696;57705;59590;71571.64214178895;86291;98622.5068874651;56208;77148;82672;90022.54988725146;94582.5270873655;8548.74353769388;8710.956445217733;8830.337724670548;8874.361511780138;9034.412763170372;50993.490065100355;52331;52402;52927.47072529225;53421.46578534321;43700.03349849328;44199.77900110607;65890;76688.61655691685;77908;11495.712607184887;11745.412729363668;11752.412379381169;12041.638750837488;12603.243805371707;11364.261323013978;11428.714282143013;11732;11785.410729463321;11829.467673954865;11359.318440893572;11399.943000285277;11683.474243658886;11830.231034982698;12118.818217726564;11403.543858245577;11565.363904985306;11617.361045142261;11865.644030679094;12239.632811015685;11484;11896.405179741152;12000.339981301113;12245.387730613611;12717.936410317889;9802.019798020141;10067;10366.792664146524;10384.740381490523;10910.509027093958;9221.645223090618;9407.529623518934;10111.39331640104;10196.949015254877;10218.744531386477 22:33:14 INFO - PROCESS | 16314 | __end_tp_report 22:33:14 INFO - PROCESS | 16314 | __start_cc_report 22:33:14 INFO - PROCESS | 16314 | _x_x_mozilla_cycle_collect,1393 22:33:14 INFO - PROCESS | 16314 | __end_cc_report 22:33:14 INFO - PROCESS | 16314 | __startTimestamp1476423194875__endTimestamp 22:33:14 INFO - PROCESS | 16314 | 22:33:14 INFO - PROCESS | 16314 | ------- Summary: start ------- 22:33:14 INFO - PROCESS | 16314 | Number of tests: 6 22:33:14 INFO - PROCESS | 16314 | 22:33:14 INFO - PROCESS | 16314 | [#0] dojo.html Cycles:165 Average:5123.93 Median:5321.79 stddev:574.47 (10.8%) stddev-sans-first:549.77 22:33:14 INFO - PROCESS | 16314 | Values: 2927.1 2943.2 2991.4 2995.0 2998.4 5052.3 5083.3 5123.2 5166.2 5248.4 5067.7 5150.8 5224.0 5230.3 5241.5 4680.1 4701.1 4751.0 4769.3 4781.7 4737.8 4767.9 4825.8 4862.4 4870.5 4590.0 4739.6 4753.7 4773.4 4863.5 4615.6 4673.1 4681.6 4685.2 4685.3 4649.8 4653.0 4661.2 4662.4 4664.3 5016.1 5053.0 5064.3 5065.0 5077.0 5403.1 5451.1 5460.2 5464.6 5520.1 5490.6 5505.7 5506.0 5523.5 5562.0 4903.6 5195.8 5197.9 5214.1 5279.3 5406.3 5625.0 5631.0 5663.7 5779.1 5503.6 5506.3 5509.5 5555.4 5569.0 5570.1 5575.0 5576.0 5577.9 5584.0 5341.9 5397.6 5451.8 5551.8 5623.2 5540.2 5542.7 5544.9 5545.9 5614.1 4280.4 4282.6 4282.7 4283.7 4337.7 3721.9 3746.7 3767.8 3847.6 3887.6 5105.1 5126.8 5137.1 5139.8 5211.0 5432.4 5434.6 5440.9 5440.9 5454.7 5042.6 5111.8 5131.0 5142.7 5189.2 4659.6 4717.1 4808.8 4810.7 4860.5 5717.1 5749.9 5761.9 5772.8 5774.1 5569.0 5570.1 5571.4 5571.6 5572.6 5560.6 5585.1 5622.7 5703.3 5733.2 5406.7 5442.2 5444.6 5446.7 5524.9 5514.2 5529.1 5534.3 5545.1 5615.3 5243.5 5318.3 5333.7 5339.7 5409.7 5355.4 5356.1 5362.9 5416.9 5432.5 5312.5 5321.8 5327.0 5336.8 5401.2 5265.8 5309.2 5340.3 5360.2 5381.8 5229.3 5301.7 5337.1 5347.8 5351.7 22:33:14 INFO - PROCESS | 16314 | 22:33:14 INFO - PROCESS | 16314 | [#1] ext.html Cycles:180 Average:55313.84 Median:3555.86 stddev:108677.79 (3056.3%) stddev-sans-first:108904.90 22:33:14 INFO - PROCESS | 16314 | Values: 558.8 565.1 584.3 590.5 612.8 31100.0 41487.2 42606.1 42674.4 42681.4 43344.8 43736.8 43795.8 43824.8 43864.3 8091.3 8293.9 8779.6 8940.7 8942.5 10763.7 11061.6 11093.6 11097.7 11110.0 10868.8 10964.5 10975.9 10978.0 10979.2 10855.2 10912.8 10923.8 10962.0 11006.5 10643.7 10719.0 10729.5 10738.8 10743.0 41753.8 41817.2 42233.4 42240.6 42259.0 3424.6 3551.3 3560.4 3577.7 3786.4 31548.8 31764.4 32004.8 32005.8 33268.5 4340.3 4449.5 4484.9 4572.1 4624.3 323873.0 324399.0 324471.0 325303.0 325349.0 32775.3 56186.0 56574.0 56598.7 56601.0 33440.8 35625.6 35660.3 35668.8 35669.6 13953.6 14004.8 14020.0 14020.9 14024.5 10673.0 10840.9 11733.8 11952.9 12034.1 8042.2 8050.0 8050.9 8156.6 8189.5 3098.9 3127.1 3169.9 3178.3 3205.0 963.2 972.5 981.1 1085.9 1160.0 31311.8 31548.0 31667.5 31857.4 32266.2 1077.5 1084.9 1164.9 1167.0 1239.2 15506.4 16241.8 16355.9 16532.6 16714.7 506061.0 509329.0 510543.0 510566.0 512844.0 56716.0 57301.0 57396.0 57398.4 57425.4 1199.6 1222.4 1244.2 1290.8 1291.3 28274.0 31779.7 31782.5 32221.5 32708.8 47209.5 47619.3 47855.8 47985.8 48043.5 371179.0 371893.0 373389.0 373620.0 373672.0 25105.0 26517.7 27466.7 27506.4 28719.9 45364.0 45938.3 46130.3 46200.3 46212.8 37943.6 39204.8 39911.6 39939.0 41164.0 37986.0 38081.8 38482.2 39433.4 39576.2 38942.8 39161.6 39997.8 40175.6 42678.0 31211.5 34742.8 35149.6 35368.1 35732.3 27357.9 27452.2 27653.7 27882.2 27949.4 22:33:14 INFO - PROCESS | 16314 | 22:33:14 INFO - PROCESS | 16314 | [#2] jquery.html Cycles:180 Average:26011.42 Median:374.30 stddev:65215.79 (17423.3%) stddev-sans-first:65370.26 22:33:14 INFO - PROCESS | 16314 | Values: 342.6 363.4 364.6 366.8 381.8 14040.4 17632.6 18825.6 20268.0 20401.7 18825.6 18989.2 19069.0 19193.0 19260.3 5448.8 5739.6 5747.7 5748.2 5750.0 4131.7 4270.1 4383.4 5589.4 5607.7 6287.4 6316.4 6422.1 6428.9 6443.7 6175.6 6234.0 6236.0 6248.6 6440.9 5405.0 5406.2 5409.2 5410.8 5414.6 22329.2 22945.8 23120.4 23121.2 23166.5 2215.3 2313.8 2322.9 2390.6 2954.1 13491.0 13603.9 14297.6 14452.3 14781.4 1791.4 1805.5 1877.9 1877.9 1901.3 75806.2 76207.2 77942.2 78424.0 79793.6 9496.9 9723.5 9897.0 9941.3 10261.6 14058.6 14062.2 14069.6 14069.7 14093.4 7422.8 7625.5 7651.7 7807.6 7869.7 7297.5 7380.7 7539.1 7606.6 7640.7 6101.7 6255.8 6269.7 6295.8 6417.2 1646.8 1705.7 1707.6 1758.3 1769.0 985.8 993.5 1009.8 1015.3 1061.1 18892.0 19742.0 19836.4 20020.0 20094.4 981.9 990.2 997.1 1003.3 1025.4 10766.6 11237.8 11332.5 11359.8 11470.7 319867.0 328824.0 428340.0 431382.0 431715.0 92067.5 93338.0 94768.5 94882.0 95131.8 865.8 893.0 893.8 900.8 906.4 16644.3 16824.9 17444.0 17963.3 18077.2 38577.6 39136.5 39161.8 39756.0 40109.8 55845.0 55976.0 56921.4 57154.7 58095.4 8052.2 8088.3 8150.5 8211.8 8456.2 12189.2 12444.3 12551.7 12611.4 13611.1 11019.7 11109.2 11621.1 11622.0 11628.7 11188.0 11295.2 11391.6 11401.8 11955.5 11203.9 11553.2 11609.6 11695.8 12221.5 8038.2 8121.8 8270.5 8410.7 8451.0 8561.3 11413.5 11443.6 11717.5 12067.7 22:33:14 INFO - PROCESS | 16314 | 22:33:14 INFO - PROCESS | 16314 | [#3] mootools.html Cycles:180 Average:5617.07 Median:5104.80 stddev:3189.06 (62.5%) stddev-sans-first:3182.26 22:33:14 INFO - PROCESS | 16314 | Values: 1399.2 1470.5 1530.9 1661.4 1698.2 8044.6 8647.0 8655.4 8656.3 8657.1 7544.7 7759.7 7767.9 8159.4 8482.2 2220.2 2270.6 2281.4 2282.7 2285.3 2253.2 2270.2 2275.1 2326.2 2326.7 2281.1 2288.1 2297.2 2301.5 2318.1 2239.0 2241.8 2242.9 2251.7 2255.3 2136.2 2160.7 2165.0 2166.3 2166.3 8494.5 8523.9 8527.0 8549.1 8565.1 4940.9 5056.2 5091.5 5093.1 5137.9 3400.9 3434.9 3496.6 3543.9 3571.9 1086.9 1106.6 1114.5 1123.4 1130.5 11736.6 11747.1 11822.2 11841.2 11867.0 4350.6 4412.6 4581.3 4603.4 4628.2 9811.8 9879.6 9972.7 9977.8 9978.5 5132.5 5150.1 5158.5 5162.4 5167.5 4106.7 4599.0 4740.9 4749.8 4777.5 3604.2 3655.4 3723.6 3741.2 3750.6 1208.6 1228.3 1237.2 1241.5 1254.4 939.2 941.3 950.1 964.9 981.6 5302.5 5619.7 5651.8 5725.4 6045.1 432.3 464.0 464.6 468.1 474.5 3825.5 3957.5 3998.6 4032.0 4272.1 10526.7 10607.1 10691.4 10692.9 10724.5 10665.0 10670.8 10680.4 10685.5 10693.9 7616.5 7792.8 7877.8 7927.3 7939.6 5484.2 5738.5 5895.8 5921.9 5949.7 9142.8 9353.4 9577.0 9602.7 9611.4 9390.0 9641.3 9696.1 9762.5 9831.0 8116.0 8174.0 8198.0 8229.8 8292.9 8323.3 8325.5 8337.7 8339.1 8340.5 7404.3 7435.7 7534.8 7570.4 7605.5 7314.7 7326.9 7330.7 7393.6 7538.2 6829.8 6852.9 6903.4 6947.9 6954.9 4886.9 5036.6 5116.5 5139.3 5198.3 5183.6 5186.9 5238.9 5259.9 5277.1 22:33:14 INFO - PROCESS | 16314 | 22:33:14 INFO - PROCESS | 16314 | [#4] prototype.html Cycles:180 Average:4283.98 Median:4729.32 stddev:1208.49 (25.6%) stddev-sans-first:1174.51 22:33:14 INFO - PROCESS | 16314 | Values: 310.5 316.1 318.9 321.4 322.4 5060.6 5186.2 5226.9 5299.8 5305.3 5062.5 5173.9 5199.6 5207.0 5209.9 4053.7 4064.7 4092.6 4094.2 4094.6 3818.3 3886.7 4065.3 4072.5 4090.3 4049.3 4052.6 4055.9 4057.0 4067.5 4024.0 4041.8 4047.1 4047.3 4053.8 3588.5 3588.9 3589.9 3614.7 3617.4 5027.6 5083.3 5109.8 5115.6 5148.3 4617.3 4622.9 4638.8 4642.3 4646.0 5308.8 5454.8 5457.4 5482.0 5498.4 3830.6 3858.1 3858.7 3870.9 3886.3 5588.2 5625.9 5680.8 5682.3 5685.4 3923.2 3933.9 3934.9 3936.2 3947.3 3874.8 3903.4 3940.8 3974.3 3999.0 4545.9 4553.3 4557.8 4558.3 4573.2 5365.1 5392.7 5445.5 5489.7 5538.0 1283.1 1298.3 1367.0 1373.7 1400.7 886.7 904.2 912.8 914.5 919.9 4608.5 4634.9 4651.4 4659.1 4695.0 4529.2 4910.8 4918.7 4930.4 4938.4 4632.2 4638.7 4645.5 4648.2 4656.2 2591.8 2593.9 2612.5 2624.9 2626.8 4702.8 5026.3 5043.2 5048.5 5064.8 4936.8 4987.7 4987.8 4993.4 5025.0 5059.8 5060.0 5101.9 5124.6 5156.4 4618.7 4731.6 4860.7 4893.2 4907.6 4802.8 4822.5 4841.6 4843.3 4859.8 5008.1 5043.0 5073.0 5074.5 5075.4 3575.7 3659.6 3661.7 3693.2 3722.7 4894.8 4941.8 4942.7 4954.8 4980.6 4748.4 4763.6 4774.5 4823.3 4833.7 4627.6 4720.3 4788.7 4882.4 4899.3 4727.0 4761.9 4765.4 4771.8 4773.5 4816.9 4840.8 4847.0 4860.4 4876.3 4485.0 4677.3 4684.7 4693.8 4705.3 22:33:14 INFO - PROCESS | 16314 | 22:33:14 INFO - PROCESS | 16314 | [#5] yui.html Cycles:180 Average:18527.12 Median:27929.66 stddev:25904.63 (92.7%) stddev-sans-first:25942.76 22:33:14 INFO - PROCESS | 16314 | Values: 710.3 718.5 726.6 750.8 765.3 15468.8 16603.8 16687.7 16722.3 16826.7 13745.6 13782.9 13991.2 14004.6 14084.0 660.6 793.2 802.2 802.9 803.3 678.2 789.4 800.7 808.6 814.2 862.5 867.8 871.4 871.9 872.2 695.9 850.1 853.2 853.5 853.8 521.2 607.2 616.7 619.9 622.4 14043.6 14103.2 14112.9 14149.4 14204.5 13699.5 14039.6 14295.4 14313.4 14342.7 12649.6 12949.8 13029.6 13153.2 13506.2 4384.6 4393.6 4435.1 4475.4 4475.9 73530.0 73672.0 73723.3 73899.6 73904.0 10870.4 11013.4 11149.6 11319.5 11451.9 20390.1 20465.3 20499.9 20522.3 20533.8 8306.3 8337.0 8385.8 8457.6 8739.5 4418.3 4647.2 4690.2 4726.6 4865.8 3282.0 3425.4 3426.5 3440.5 3442.9 599.9 603.2 608.2 623.9 637.1 562.0 582.6 608.0 640.9 660.9 8866.1 9261.5 9335.2 9351.8 9574.3 610.8 645.8 656.6 681.3 684.9 4491.3 4542.5 4546.2 4547.3 4581.9 66655.0 68880.7 86065.0 115902.4 121030.4 57705.0 59590.0 71571.6 86291.0 98622.5 56208.0 77148.0 82672.0 90022.5 94582.5 8548.7 8711.0 8830.3 8874.4 9034.4 50993.5 52331.0 52402.0 52927.5 53421.5 43700.0 44199.8 65890.0 76688.6 77908.0 11495.7 11745.4 11752.4 12041.6 12603.2 11364.3 11428.7 11732.0 11785.4 11829.5 11359.3 11399.9 11683.5 11830.2 12118.8 11403.5 11565.4 11617.4 11865.6 12239.6 11484.0 11896.4 12000.3 12245.4 12717.9 9802.0 10067.0 10366.8 10384.7 10910.5 9221.6 9407.5 10111.4 10196.9 10218.7 22:33:14 INFO - PROCESS | 16314 | -------- Summary: end -------- 22:33:14 INFO - PROCESS | 16314 | 22:33:15 INFO - TEST-INFO | 16314: exit 0 22:33:15 INFO - TEST-OK | dromaeo_css | took 1117250ms 22:33:15 INFO - TEST-START | kraken 22:33:15 INFO - operating with platform_type : linux_ 22:33:15 INFO - Initialising browser for kraken test... 22:33:15 INFO - TEST-INFO | started process 16630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNz6Xtj/profile http://localhost:40410/getInfo.html) 22:33:19 INFO - PROCESS | 16630 | __metrics Screen width/height:1600/1200 22:33:19 INFO - PROCESS | 16630 | colorDepth:24 22:33:19 INFO - PROCESS | 16630 | Browser inner width/height: 1024/697 22:33:19 INFO - PROCESS | 16630 | __metrics 22:33:20 INFO - PROCESS | 16630 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:33:20 INFO - PROCESS | 16630 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:33:20 INFO - PROCESS | 16630 | console.error: PushService: 22:33:20 INFO - PROCESS | 16630 | stateChangeProcessEnqueue: Error transitioning state 22:33:20 INFO - PROCESS | 16630 | UnknownError 22:33:21 INFO - TEST-INFO | 16630: exit 0 22:33:21 INFO - Browser initialized. 22:33:21 INFO - Running cycle 1/1 for kraken test... 22:33:21 INFO - TEST-INFO | started process 16714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNz6Xtj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:33:33 INFO - PROCESS | 16714 | RSS: Main: 172171264 22:33:33 INFO - PROCESS | 16714 | 22:33:36 INFO - PROCESS | 16714 | Cycle 1(1): loaded http://localhost:40410/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40410/tests/kraken/driver.html?testName=audio-beat-detection) 22:33:37 INFO - PROCESS | 16714 | RSS: Main: 229400576 22:33:37 INFO - PROCESS | 16714 | 22:33:39 INFO - PROCESS | 16714 | Cycle 1(1): loaded http://localhost:40410/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40410/tests/kraken/driver.html?testName=audio-dft) 22:33:40 INFO - PROCESS | 16714 | RSS: Main: 215990272 22:33:40 INFO - PROCESS | 16714 | 22:33:43 INFO - PROCESS | 16714 | Cycle 1(1): loaded http://localhost:40410/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40410/tests/kraken/driver.html?testName=audio-fft) 22:33:44 INFO - PROCESS | 16714 | RSS: Main: 298082304 22:33:44 INFO - PROCESS | 16714 | 22:33:46 INFO - PROCESS | 16714 | Cycle 1(1): loaded http://localhost:40410/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40410/tests/kraken/driver.html?testName=audio-oscillator) 22:33:46 INFO - PROCESS | 16714 | RSS: Main: 209633280 22:33:46 INFO - PROCESS | 16714 | 22:33:48 INFO - PROCESS | 16714 | Cycle 1(1): loaded http://localhost:40410/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40410/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:33:49 INFO - PROCESS | 16714 | RSS: Main: 212238336 22:33:49 INFO - PROCESS | 16714 | 22:33:52 INFO - PROCESS | 16714 | Cycle 1(1): loaded http://localhost:40410/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40410/tests/kraken/driver.html?testName=imaging-darkroom) 22:33:53 INFO - PROCESS | 16714 | RSS: Main: 248406016 22:33:53 INFO - PROCESS | 16714 | 22:33:56 INFO - PROCESS | 16714 | Cycle 1(1): loaded http://localhost:40410/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40410/tests/kraken/driver.html?testName=imaging-desaturate) 22:33:57 INFO - PROCESS | 16714 | RSS: Main: 247005184 22:33:57 INFO - PROCESS | 16714 | 22:33:59 INFO - PROCESS | 16714 | Cycle 1(1): loaded http://localhost:40410/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40410/tests/kraken/driver.html?testName=json-parse-financial) 22:34:00 INFO - PROCESS | 16714 | RSS: Main: 247140352 22:34:00 INFO - PROCESS | 16714 | 22:34:01 INFO - PROCESS | 16714 | Cycle 1(1): loaded http://localhost:40410/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40410/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:34:02 INFO - PROCESS | 16714 | RSS: Main: 209104896 22:34:02 INFO - PROCESS | 16714 | 22:34:04 INFO - PROCESS | 16714 | Cycle 1(1): loaded http://localhost:40410/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40410/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:34:04 INFO - PROCESS | 16714 | RSS: Main: 216215552 22:34:04 INFO - PROCESS | 16714 | 22:34:06 INFO - PROCESS | 16714 | Cycle 1(1): loaded http://localhost:40410/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40410/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:34:07 INFO - PROCESS | 16714 | RSS: Main: 225837056 22:34:07 INFO - PROCESS | 16714 | 22:34:09 INFO - PROCESS | 16714 | Cycle 1(1): loaded http://localhost:40410/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:34:10 INFO - PROCESS | 16714 | RSS: Main: 234029056 22:34:10 INFO - PROCESS | 16714 | 22:34:13 INFO - PROCESS | 16714 | Cycle 1(1): loaded http://localhost:40410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:34:14 INFO - PROCESS | 16714 | RSS: Main: 231571456 22:34:14 INFO - PROCESS | 16714 | 22:34:15 INFO - PROCESS | 16714 | Cycle 1(1): loaded http://localhost:40410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40410/tests/kraken/driver.html?testName=ai-astar) 22:34:16 INFO - PROCESS | 16714 | RSS: Main: 281526272 22:34:16 INFO - PROCESS | 16714 | 22:34:16 INFO - PROCESS | 16714 | __start_tp_report 22:34:16 INFO - PROCESS | 16714 | _x_x_mozilla_page_load 22:34:16 INFO - PROCESS | 16714 | _x_x_mozilla_page_load_details 22:34:16 INFO - PROCESS | 16714 | |i|pagename|runs| 22:34:16 INFO - PROCESS | 16714 | |0;ai-astar;104;112;112;110;113;111;110;110;112;111 22:34:16 INFO - PROCESS | 16714 | |1;audio-beat-detection;154;123;121;159;123;124;121;121;150;120 22:34:16 INFO - PROCESS | 16714 | |2;audio-dft;160;160;161;162;161;162;163;161;162;164 22:34:16 INFO - PROCESS | 16714 | |3;audio-fft;74;74;74;120;76;75;77;76;99;75 22:34:16 INFO - PROCESS | 16714 | |4;audio-oscillator;82;81;113;82;82;83;104;83;83;119 22:34:16 INFO - PROCESS | 16714 | |5;imaging-gaussian-blur;116;117;117;116;116;117;116;117;117;117 22:34:16 INFO - PROCESS | 16714 | |6;imaging-darkroom;146;145;147;145;146;146;146;145;147;146 22:34:16 INFO - PROCESS | 16714 | |7;imaging-desaturate;85;85;85;84;85;84;85;84;84;85 22:34:16 INFO - PROCESS | 16714 | |8;json-parse-financial;56;52;54;53;57;57;55;52;54;53 22:34:16 INFO - PROCESS | 16714 | |9;json-stringify-tinderbox;60;59;59;59;60;60;60;60;60;59 22:34:16 INFO - PROCESS | 16714 | |10;stanford-crypto-aes;82;84;80;80;81;89;84;79;80;79 22:34:16 INFO - PROCESS | 16714 | |11;stanford-crypto-ccm;139;129;127;128;131;127;128;138;169;130 22:34:16 INFO - PROCESS | 16714 | |12;stanford-crypto-pbkdf2;165;166;166;165;165;167;166;167;164;165 22:34:16 INFO - PROCESS | 16714 | |13;stanford-crypto-sha256-iterative;69;65;67;65;66;68;65;66;65;66 22:34:16 INFO - PROCESS | 16714 | __end_tp_report 22:34:16 INFO - PROCESS | 16714 | __start_cc_report 22:34:16 INFO - PROCESS | 16714 | _x_x_mozilla_cycle_collect,1713 22:34:16 INFO - PROCESS | 16714 | __end_cc_report 22:34:16 INFO - PROCESS | 16714 | __startTimestamp1476423256017__endTimestamp 22:34:16 INFO - PROCESS | 16714 | 22:34:16 INFO - PROCESS | 16714 | ------- Summary: start ------- 22:34:16 INFO - PROCESS | 16714 | Number of tests: 14 22:34:16 INFO - PROCESS | 16714 | 22:34:16 INFO - PROCESS | 16714 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:2.51 (2.2%) stddev-sans-first:1.09 22:34:16 INFO - PROCESS | 16714 | Values: 104.0 112.0 112.0 110.0 113.0 111.0 110.0 110.0 112.0 111.0 22:34:16 INFO - PROCESS | 16714 | 22:34:16 INFO - PROCESS | 16714 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:123.50 stddev:15.88 (12.9%) stddev-sans-first:14.62 22:34:16 INFO - PROCESS | 16714 | Values: 154.0 123.0 121.0 159.0 123.0 124.0 121.0 121.0 150.0 120.0 22:34:16 INFO - PROCESS | 16714 | 22:34:16 INFO - PROCESS | 16714 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.20 22:34:16 INFO - PROCESS | 16714 | Values: 160.0 160.0 161.0 162.0 161.0 162.0 163.0 161.0 162.0 164.0 22:34:16 INFO - PROCESS | 16714 | 22:34:16 INFO - PROCESS | 16714 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.50 stddev:15.35 (20.3%) stddev-sans-first:16.00 22:34:16 INFO - PROCESS | 16714 | Values: 74.0 74.0 74.0 120.0 76.0 75.0 77.0 76.0 99.0 75.0 22:34:16 INFO - PROCESS | 16714 | 22:34:16 INFO - PROCESS | 16714 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:82.00 stddev:14.80 (18.0%) stddev-sans-first:15.32 22:34:16 INFO - PROCESS | 16714 | Values: 82.0 81.0 113.0 82.0 82.0 83.0 104.0 83.0 83.0 119.0 22:34:16 INFO - PROCESS | 16714 | 22:34:16 INFO - PROCESS | 16714 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 22:34:16 INFO - PROCESS | 16714 | Values: 116.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 22:34:16 INFO - PROCESS | 16714 | 22:34:16 INFO - PROCESS | 16714 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 22:34:16 INFO - PROCESS | 16714 | Values: 146.0 145.0 147.0 145.0 146.0 146.0 146.0 145.0 147.0 146.0 22:34:16 INFO - PROCESS | 16714 | 22:34:16 INFO - PROCESS | 16714 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 22:34:16 INFO - PROCESS | 16714 | Values: 85.0 85.0 85.0 84.0 85.0 84.0 85.0 84.0 84.0 85.0 22:34:16 INFO - PROCESS | 16714 | 22:34:16 INFO - PROCESS | 16714 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:1.89 (3.5%) stddev-sans-first:1.90 22:34:16 INFO - PROCESS | 16714 | Values: 56.0 52.0 54.0 53.0 57.0 57.0 55.0 52.0 54.0 53.0 22:34:16 INFO - PROCESS | 16714 | 22:34:16 INFO - PROCESS | 16714 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 22:34:16 INFO - PROCESS | 16714 | Values: 60.0 59.0 59.0 59.0 60.0 60.0 60.0 60.0 60.0 59.0 22:34:16 INFO - PROCESS | 16714 | 22:34:16 INFO - PROCESS | 16714 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:81.50 stddev:3.12 (3.8%) stddev-sans-first:3.31 22:34:16 INFO - PROCESS | 16714 | Values: 82.0 84.0 80.0 80.0 81.0 89.0 84.0 79.0 80.0 79.0 22:34:16 INFO - PROCESS | 16714 | 22:34:16 INFO - PROCESS | 16714 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:130.50 stddev:12.83 (9.8%) stddev-sans-first:13.51 22:34:16 INFO - PROCESS | 16714 | Values: 139.0 129.0 127.0 128.0 131.0 127.0 128.0 138.0 169.0 130.0 22:34:16 INFO - PROCESS | 16714 | 22:34:16 INFO - PROCESS | 16714 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:166.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 22:34:16 INFO - PROCESS | 16714 | Values: 165.0 166.0 166.0 165.0 165.0 167.0 166.0 167.0 164.0 165.0 22:34:16 INFO - PROCESS | 16714 | 22:34:16 INFO - PROCESS | 16714 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:1.40 (2.1%) stddev-sans-first:1.05 22:34:16 INFO - PROCESS | 16714 | Values: 69.0 65.0 67.0 65.0 66.0 68.0 65.0 66.0 65.0 66.0 22:34:16 INFO - PROCESS | 16714 | -------- Summary: end -------- 22:34:16 INFO - PROCESS | 16714 | 22:34:17 INFO - TEST-INFO | 16714: exit 0 22:34:17 INFO - TEST-OK | kraken | took 61487ms 22:34:17 INFO - SUITE-END | took 1178s 22:34:17 INFO - Completed test suite (00:19:39) 22:34:17 INFO - javascript benchmark 22:34:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2927.0926012935993, 2943.20533455967, 2991.356858275471, 2994.955075673864, 2998.400319936012, 5052.317937078494, 5083.313752643397, 5123.180291153416, 5166.199239117938, 5248.422673505921, 5067.670601410915, 5150.819721309755, 5224.033553792541, 5230.34620672416, 5241.528262456378, 4680.134175177586, 4701.106789709944, 4751.049790041988, 4769.284607308914, 4781.665283430161, 4737.786799594027, 4767.856964291077, 4825.7587120644, 4862.367892174012, 4870.512948705136, 4590.0, 4739.620830333565, 4753.71477711335, 4773.403324584427, 4863.489333619955, 4615.607673347769, 4673.112108699336, 4681.648876334254, 4685.1800934836265, 4685.2972054191805, 4649.767511624439, 4653.0, 4661.207594708873, 4662.393888794435, 4664.323673067386, 5016.097102521545, 5053.0, 5064.265681476202, 5065.037642847848, 5077.0, 5403.081476149025, 5451.100568406208, 5460.153676180159, 5464.644798088151, 5520.089185284423, 5490.615656904019, 5505.697186654733, 5505.972470137664, 5523.502884740393, 5561.972190139064, 4903.6077113831525, 5195.766190521435, 5197.896042079137, 5214.0614689355525, 5279.313689220415, 5406.324209473816, 5624.971875140598, 5631.042722737145, 5663.716814159358, 5779.133130030529, 5503.642263252876, 5506.2841830562575, 5509.531689806331, 5555.444455554493, 5569.0254205513875, 5570.080936645408, 5575.0, 5576.0241957657245, 5577.9163312550345, 5583.972080139654, 5341.893162136736, 5397.595180361489, 5451.754671039813, 5551.750171242304, 5623.2408624835125, 5540.196671482693, 5542.722863856791, 5544.91682624761, 5545.916811247835, 5614.129809879475, 4280.422143010716, 4282.614564689193, 4282.678799090081, 4283.700140990163, 4337.73973561581, 3721.888343349704, 3746.7002639788752, 3767.8492860285282, 3847.5575308839284, 3887.5918028607157, 5105.055564720538, 5126.794928202905, 5137.0753264412015, 5139.7687104080405, 5210.97394513025, 5432.429594892558, 5434.592405569598, 5440.91838622421, 5440.91838622421, 5454.672719636835, 5042.596592272609, 5111.795528178905, 5131.0, 5142.742862856842, 5189.195674670432, 4659.5573420525, 4717.056588682277, 4808.759562021885, 4810.687305325143, 4860.538248866423, 5717.142428635738, 5749.885002299847, 5761.9135712964335, 5772.826815195551, 5774.133879917962, 5569.0, 5570.080936645408, 5571.3871474137, 5571.554275658019, 5572.60991730575, 5560.582956278215, 5585.050541407889, 5622.746976385991, 5703.344115426779, 5733.168690539765, 5406.7296635167295, 5442.183672449164, 5444.564434845123, 5446.700431476307, 5524.86187845291, 5514.200440936122, 5529.060059789926, 5534.280543529477, 5545.085060964896, 5615.2700148982, 5243.528082472596, 5318.255444237887, 5333.679979201261, 5339.7063161526485, 5409.675419474844, 5355.384130824849, 5356.062689029326, 5362.865928351823, 5416.891662166656, 5432.511074003359, 5312.495312945264, 5321.787128514971, 5327.0, 5336.813211537577, 5401.189821526646, 5265.815696450606, 5309.150535914235, 5340.252364668871, 5360.2227676987395, 5381.784728610812, 5229.320188375486, 5301.655392399482, 5337.146056630921, 5347.759350829144, 5351.705656188947], "value": 5085.575500898129, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.8051228730662, 565.0563558856709, 584.3367777572454, 590.4862769390629, 612.7640858269566, 31100.0, 41487.17025659485, 42606.147877042444, 42674.359884601756, 42681.35977960333, 43344.78327608365, 43736.78131609345, 43795.78102109493, 43824.780876095654, 43864.34203486942, 8091.312238459738, 8293.917060829404, 8779.561021948894, 8940.687075952343, 8942.508162051117, 10763.730906727355, 11061.557537698482, 11093.55625774968, 11097.72255693606, 11110.0, 10868.782624347508, 10964.506597203104, 10975.890241097566, 10978.0, 10979.231453798237, 10855.24013319068, 10912.836307455394, 10923.781524369508, 10962.0, 11006.504707288192, 10643.733906652318, 10719.0, 10729.517171727213, 10738.838917416246, 10743.0, 41753.79123104365, 41817.163656726996, 42233.366499502226, 42240.57759422397, 42259.0, 3424.5719285089363, 3551.325248202859, 3560.394732895414, 3577.731670124725, 3786.4320351947154, 31548.842255788804, 31764.364712705617, 32004.839975800205, 32005.83997080023, 33268.50097248543, 4340.262155433584, 4449.5327990560845, 4484.9327260090795, 4572.0627271409285, 4624.306354046887, 323873.0, 324399.0, 324471.0, 325303.0, 325349.0, 32775.34449311048, 56186.0, 56574.0, 56598.71700641471, 56601.0, 33440.832795835864, 35625.64374356275, 35660.28679426397, 35668.82165589155, 35669.643303566634, 13953.581392558239, 14004.789928151085, 14020.018598697994, 14020.929895350459, 14024.509142179975, 10673.0, 10840.945795270973, 11733.765324693459, 11952.880471195176, 12034.097442691833, 8042.155573664681, 8049.959750201211, 8050.919490805134, 8156.592170391456, 8189.549574773326, 3098.907032788975, 3127.108773999399, 3169.8742775427645, 3178.253110519026, 3205.0, 963.210167662524, 972.4894430424084, 981.1415011864618, 1085.8654535565186, 1159.9594014209463, 31311.843440783105, 31548.0, 31667.524987125213, 31857.362852742815, 32266.193345166088, 1077.4612693653173, 1084.8915108489089, 1164.931311611702, 1166.9591564295208, 1239.231676360662, 15506.379744810081, 16241.756373654405, 16355.918220408821, 16532.58668533272, 16714.6657066858, 506061.0, 509329.0, 510543.0, 510566.0, 512844.0, 56716.0, 57301.0, 57396.0, 57398.426015740144, 57425.42574574285, 1199.6401079676061, 1222.413241644016, 1244.2161438293997, 1290.8128321393344, 1291.283337747559, 28274.010409635564, 31779.682203178596, 31782.52326215155, 32221.51667725033, 32708.836455817567, 47209.52790472051, 47619.28571071367, 47855.76072119617, 47985.760071199424, 48043.519564805305, 371179.0, 371893.0, 373389.0, 373620.0, 373672.0, 25105.0, 26517.734822651528, 27466.725332747217, 27506.449871002867, 28719.85640071786, 45364.0, 45938.31092533548, 46130.308045378675, 46200.30699539442, 46212.7689361551, 37943.62056379401, 39204.803975979936, 39911.60088399079, 39939.0, 41164.0, 37986.0, 38081.80959095297, 38482.230355392174, 39433.40849887311, 39576.2084758309, 38942.80528597339, 39161.608383915795, 39997.80001099976, 40175.59824401836, 42678.0, 31211.531827022158, 34742.82628586841, 35149.64850351464, 35368.11579710528, 35732.285354293286, 27357.863210684616, 27452.17643470699, 27653.723462765116, 27882.16353509398, 27949.353453649375], "value": 18688.729668469026, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.6038891517069, 363.37499500858513, 364.5898364340117, 366.8459247116211, 381.7575839342019, 14040.438382464701, 17632.64734705305, 18825.62348753024, 20268.0, 20401.693974590395, 18825.62348753024, 18989.240430382768, 19069.0, 19193.0, 19260.325888593903, 5448.8365349039495, 5739.626924249931, 5747.655140691572, 5748.166515855199, 5749.971250143764, 4131.690123240754, 4270.12462445198, 4383.408239887606, 5589.413111623282, 5607.719614019303, 6287.402696743825, 6316.3683631636695, 6422.133012043361, 6428.935710642881, 6443.710033048501, 6175.59858609189, 6234.0337247726675, 6236.0, 6248.593841400295, 6440.935590644081, 5404.972975135099, 5406.243125962368, 5409.24270602116, 5410.810621628224, 5414.620976531644, 22329.218477353377, 22945.77054229453, 23120.42198945023, 23121.190758323548, 23166.53666926669, 2215.3464727905143, 2313.7574228913104, 2322.88385580722, 2390.5816482115733, 2954.1116096883884, 13491.0, 13603.86396136036, 14297.64255893611, 14452.265728112694, 14781.408743650241, 1791.3819732192503, 1805.5395874052165, 1877.87793793403, 1877.9248830046781, 1901.3250296144945, 75806.24193758047, 76207.23792762058, 77942.22057779407, 78424.0, 79793.60103199446, 9496.857547136799, 9723.471897306752, 9897.03089073275, 9941.32856006373, 10261.640842570474, 14058.648533786532, 14062.156270623795, 14069.648258793612, 14069.71860562783, 14093.365798539091, 7422.810270970077, 7625.466217364731, 7651.655675494616, 7807.6486558105025, 7869.694728214164, 7297.452691048086, 7380.667869945865, 7539.0576177977755, 7606.581638009962, 7640.732574359982, 6101.664408457577, 6255.843603909939, 6269.7178626961895, 6295.811125666238, 6417.1657684500715, 1646.761219623148, 1705.7100292950229, 1707.6338928856865, 1758.34062226665, 1768.965689457109, 985.7929834734786, 993.4883534979491, 1009.7526106104051, 1015.2537635267329, 1061.076604554866, 18892.0, 19742.0, 19836.404907852786, 20020.0, 20094.39716808498, 981.9410835349902, 990.1732053735068, 997.0686182623065, 1003.3127307794184, 1025.3847691385108, 10766.623168189075, 11237.775244495228, 11332.467013194624, 11359.829602555968, 11470.713232169262, 319867.0, 328824.0, 428340.0, 431382.0, 431715.0, 92067.53966230126, 93338.0, 94768.52615736877, 94882.0, 95131.82758930998, 865.8138500222483, 892.9598168082451, 893.7765558610347, 900.7658008917729, 906.3655441191192, 16644.334226631283, 16824.915875420545, 17444.0, 17963.281468741105, 18077.186526606598, 38577.61422385852, 39136.5208870764, 39161.804190978866, 39756.0, 40109.79945100256, 55845.0, 55976.0, 56921.43078569161, 57154.712566678434, 58095.419045809, 8052.235037671412, 8088.272055515032, 8150.470219435718, 8211.794705132419, 8456.154384561742, 12189.207701499374, 12444.253344798979, 12551.686207844878, 12611.432485538357, 13611.11527750693, 11019.669409917715, 11109.222354435113, 11621.128415368712, 11622.0, 11628.6511404658, 11188.0, 11295.209335346775, 11391.601293955004, 11401.828972565252, 11955.462004209658, 11203.943980280372, 11553.24903881245, 11609.593664221711, 11695.76608467809, 12221.511139554319, 8038.155993620586, 8121.75634730959, 8270.462419942685, 8410.663573457237, 8451.0, 8561.315094792526, 11413.543458261576, 11443.599474018369, 11717.472713727731, 12067.698307542381], "value": 9071.440866384622, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.1519385329834, 1470.4779803169874, 1530.9464168754096, 1661.418503523766, 1698.167897730111, 8044.637991290391, 8647.0, 8655.43739656922, 8656.307495400368, 8657.13428657134, 7544.660490277937, 7759.650815713307, 7767.922320776791, 8159.388045896551, 8482.194191551807, 2220.245116660335, 2270.6026445371995, 2281.3726225288015, 2282.6804247405375, 2285.3486756274383, 2253.211376018397, 2270.20542810016, 2275.0785931697687, 2326.2090889097703, 2326.720793504782, 2281.064763446987, 2288.107638021173, 2297.24191016964, 2301.5051763870765, 2318.084356679111, 2238.955220895573, 2241.831862610311, 2242.8654280743126, 2251.7072780538588, 2255.3008567344177, 2136.2416342198608, 2160.6650969099815, 2164.967525487119, 2166.306781829815, 2166.328438184152, 8494.490330580185, 8523.914760852374, 8526.976762788505, 8549.102344253826, 8565.100664430207, 4940.925886111711, 5056.241563765465, 5091.516305950929, 5093.0577843099145, 5137.8715532112, 3400.897973060812, 3434.862605495777, 3496.580410350749, 3543.911402214965, 3571.8749843755345, 1086.8913108689146, 1106.5960924262586, 1114.504045699664, 1123.4102096399374, 1130.4969288666546, 11736.647900562997, 11747.060235181165, 11822.172447928648, 11841.171118021743, 11867.0, 4350.60844523988, 4412.646988240933, 4581.289900065495, 4603.401557797465, 4628.190066738374, 9811.754706132404, 9879.604815807432, 9972.700818975442, 9977.800443991226, 9978.45118518474, 5132.538071573502, 5150.072986862326, 5158.509941555546, 5162.354705661793, 5167.457416971164, 4106.7125301229225, 4599.0, 4740.928886066712, 4749.762511874393, 4777.474477807438, 3604.18905746205, 3655.3603119453987, 3723.646253605903, 3741.214344987529, 3750.5686846012513, 1208.5588760102676, 1228.3060071059822, 1237.2143688757524, 1241.4847838147248, 1254.4355040231933, 939.2204470289644, 941.3363578677016, 950.064186776025, 964.8504481805331, 981.5877331520778, 5302.522772950453, 5619.690916999522, 5651.802186923438, 5725.398833122462, 6045.093236014545, 432.2565187876847, 463.9512851150648, 464.64222548638037, 468.11058987922536, 474.5302150870613, 3825.5026846509777, 3957.5448823385104, 3998.620131087542, 4031.9596804031585, 4272.081502476983, 10526.684199474028, 10607.098396636373, 10691.41197234144, 10692.89307106919, 10724.463776811128, 10665.0, 10670.839937400946, 10680.412577308323, 10685.465726713634, 10693.893061069446, 7616.466847320745, 7792.766217013499, 7877.763667089882, 7927.326177274881, 7939.563324017119, 5484.177373394023, 5738.454846789548, 5895.793647222326, 5921.911171332347, 5949.672767997628, 9142.817143657223, 9353.438793672402, 9576.952115239379, 9602.711918642452, 9611.423314601147, 9390.0, 9641.27690423207, 9696.0788725071, 9762.51187440611, 9830.950845245728, 8115.959420202861, 8174.0, 8198.0, 8229.83540329202, 8292.87560686578, 8323.250907418362, 8325.458845175044, 8337.749867503984, 8339.082700903016, 8340.541270230196, 7404.296591823768, 7435.739749108755, 7534.8493030138, 7570.432217583813, 7605.543667379975, 7314.743983960536, 7326.890096648448, 7330.6701198445135, 7393.593352365671, 7538.170801211752, 6829.829254268683, 6852.931470685229, 6903.447724181953, 6947.895781563179, 6954.930450695429, 4886.92669609949, 5036.647434679538, 5116.539511443988, 5139.254808052886, 5198.298229739088, 5183.5593974512585, 5186.870328241674, 5238.856685988377, 5259.868503287295, 5277.102892508206], "value": 4433.602740917572, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.5341987019472, 316.14482823961185, 318.8676699169845, 321.3781333120412, 322.4470033891875, 5060.645754797166, 5186.170212765958, 5226.86932826679, 5299.761510732017, 5305.336832895888, 5062.5193655108915, 5173.896522069556, 5199.584033277338, 5206.973965130179, 5209.921851172236, 4053.7028150991696, 4064.715469917107, 4092.5702801205966, 4094.160697057096, 4094.61101195386, 3818.2745278397156, 3886.650201481866, 4065.26825171469, 4072.511298644167, 4090.3004017348558, 4049.2711311963835, 4052.5744796796353, 4055.878323650295, 4056.9917890644174, 4067.491563554556, 4024.0, 4041.8383264669233, 4047.1096358801015, 4047.271491131595, 4053.756774593534, 3588.5155504006884, 3588.946165807515, 3589.94615080774, 3614.710823134143, 3617.4212126059706, 5027.597792176617, 5083.262926875583, 5109.795608175668, 5115.565176959963, 5148.330717006766, 4617.261238201905, 4622.850374575804, 4638.79125439356, 4642.326862604903, 4646.047560250141, 5308.761655390209, 5454.754536045887, 5457.370848385819, 5482.0, 5498.422665620133, 3830.559485659157, 3858.131920317934, 3858.6913046956174, 3870.9225815483815, 3886.300465916134, 5588.2455868458055, 5625.887482250373, 5680.772769089232, 5682.318121825366, 5685.374608793029, 3923.1761330120426, 3933.940990885139, 3934.8622798201927, 3936.193080418507, 3947.2894878921497, 3874.845006199777, 3903.414487826792, 3940.7832569208967, 3974.324364857981, 3998.9600103998587, 4545.931811022837, 4553.2942393929, 4557.817687292471, 4558.316252562142, 4573.245414506569, 5365.114756065205, 5392.676439413648, 5445.537129343971, 5489.670619762827, 5538.0, 1283.1146508908823, 1298.2729671384054, 1366.9863301367059, 1373.7321222361743, 1400.7128538649552, 886.7162507997378, 904.1817155474175, 912.7854954085784, 914.5244472874068, 919.9310051746146, 4608.470025946992, 4634.884127896829, 4651.37206477128, 4659.084665677675, 4695.0, 4529.207388706963, 4910.803567857246, 4918.6556941014505, 4930.383702037246, 4938.382657191694, 4632.2356811126465, 4638.744869032168, 4645.488996210414, 4648.233041548175, 4656.231721765871, 2591.8444893306464, 2593.9092131775296, 2612.4644447888136, 2624.934376640599, 2626.7898568114506, 4702.835400760957, 5026.321446604661, 5043.2435134730085, 5048.495150484996, 5064.784451731558, 4936.753162341868, 4987.675801072991, 4987.800487980513, 4993.350864387607, 5024.974875125674, 5059.785651443627, 5060.0, 5101.8724531887, 5124.564412024945, 5156.355455568054, 4618.709416597149, 4731.645126615586, 4860.708357498562, 4893.165063101337, 4907.55831975124, 4802.831900883592, 4822.493638167942, 4841.588464980516, 4843.329051477234, 4859.829905953275, 5008.1235783736975, 5042.991401719597, 5072.9746351268, 5074.517920797518, 5075.441701412916, 3575.73182011345, 3659.5608526976935, 3661.718398560589, 3693.2244228711197, 3722.7394082415053, 4894.828680996148, 4941.827036053721, 4942.678725882806, 4954.826581069645, 4980.601551875914, 4748.382710247645, 4763.642726795573, 4774.522547745198, 4823.300621409946, 4833.709977401367, 4627.62978961689, 4720.315554244684, 4788.712677239377, 4882.414110306786, 4899.31409602663, 4727.0, 4761.857144285677, 4765.425930552086, 4771.809127634856, 4773.522647735199, 4816.903661926812, 4840.806367745251, 4846.951530484791, 4860.441049279378, 4876.317315575751, 4485.0, 4677.32178834074, 4684.672072954861, 4693.765311734468, 4705.317728929218], "value": 3903.582415065986, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.3180946291559, 718.5006420537725, 726.5713229194774, 750.8273097187644, 765.265345268542, 15468.767968480483, 16603.833961660366, 16687.66624667506, 16722.331106755715, 16826.66346673067, 13745.587632371045, 13782.862171378283, 13991.160530368184, 14004.579862604112, 14084.0, 660.5541259649741, 793.183021487867, 802.2498963469146, 802.9277365037145, 803.333233416266, 678.2437582095977, 789.3606178995004, 800.6997375984006, 808.640155130967, 814.1817473439186, 862.5385418800943, 867.8220964702252, 871.363904349825, 871.8866547348836, 872.2411501993274, 695.8817001109824, 850.1243718969471, 853.1766844994579, 853.4580541356253, 853.8164294676643, 521.1947541049088, 607.2288193993603, 616.6947361056261, 619.9256089269271, 622.3993845938691, 14043.64890877726, 14103.153810771284, 14112.92943535286, 14149.434022639081, 14204.502842400467, 13699.45202191911, 14039.578812635535, 14295.428182872673, 14313.355898984571, 14342.71314573713, 12649.557265495663, 12949.80575291362, 13029.609111726664, 13153.21080735159, 13506.189628622315, 4384.561543845622, 4393.6045755881805, 4435.090806384684, 4475.440569928759, 4475.888102797424, 73530.0, 73672.0, 73723.26276737217, 73899.63050184715, 73904.0, 10870.402127882884, 11013.449327533592, 11149.554017839358, 11319.490622921989, 11451.942740286246, 20390.08244628995, 20465.2837150702, 20499.8975005124, 20522.28172014002, 20533.794662053486, 8306.252437280673, 8337.0, 8385.790355241046, 8457.57712114404, 8739.519326437106, 4418.33724941255, 4647.1635105680625, 4690.226112691368, 4726.550977657117, 4865.829695960624, 3281.950770738441, 3425.400554902882, 3426.5031570422148, 3440.535527703728, 3442.9311413771584, 599.9160117583542, 603.2128072864954, 608.2214765100679, 623.9407256310643, 637.0794202377613, 561.9606627536033, 582.5659883386904, 608.0484042473515, 640.9070684750685, 660.920689517261, 8866.113388661082, 9261.536923153815, 9335.206507446806, 9351.812963740824, 9574.329796914288, 610.8014895159091, 645.7513857164931, 656.6486929492698, 681.2914568848342, 684.94177994871, 4491.348754430589, 4542.523035081335, 4546.226801650991, 4547.3179023146795, 4581.862544123682, 66655.0, 68880.6555967217, 86065.0, 115902.42048789702, 121030.39484802696, 57705.0, 59590.0, 71571.64214178895, 86291.0, 98622.5068874651, 56208.0, 77148.0, 82672.0, 90022.54988725146, 94582.5270873655, 8548.74353769388, 8710.956445217733, 8830.337724670548, 8874.361511780138, 9034.412763170372, 50993.490065100355, 52331.0, 52402.0, 52927.47072529225, 53421.46578534321, 43700.03349849328, 44199.77900110607, 65890.0, 76688.61655691685, 77908.0, 11495.712607184887, 11745.412729363668, 11752.412379381169, 12041.638750837488, 12603.243805371707, 11364.261323013978, 11428.714282143013, 11732.0, 11785.410729463321, 11829.467673954865, 11359.318440893572, 11399.943000285277, 11683.474243658886, 11830.231034982698, 12118.818217726564, 11403.543858245577, 11565.363904985306, 11617.361045142261, 11865.644030679094, 12239.632811015685, 11484.0, 11896.405179741152, 12000.339981301113, 12245.387730613611, 12717.936410317889, 9802.019798020141, 10067.0, 10366.792664146524, 10384.740381490523, 10910.509027093958, 9221.645223090618, 9407.529623518934, 10111.39331640104, 10196.949015254877, 10218.744531386477], "value": 7094.474866409469, "unit": "score"}], "name": "dromaeo_css", "value": 6878.030584873598, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 110.0, 113.0, 111.0, 110.0, 110.0, 112.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 121.0, 159.0, 123.0, 124.0, 121.0, 121.0, 150.0, 120.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 162.0, 161.0, 162.0, 163.0, 161.0, 162.0, 164.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 120.0, 76.0, 75.0, 77.0, 76.0, 99.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 113.0, 82.0, 82.0, 83.0, 104.0, 83.0, 83.0, 119.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 145.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 85.0, 84.0, 85.0, 84.0, 84.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 54.0, 53.0, 57.0, 57.0, 55.0, 52.0, 54.0, 53.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 80.0, 80.0, 81.0, 89.0, 84.0, 79.0, 80.0, 79.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 129.0, 127.0, 128.0, 131.0, 127.0, 128.0, 138.0, 169.0, 130.0], "value": 134.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 166.0, 165.0, 165.0, 167.0, 166.0, 167.0, 164.0, 165.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 67.0, 65.0, 66.0, 68.0, 65.0, 66.0, 65.0, 66.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1486.0999999999997, "alertThreshold": 2.0}]} 22:34:17 INFO - Return code: 0 22:34:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:34:17 INFO - # TBPL SUCCESS # 22:34:17 INFO - Running post-action listener: _resource_record_post_action 22:34:17 INFO - [mozharness: 2016-10-14 05:34:17.810520Z] Finished run-tests step (success) 22:34:17 INFO - Running post-run listener: _resource_record_post_run 22:34:17 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404836352; Read time: 172; Write time: 262956 22:34:17 INFO - TinderboxPrint: CPU usage
13.2% 22:34:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 172 22:34:17 INFO - TinderboxPrint: I/O write bytes / time
404,836,352 / 262,956 22:34:17 INFO - TinderboxPrint: CPU idle
8,283.9 (86.8%) 22:34:17 INFO - TinderboxPrint: CPU user
1,208.6 (12.7%) 22:34:17 INFO - TinderboxPrint: Swap in / out
0 / 0 22:34:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115228672; Read time: 0; Write time: 89524 22:34:17 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289607680; Read time: 172; Write time: 173432 22:34:18 INFO - Running post-run listener: _upload_blobber_files 22:34:18 INFO - Blob upload gear active. 22:34:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:34:18 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 22:34:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:34:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:34:18 INFO - (blobuploader) - INFO - Open directory for files ... 22:34:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:34:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:34:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:34:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:34:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:34:21 INFO - (blobuploader) - INFO - Done attempting. 22:34:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:34:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:34:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:34:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:34:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:34:22 INFO - (blobuploader) - INFO - Done attempting. 22:34:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:34:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:34:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:34:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:34:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:34:23 INFO - (blobuploader) - INFO - Done attempting. 22:34:23 INFO - (blobuploader) - INFO - Iteration through files over. 22:34:23 INFO - Return code: 0 22:34:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:34:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:34:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c8a44a9c4ddfa6525156bdbee3327278c57fdf5b44a4dfa8cdf492b940373bce95765b690665485b41a09741e6ae17bece734b9c13c1c7f0380fd2be3c71bee0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bd5995759ef974e042ac0269162be22601105788a3a342a3483b8e4817edc5bee8f34e44bfc3c301be92db6e66965fe02fb6088c299a6fc86fa94645f118fb76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/544cd3827ff06ef36f6a9fe0ecc8db75e0d0290aa16b5bc2b26fbdf49444331061733de5894602c2129fa3e8997f0f7bf8fc6fbe8c6b721183b3d0d5efb37590"} 22:34:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:34:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:34:23 INFO - Contents: 22:34:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c8a44a9c4ddfa6525156bdbee3327278c57fdf5b44a4dfa8cdf492b940373bce95765b690665485b41a09741e6ae17bece734b9c13c1c7f0380fd2be3c71bee0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bd5995759ef974e042ac0269162be22601105788a3a342a3483b8e4817edc5bee8f34e44bfc3c301be92db6e66965fe02fb6088c299a6fc86fa94645f118fb76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/544cd3827ff06ef36f6a9fe0ecc8db75e0d0290aa16b5bc2b26fbdf49444331061733de5894602c2129fa3e8997f0f7bf8fc6fbe8c6b721183b3d0d5efb37590"} 22:34:23 INFO - Running post-run listener: copy_logs_to_upload_dir 22:34:23 INFO - Copying logs to upload dir... 22:34:23 INFO - mkdir: /builds/slave/test/build/upload/logs 22:34:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.762264 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-13 22:34:23.004395) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 22:34:23.007690) ========= 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=523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c8a44a9c4ddfa6525156bdbee3327278c57fdf5b44a4dfa8cdf492b940373bce95765b690665485b41a09741e6ae17bece734b9c13c1c7f0380fd2be3c71bee0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bd5995759ef974e042ac0269162be22601105788a3a342a3483b8e4817edc5bee8f34e44bfc3c301be92db6e66965fe02fb6088c299a6fc86fa94645f118fb76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/544cd3827ff06ef36f6a9fe0ecc8db75e0d0290aa16b5bc2b26fbdf49444331061733de5894602c2129fa3e8997f0f7bf8fc6fbe8c6b721183b3d0d5efb37590"} build_url:https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c8a44a9c4ddfa6525156bdbee3327278c57fdf5b44a4dfa8cdf492b940373bce95765b690665485b41a09741e6ae17bece734b9c13c1c7f0380fd2be3c71bee0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bd5995759ef974e042ac0269162be22601105788a3a342a3483b8e4817edc5bee8f34e44bfc3c301be92db6e66965fe02fb6088c299a6fc86fa94645f118fb76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/544cd3827ff06ef36f6a9fe0ecc8db75e0d0290aa16b5bc2b26fbdf49444331061733de5894602c2129fa3e8997f0f7bf8fc6fbe8c6b721183b3d0d5efb37590"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 22:34:23.033695) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 22:34:23.034055) ========= 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=523ca41ca1e0623de333ad52000001bf-1476422022.523139-1209150338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 22:34:23.119207) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 22:34:23.119563) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 22:34:23.119856) ========= ========= Total master_lag: 0.15 =========