builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1478597111.37 results: success (0) buildid: 20161107223014 builduid: 9794e752e99e498189e4f57c251a72f5 revision: f13e90d496cf1bc6dfc4fd398da33e4afe785bde ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 01:25:11.375328) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 01:25:11.375780) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 01:25:11.376058) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 01:25:11.392191) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 01:25:11.392610) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-08 01:25:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-11-08 01:25:11 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118436 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 01:25:11.527062) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 01:25:11.527653) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017896 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 01:25:11.577718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 01:25:11.578042) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f13e90d496cf1bc6dfc4fd398da33e4afe785bde --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f13e90d496cf1bc6dfc4fd398da33e4afe785bde --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=a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-08 01:25:11,900 truncating revision to first 12 chars 2016-11-08 01:25:11,900 Setting DEBUG logging. 2016-11-08 01:25:11,900 attempt 1/10 2016-11-08 01:25:11,900 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f13e90d496cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-08 01:25:12,206 unpacking tar archive at: mozilla-central-f13e90d496cf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613690 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 01:25:12.205866) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 01:25:12.206162) ========= script_repo_revision: f13e90d496cf1bc6dfc4fd398da33e4afe785bde ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 01:25:12.206571) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 01:25:12.206848) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 01:25:12.216443) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-11-08 01:25:12.216813) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:25:12 INFO - MultiFileLogger online at 20161108 01:25:12 in /builds/slave/test 01:25:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 01:25:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:25:12 INFO - {'append_to_log': False, 01:25:12 INFO - 'base_work_dir': '/builds/slave/test', 01:25:12 INFO - 'blob_upload_branch': 'Firefox', 01:25:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:25:12 INFO - 'branch': 'Firefox', 01:25:12 INFO - 'buildbot_json_path': 'buildprops.json', 01:25:12 INFO - 'config_files': ('talos/linux_config.py',), 01:25:12 INFO - 'default_actions': ('clobber', 01:25:12 INFO - 'read-buildbot-config', 01:25:12 INFO - 'download-and-extract', 01:25:12 INFO - 'populate-webroot', 01:25:12 INFO - 'create-virtualenv', 01:25:12 INFO - 'install', 01:25:12 INFO - 'run-tests'), 01:25:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:25:12 INFO - 'download_minidump_stackwalk': True, 01:25:12 INFO - 'download_symbols': 'ondemand', 01:25:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:25:12 INFO - 'tooltool.py': '/tools/tooltool.py', 01:25:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:25:12 INFO - '/tools/misc-python/virtualenv.py')}, 01:25:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:25:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:25:12 INFO - 'installer_path': 'installer.exe', 01:25:12 INFO - 'log_level': 'info', 01:25:12 INFO - 'log_name': 'talos', 01:25:12 INFO - 'log_to_console': True, 01:25:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:25:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:25:12 INFO - 'opt_config_files': (), 01:25:12 INFO - 'pip_index': False, 01:25:12 INFO - 'sps_profile': False, 01:25:12 INFO - 'sps_profile_interval': 0, 01:25:12 INFO - 'suite': 'dromaeojs', 01:25:12 INFO - 'system_bits': '32', 01:25:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:25:12 INFO - 'title': 'talos-linux64-ix-062', 01:25:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:25:12 INFO - 'use_talos_json': True, 01:25:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:25:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:25:12 INFO - 'work_dir': 'build'} 01:25:12 INFO - [mozharness: 2016-11-08 09:25:12.645353Z] Running clobber step. 01:25:12 INFO - Running pre-action listener: _resource_record_pre_action 01:25:12 INFO - Running main action method: clobber 01:25:12 INFO - rmtree: /builds/slave/test/build 01:25:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:25:13 INFO - Running post-action listener: _resource_record_post_action 01:25:13 INFO - [mozharness: 2016-11-08 09:25:13.636843Z] Finished clobber step (success) 01:25:13 INFO - [mozharness: 2016-11-08 09:25:13.636941Z] Running read-buildbot-config step. 01:25:13 INFO - Running pre-action listener: _resource_record_pre_action 01:25:13 INFO - Running main action method: read_buildbot_config 01:25:13 INFO - Using buildbot properties: 01:25:13 INFO - { 01:25:13 INFO - "project": "", 01:25:13 INFO - "product": "firefox", 01:25:13 INFO - "script_repo_revision": "production", 01:25:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 01:25:13 INFO - "repository": "", 01:25:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 01:25:13 INFO - "buildid": "20161107223014", 01:25:13 INFO - "pgo_build": "True", 01:25:13 INFO - "basedir": "/builds/slave/test", 01:25:13 INFO - "buildnumber": 74, 01:25:13 INFO - "slavename": "talos-linux64-ix-062", 01:25:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:25:13 INFO - "platform": "ubuntu64_hw", 01:25:13 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 01:25:13 INFO - "branch": "mozilla-central", 01:25:13 INFO - "repo_path": "mozilla-central", 01:25:13 INFO - "revision": "f13e90d496cf1bc6dfc4fd398da33e4afe785bde", 01:25:13 INFO - "stage_platform": "linux64-pgo", 01:25:13 INFO - "builduid": "9794e752e99e498189e4f57c251a72f5", 01:25:13 INFO - "slavebuilddir": "test" 01:25:13 INFO - } 01:25:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 01:25:13 INFO - Running post-action listener: _resource_record_post_action 01:25:13 INFO - [mozharness: 2016-11-08 09:25:13.639351Z] Finished read-buildbot-config step (success) 01:25:13 INFO - [mozharness: 2016-11-08 09:25:13.639439Z] Running download-and-extract step. 01:25:13 INFO - Running pre-action listener: _resource_record_pre_action 01:25:13 INFO - Running main action method: download_and_extract 01:25:13 INFO - mkdir: /builds/slave/test/build/tests 01:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:13 INFO - trying https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:25:13 INFO - Downloading https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:25:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:25:14 INFO - Downloaded 1361 bytes. 01:25:14 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:25:14 INFO - Using the following test package requirements: 01:25:14 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:25:14 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:25:14 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:25:14 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:14 INFO - u'jsshell-linux-x86_64.zip'], 01:25:14 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:25:14 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:25:14 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:25:14 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:25:14 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:25:14 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:25:14 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:25:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:25:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:25:14 INFO - Fetch https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:25:14 INFO - Http code: 200 01:25:14 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 01:25:14 INFO - x-amz-cf-id: zCPAaIFAudHPLl8YDTb1P7kAj6E0ITQuwI2gY3svvukZrQ9yKvtwCQ== 01:25:14 INFO - x-amz-version-id: ARg.8qZH3Fyi2tYzuhbobQYE1Ziwgijf 01:25:15 INFO - Expected file size: 21923144 01:25:15 INFO - Obtained file size: 21923144 01:25:19 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:25:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:25:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:25:19 INFO - Fetch https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:25:19 INFO - Http code: 200 01:25:19 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 01:25:19 INFO - x-amz-cf-id: x0NFlMP4YyohI9MmjoPPonCBmIJ15e4_cV30CqZjqmT6FKF6rxgI9A== 01:25:19 INFO - x-amz-version-id: ARg.8qZH3Fyi2tYzuhbobQYE1Ziwgijf 01:25:20 INFO - Expected file size: 21923144 01:25:20 INFO - Obtained file size: 21923144 01:25:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 01:25:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:25:24 INFO - Fetch https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 01:25:25 INFO - Http code: 200 01:25:25 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 01:25:25 INFO - x-amz-cf-id: PgMrXX8Uv3R7PbMP-8gV5cX-_v9g6LOXTDft55fvLRlM0CG_ORx4DQ== 01:25:25 INFO - x-amz-version-id: 70jHW6gxuWsJAm6zDTWKxw8Yycvo78R8 01:25:25 INFO - Expected file size: 14409038 01:25:25 INFO - Obtained file size: 14409038 01:25:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:25 INFO - trying https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:25:25 INFO - Downloading https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:25:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:25:28 INFO - Downloaded 59656612 bytes. 01:25:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:25:28 INFO - mkdir: /builds/slave/test/properties 01:25:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:25:28 INFO - Writing to file /builds/slave/test/properties/build_url 01:25:28 INFO - Contents: 01:25:28 INFO - build_url:https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:25:28 INFO - Running post-action listener: _resource_record_post_action 01:25:28 INFO - Running post-action listener: set_extra_try_arguments 01:25:28 INFO - [mozharness: 2016-11-08 09:25:28.761366Z] Finished download-and-extract step (success) 01:25:28 INFO - [mozharness: 2016-11-08 09:25:28.761595Z] Running populate-webroot step. 01:25:28 INFO - Running pre-action listener: _resource_record_pre_action 01:25:28 INFO - Running main action method: populate_webroot 01:25:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:25:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:25:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:25:28 INFO - '--tppagecycles', 01:25:28 INFO - '7'], 01:25:28 INFO - 'tests': ['tsvgm']}}, 01:25:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:25:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:25:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:25:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:25:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:25:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:25:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:28 INFO - 'talos_options': ['--disable-e10s'], 01:25:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:25:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:25:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:28 INFO - 'talos_options': ['--disable-e10s'], 01:25:28 INFO - 'tests': ['damp', 'tps']}, 01:25:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:28 INFO - 'tests': ['damp', 'tps']}, 01:25:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:25:28 INFO - 'tests': ['dromaeo_dom']}, 01:25:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:25:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:25:28 INFO - 'tests': ['basic_compositor_video']}, 01:25:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:25:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:25:28 INFO - 'tests': ['a11yr', 01:25:28 INFO - 'ts_paint', 01:25:28 INFO - 'tpaint', 01:25:28 INFO - 'sessionrestore', 01:25:28 INFO - 'sessionrestore_no_auto_restore', 01:25:28 INFO - 'tabpaint']}, 01:25:28 INFO - 'other-e10s': {'tests': ['a11yr', 01:25:28 INFO - 'ts_paint', 01:25:28 INFO - 'tpaint', 01:25:28 INFO - 'sessionrestore', 01:25:28 INFO - 'sessionrestore_no_auto_restore', 01:25:28 INFO - 'tabpaint']}, 01:25:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:25:28 INFO - 'ts_paint', 01:25:28 INFO - 'tpaint', 01:25:28 INFO - 'sessionrestore', 01:25:28 INFO - 'sessionrestore_no_auto_restore', 01:25:28 INFO - 'tabpaint']}, 01:25:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:25:28 INFO - 'ts_paint', 01:25:28 INFO - 'tpaint', 01:25:28 INFO - 'sessionrestore', 01:25:28 INFO - 'sessionrestore_no_auto_restore', 01:25:28 INFO - 'tabpaint']}, 01:25:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:25:28 INFO - 'tests': ['a11yr', 01:25:28 INFO - 'ts_paint', 01:25:28 INFO - 'tpaint', 01:25:28 INFO - 'sessionrestore', 01:25:28 INFO - 'sessionrestore_no_auto_restore', 01:25:28 INFO - 'tabpaint']}, 01:25:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:25:28 INFO - 'tests': ['a11yr', 01:25:28 INFO - 'ts_paint', 01:25:28 INFO - 'tpaint', 01:25:28 INFO - 'sessionrestore', 01:25:28 INFO - 'sessionrestore_no_auto_restore', 01:25:28 INFO - 'tabpaint']}, 01:25:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:25:28 INFO - 'tests': ['tsvgx', 01:25:28 INFO - 'tsvgr_opacity', 01:25:28 INFO - 'tart', 01:25:28 INFO - 'tscrollx', 01:25:28 INFO - 'cart']}, 01:25:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:25:28 INFO - 'tsvgr_opacity', 01:25:28 INFO - 'tart', 01:25:28 INFO - 'tscrollx', 01:25:28 INFO - 'cart']}, 01:25:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:28 INFO - 'talos_options': ['--disable-e10s'], 01:25:28 INFO - 'tests': ['tp5o']}, 01:25:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:28 INFO - 'tests': ['tp5o']}, 01:25:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:28 INFO - 'talos_options': ['--disable-e10s', 01:25:28 INFO - '--xperf_path', 01:25:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:25:28 INFO - 'tests': ['tp5n']}, 01:25:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:28 INFO - 'talos_options': ['--xperf_path', 01:25:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:25:28 INFO - 'tests': ['tp5n']}}, 01:25:28 INFO - 'talos.zip': {'path': '', 01:25:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:25:28 INFO - Running post-action listener: _resource_record_post_action 01:25:28 INFO - [mozharness: 2016-11-08 09:25:28.781327Z] Finished populate-webroot step (success) 01:25:28 INFO - [mozharness: 2016-11-08 09:25:28.781416Z] Running create-virtualenv step. 01:25:28 INFO - Running pre-action listener: _resource_record_pre_action 01:25:28 INFO - Running main action method: create_virtualenv 01:25:28 INFO - Creating virtualenv /builds/slave/test/build/venv 01:25:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:25:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:25:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:25:28 INFO - Using real prefix '/usr' 01:25:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:25:29 INFO - Installing distribute.............................................................................................................................................................................................done. 01:25:31 INFO - Installing pip.................done. 01:25:31 INFO - Return code: 0 01:25:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:25:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:25:31 INFO - Reading from file tmpfile_stdout 01:25:31 INFO - Output received: 01:25:31 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 01:25:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1a864f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a28790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a25930>, '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 0x1a26830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a26cc0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:25:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:25:31 INFO - Using env: {'DISPLAY': ':0', 01:25:31 INFO - 'HOME': '/home/cltbld', 01:25:31 INFO - 'LANG': 'en_US.UTF-8', 01:25:31 INFO - 'LANGUAGE': 'en_US:en', 01:25:31 INFO - 'LOGNAME': 'cltbld', 01:25:31 INFO - 'MAIL': '/var/mail/cltbld', 01:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:31 INFO - 'MOZ_NO_REMOTE': '1', 01:25:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:31 INFO - 'NO_EM_RESTART': '1', 01:25:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:31 INFO - 'PWD': '/builds/slave/test', 01:25:31 INFO - 'SHELL': '/bin/bash', 01:25:31 INFO - 'SHLVL': '1', 01:25:31 INFO - 'TERM': 'linux', 01:25:31 INFO - 'TMOUT': '86400', 01:25:31 INFO - 'USER': 'cltbld', 01:25:31 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 01:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:31 INFO - '_': '/tools/buildbot/bin/python'} 01:25:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:25:31 INFO - Cleaning up... 01:25:31 INFO - Return code: 0 01:25:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1a864f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a28790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a25930>, '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 0x1a26830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a26cc0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:25:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:25:31 INFO - Using env: {'DISPLAY': ':0', 01:25:31 INFO - 'HOME': '/home/cltbld', 01:25:31 INFO - 'LANG': 'en_US.UTF-8', 01:25:31 INFO - 'LANGUAGE': 'en_US:en', 01:25:31 INFO - 'LOGNAME': 'cltbld', 01:25:31 INFO - 'MAIL': '/var/mail/cltbld', 01:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:31 INFO - 'MOZ_NO_REMOTE': '1', 01:25:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:31 INFO - 'NO_EM_RESTART': '1', 01:25:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:31 INFO - 'PWD': '/builds/slave/test', 01:25:31 INFO - 'SHELL': '/bin/bash', 01:25:31 INFO - 'SHLVL': '1', 01:25:31 INFO - 'TERM': 'linux', 01:25:31 INFO - 'TMOUT': '86400', 01:25:31 INFO - 'USER': 'cltbld', 01:25:31 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 01:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:31 INFO - '_': '/tools/buildbot/bin/python'} 01:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:32 INFO - Downloading/unpacking psutil>=3.1.1 01:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:25:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:25:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:25:34 INFO - Installing collected packages: psutil 01:25:34 INFO - Running setup.py install for psutil 01:25:34 INFO - building 'psutil._psutil_linux' extension 01:25:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:25:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:25:34 INFO - building 'psutil._psutil_posix' extension 01:25:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:25:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:25:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:25:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:25:34 INFO - Successfully installed psutil 01:25:34 INFO - Cleaning up... 01:25:34 INFO - Return code: 0 01:25:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:34 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 0x7f1a864f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a28790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a25930>, '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 0x1a26830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a26cc0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:25:34 INFO - Using env: {'DISPLAY': ':0', 01:25:34 INFO - 'HOME': '/home/cltbld', 01:25:34 INFO - 'LANG': 'en_US.UTF-8', 01:25:34 INFO - 'LANGUAGE': 'en_US:en', 01:25:34 INFO - 'LOGNAME': 'cltbld', 01:25:34 INFO - 'MAIL': '/var/mail/cltbld', 01:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:34 INFO - 'MOZ_NO_REMOTE': '1', 01:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:34 INFO - 'NO_EM_RESTART': '1', 01:25:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:34 INFO - 'PWD': '/builds/slave/test', 01:25:34 INFO - 'SHELL': '/bin/bash', 01:25:34 INFO - 'SHLVL': '1', 01:25:34 INFO - 'TERM': 'linux', 01:25:34 INFO - 'TMOUT': '86400', 01:25:34 INFO - 'USER': 'cltbld', 01:25:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 01:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:34 INFO - '_': '/tools/buildbot/bin/python'} 01:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:25:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:25:36 INFO - Installing collected packages: mozsystemmonitor 01:25:36 INFO - Running setup.py install for mozsystemmonitor 01:25:36 INFO - Successfully installed mozsystemmonitor 01:25:36 INFO - Cleaning up... 01:25:36 INFO - Return code: 0 01:25:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:36 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 0x7f1a864f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a28790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a25930>, '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 0x1a26830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a26cc0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:25:36 INFO - Using env: {'DISPLAY': ':0', 01:25:36 INFO - 'HOME': '/home/cltbld', 01:25:36 INFO - 'LANG': 'en_US.UTF-8', 01:25:36 INFO - 'LANGUAGE': 'en_US:en', 01:25:36 INFO - 'LOGNAME': 'cltbld', 01:25:36 INFO - 'MAIL': '/var/mail/cltbld', 01:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:36 INFO - 'MOZ_NO_REMOTE': '1', 01:25:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:36 INFO - 'NO_EM_RESTART': '1', 01:25:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:36 INFO - 'PWD': '/builds/slave/test', 01:25:36 INFO - 'SHELL': '/bin/bash', 01:25:36 INFO - 'SHLVL': '1', 01:25:36 INFO - 'TERM': 'linux', 01:25:36 INFO - 'TMOUT': '86400', 01:25:36 INFO - 'USER': 'cltbld', 01:25:36 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 01:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:36 INFO - '_': '/tools/buildbot/bin/python'} 01:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:37 INFO - Downloading/unpacking jsonschema==2.5.1 01:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:25:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:39 INFO - Downloading functools32-3.2.3-2.tar.gz 01:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:25:39 INFO - warning: no files found matching '*.txt' 01:25:39 INFO - no previously-included directories found matching 'build' 01:25:39 INFO - no previously-included directories found matching 'dist' 01:25:39 INFO - no previously-included directories found matching '.git*' 01:25:39 INFO - Installing collected packages: jsonschema, functools32 01:25:39 INFO - Running setup.py install for functools32 01:25:39 INFO - warning: no files found matching '*.txt' 01:25:39 INFO - no previously-included directories found matching 'build' 01:25:39 INFO - no previously-included directories found matching 'dist' 01:25:39 INFO - no previously-included directories found matching '.git*' 01:25:39 INFO - Successfully installed jsonschema functools32 01:25:39 INFO - Cleaning up... 01:25:39 INFO - Return code: 0 01:25:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:39 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 0x7f1a864f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a28790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a25930>, '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 0x1a26830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a26cc0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:25:39 INFO - Using env: {'DISPLAY': ':0', 01:25:39 INFO - 'HOME': '/home/cltbld', 01:25:39 INFO - 'LANG': 'en_US.UTF-8', 01:25:39 INFO - 'LANGUAGE': 'en_US:en', 01:25:39 INFO - 'LOGNAME': 'cltbld', 01:25:39 INFO - 'MAIL': '/var/mail/cltbld', 01:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:39 INFO - 'MOZ_NO_REMOTE': '1', 01:25:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:39 INFO - 'NO_EM_RESTART': '1', 01:25:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:39 INFO - 'PWD': '/builds/slave/test', 01:25:39 INFO - 'SHELL': '/bin/bash', 01:25:39 INFO - 'SHLVL': '1', 01:25:39 INFO - 'TERM': 'linux', 01:25:39 INFO - 'TMOUT': '86400', 01:25:39 INFO - 'USER': 'cltbld', 01:25:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 01:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:39 INFO - '_': '/tools/buildbot/bin/python'} 01:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:25:39 INFO - Cleaning up... 01:25:39 INFO - Return code: 0 01:25:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:39 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 0x7f1a864f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a28790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a25930>, '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 0x1a26830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a26cc0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:25:39 INFO - Using env: {'DISPLAY': ':0', 01:25:39 INFO - 'HOME': '/home/cltbld', 01:25:39 INFO - 'LANG': 'en_US.UTF-8', 01:25:39 INFO - 'LANGUAGE': 'en_US:en', 01:25:39 INFO - 'LOGNAME': 'cltbld', 01:25:39 INFO - 'MAIL': '/var/mail/cltbld', 01:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:39 INFO - 'MOZ_NO_REMOTE': '1', 01:25:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:39 INFO - 'NO_EM_RESTART': '1', 01:25:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:39 INFO - 'PWD': '/builds/slave/test', 01:25:39 INFO - 'SHELL': '/bin/bash', 01:25:39 INFO - 'SHLVL': '1', 01:25:39 INFO - 'TERM': 'linux', 01:25:39 INFO - 'TMOUT': '86400', 01:25:39 INFO - 'USER': 'cltbld', 01:25:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 01:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:39 INFO - '_': '/tools/buildbot/bin/python'} 01:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:40 INFO - Downloading/unpacking blobuploader==1.2.4 01:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:41 INFO - Downloading blobuploader-1.2.4.tar.gz 01:25:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:25:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:25:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:42 INFO - Downloading docopt-0.6.1.tar.gz 01:25:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:25:42 INFO - Installing collected packages: blobuploader, requests, docopt 01:25:42 INFO - Running setup.py install for blobuploader 01:25:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:25:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:25:42 INFO - Running setup.py install for requests 01:25:43 INFO - Running setup.py install for docopt 01:25:43 INFO - Successfully installed blobuploader requests docopt 01:25:43 INFO - Cleaning up... 01:25:43 INFO - Return code: 0 01:25:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:43 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 0x7f1a864f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a28790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a25930>, '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 0x1a26830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a26cc0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:25:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:25:43 INFO - Using env: {'DISPLAY': ':0', 01:25:43 INFO - 'HOME': '/home/cltbld', 01:25:43 INFO - 'LANG': 'en_US.UTF-8', 01:25:43 INFO - 'LANGUAGE': 'en_US:en', 01:25:43 INFO - 'LOGNAME': 'cltbld', 01:25:43 INFO - 'MAIL': '/var/mail/cltbld', 01:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:43 INFO - 'MOZ_NO_REMOTE': '1', 01:25:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:43 INFO - 'NO_EM_RESTART': '1', 01:25:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:43 INFO - 'PWD': '/builds/slave/test', 01:25:43 INFO - 'SHELL': '/bin/bash', 01:25:43 INFO - 'SHLVL': '1', 01:25:43 INFO - 'TERM': 'linux', 01:25:43 INFO - 'TMOUT': '86400', 01:25:43 INFO - 'USER': 'cltbld', 01:25:43 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 01:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:43 INFO - '_': '/tools/buildbot/bin/python'} 01:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:25:43 INFO - Running setup.py (path:/tmp/pip-vxkSWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:25:43 INFO - Running setup.py (path:/tmp/pip-jaQs1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:25:43 INFO - Running setup.py (path:/tmp/pip-ekwJMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:25:43 INFO - Running setup.py (path:/tmp/pip-yeHHhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:25:43 INFO - Running setup.py (path:/tmp/pip-KrFDOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:25:43 INFO - Running setup.py (path:/tmp/pip-rtmozI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:25:44 INFO - Running setup.py (path:/tmp/pip-09VXCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:25:44 INFO - Running setup.py (path:/tmp/pip-vj3WjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:25:44 INFO - Running setup.py (path:/tmp/pip-EzrnPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:25:44 INFO - Running setup.py (path:/tmp/pip-q0Narq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:25:44 INFO - Running setup.py (path:/tmp/pip-YcHaBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:25:44 INFO - Running setup.py (path:/tmp/pip-FdyNNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:25:44 INFO - Running setup.py (path:/tmp/pip-_woIqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:25:44 INFO - Running setup.py (path:/tmp/pip-UcGFuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:44 INFO - Running setup.py (path:/tmp/pip-r2Wlom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:25:44 INFO - Running setup.py (path:/tmp/pip-6M5xP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:25:44 INFO - Running setup.py (path:/tmp/pip-3779RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:25:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:25:44 INFO - Running setup.py install for manifestparser 01:25:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:25:44 INFO - Running setup.py install for mozcrash 01:25:45 INFO - Running setup.py install for mozdebug 01:25:45 INFO - Running setup.py install for mozdevice 01:25:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:25:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:25:45 INFO - Running setup.py install for mozfile 01:25:45 INFO - Running setup.py install for mozhttpd 01:25:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:25:45 INFO - Running setup.py install for mozinfo 01:25:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:25:45 INFO - Running setup.py install for mozInstall 01:25:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:25:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:25:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:25:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:25:45 INFO - Running setup.py install for mozleak 01:25:45 INFO - Running setup.py install for mozlog 01:25:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:25:45 INFO - Running setup.py install for moznetwork 01:25:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:25:46 INFO - Running setup.py install for mozprocess 01:25:46 INFO - Running setup.py install for mozprofile 01:25:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:25:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:25:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:25:46 INFO - Running setup.py install for mozrunner 01:25:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:25:46 INFO - Running setup.py install for mozscreenshot 01:25:46 INFO - Running setup.py install for moztest 01:25:46 INFO - Running setup.py install for mozversion 01:25:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:25:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:25:46 INFO - Cleaning up... 01:25:46 INFO - Return code: 0 01:25:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:46 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 0x7f1a864f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a28790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a25930>, '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 0x1a26830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a26cc0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:25:46 INFO - Using env: {'DISPLAY': ':0', 01:25:46 INFO - 'HOME': '/home/cltbld', 01:25:46 INFO - 'LANG': 'en_US.UTF-8', 01:25:46 INFO - 'LANGUAGE': 'en_US:en', 01:25:46 INFO - 'LOGNAME': 'cltbld', 01:25:46 INFO - 'MAIL': '/var/mail/cltbld', 01:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:46 INFO - 'MOZ_NO_REMOTE': '1', 01:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:46 INFO - 'NO_EM_RESTART': '1', 01:25:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:46 INFO - 'PWD': '/builds/slave/test', 01:25:46 INFO - 'SHELL': '/bin/bash', 01:25:46 INFO - 'SHLVL': '1', 01:25:46 INFO - 'TERM': 'linux', 01:25:46 INFO - 'TMOUT': '86400', 01:25:46 INFO - 'USER': 'cltbld', 01:25:46 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 01:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:46 INFO - '_': '/tools/buildbot/bin/python'} 01:25:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:25:46 INFO - Running setup.py (path:/tmp/pip-tUWnT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:25:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:25:46 INFO - Running setup.py (path:/tmp/pip-Nlw4bq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:25:47 INFO - Running setup.py (path:/tmp/pip-qIqZlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:25:47 INFO - Running setup.py (path:/tmp/pip-kQbz4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:25:47 INFO - Running setup.py (path:/tmp/pip-b8mU85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:25:47 INFO - Running setup.py (path:/tmp/pip-8OCe2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:25:47 INFO - Running setup.py (path:/tmp/pip-jGsBXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:25:47 INFO - Running setup.py (path:/tmp/pip-QirnpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:25:47 INFO - Running setup.py (path:/tmp/pip-mG4Y_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:25:47 INFO - Running setup.py (path:/tmp/pip-ssx72E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:25:47 INFO - Running setup.py (path:/tmp/pip-D2riyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:25:47 INFO - Running setup.py (path:/tmp/pip-tEFpI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:25:47 INFO - Running setup.py (path:/tmp/pip-jO02CQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:25:47 INFO - Running setup.py (path:/tmp/pip-IecBw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:47 INFO - Running setup.py (path:/tmp/pip-pMee55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:25:48 INFO - Running setup.py (path:/tmp/pip-nUAbQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:25:48 INFO - Running setup.py (path:/tmp/pip-IGPchP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:25:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:50 INFO - Downloading blessings-1.6.tar.gz 01:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:25:50 INFO - Installing collected packages: blessings 01:25:50 INFO - Running setup.py install for blessings 01:25:50 INFO - Successfully installed blessings 01:25:50 INFO - Cleaning up... 01:25:50 INFO - Return code: 0 01:25:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:25:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:25:50 INFO - Reading from file tmpfile_stdout 01:25:50 INFO - Current package versions: 01:25:50 INFO - argparse == 1.2.1 01:25:50 INFO - blessings == 1.6 01:25:50 INFO - blobuploader == 1.2.4 01:25:50 INFO - docopt == 0.6.1 01:25:50 INFO - functools32 == 3.2.3-2 01:25:50 INFO - jsonschema == 2.5.1 01:25:50 INFO - manifestparser == 1.1 01:25:50 INFO - mozInstall == 1.12 01:25:50 INFO - mozcrash == 0.17 01:25:50 INFO - mozdebug == 0.1 01:25:50 INFO - mozdevice == 0.48 01:25:50 INFO - mozfile == 1.2 01:25:50 INFO - mozhttpd == 0.7 01:25:50 INFO - mozinfo == 0.9 01:25:50 INFO - mozleak == 0.1 01:25:50 INFO - mozlog == 3.4 01:25:50 INFO - moznetwork == 0.27 01:25:50 INFO - mozprocess == 0.23 01:25:50 INFO - mozprofile == 0.28 01:25:50 INFO - mozrunner == 6.12 01:25:50 INFO - mozscreenshot == 0.1 01:25:50 INFO - mozsystemmonitor == 0.3 01:25:50 INFO - moztest == 0.7 01:25:50 INFO - mozversion == 1.4 01:25:50 INFO - psutil == 3.1.1 01:25:50 INFO - requests == 1.2.3 01:25:50 INFO - wsgiref == 0.1.2 01:25:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:50 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 0x7f1a864f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a28790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a25930>, '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 0x1a26830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a26cc0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:25:50 INFO - Using env: {'DISPLAY': ':0', 01:25:50 INFO - 'HOME': '/home/cltbld', 01:25:50 INFO - 'LANG': 'en_US.UTF-8', 01:25:50 INFO - 'LANGUAGE': 'en_US:en', 01:25:50 INFO - 'LOGNAME': 'cltbld', 01:25:50 INFO - 'MAIL': '/var/mail/cltbld', 01:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:50 INFO - 'MOZ_NO_REMOTE': '1', 01:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:50 INFO - 'NO_EM_RESTART': '1', 01:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:50 INFO - 'PWD': '/builds/slave/test', 01:25:50 INFO - 'SHELL': '/bin/bash', 01:25:50 INFO - 'SHLVL': '1', 01:25:50 INFO - 'TERM': 'linux', 01:25:50 INFO - 'TMOUT': '86400', 01:25:50 INFO - 'USER': 'cltbld', 01:25:50 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 01:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:50 INFO - '_': '/tools/buildbot/bin/python'} 01:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:25:50 INFO - Cleaning up... 01:25:50 INFO - Return code: 0 01:25:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:50 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 0x7f1a864f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a28790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a25930>, '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 0x1a26830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a26cc0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:25:50 INFO - Using env: {'DISPLAY': ':0', 01:25:50 INFO - 'HOME': '/home/cltbld', 01:25:50 INFO - 'LANG': 'en_US.UTF-8', 01:25:50 INFO - 'LANGUAGE': 'en_US:en', 01:25:50 INFO - 'LOGNAME': 'cltbld', 01:25:50 INFO - 'MAIL': '/var/mail/cltbld', 01:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:50 INFO - 'MOZ_NO_REMOTE': '1', 01:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:50 INFO - 'NO_EM_RESTART': '1', 01:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:50 INFO - 'PWD': '/builds/slave/test', 01:25:50 INFO - 'SHELL': '/bin/bash', 01:25:50 INFO - 'SHLVL': '1', 01:25:50 INFO - 'TERM': 'linux', 01:25:50 INFO - 'TMOUT': '86400', 01:25:50 INFO - 'USER': 'cltbld', 01:25:50 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 01:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:50 INFO - '_': '/tools/buildbot/bin/python'} 01:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:25:51 INFO - Cleaning up... 01:25:51 INFO - Return code: 0 01:25:51 INFO - Running post-action listener: _resource_record_post_action 01:25:51 INFO - Running post-action listener: _start_resource_monitoring 01:25:51 INFO - Starting resource monitoring. 01:25:51 INFO - [mozharness: 2016-11-08 09:25:51.072689Z] Finished create-virtualenv step (success) 01:25:51 INFO - [mozharness: 2016-11-08 09:25:51.073280Z] Running install step. 01:25:51 INFO - Running pre-action listener: _resource_record_pre_action 01:25:51 INFO - Running main action method: install 01:25:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:25:51 INFO - Reading from file tmpfile_stdout 01:25:51 INFO - Detecting whether we're running mozinstall >=1.0... 01:25:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:25:51 INFO - Reading from file tmpfile_stdout 01:25:51 INFO - Output received: 01:25:51 INFO - Usage: mozinstall [options] installer 01:25:51 INFO - Options: 01:25:51 INFO - -h, --help show this help message and exit 01:25:51 INFO - -d DEST, --destination=DEST 01:25:51 INFO - Directory to install application into. [default: 01:25:51 INFO - "/builds/slave/test"] 01:25:51 INFO - --app=APP Application being installed. [default: firefox] 01:25:51 INFO - mkdir: /builds/slave/test/build/application 01:25:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:26:08 INFO - Reading from file tmpfile_stdout 01:26:08 INFO - Output received: 01:26:08 INFO - /builds/slave/test/build/application/firefox/firefox 01:26:08 INFO - Running post-action listener: _resource_record_post_action 01:26:08 INFO - [mozharness: 2016-11-08 09:26:08.346620Z] Finished install step (success) 01:26:08 INFO - [mozharness: 2016-11-08 09:26:08.346953Z] Running run-tests step. 01:26:08 INFO - Running pre-action listener: _resource_record_pre_action 01:26:08 INFO - Running main action method: run_tests 01:26:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:26:08 INFO - Python 2.7.3 01:26:08 INFO - Return code: 0 01:26:08 INFO - grabbing minidump binary from tooltool 01:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:08 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 0x1a25930>, '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 0x1a26830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a26cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:26:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:26:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:26:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:26:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:26:08 INFO - Return code: 0 01:26:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:26:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:26:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:26:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:26:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:26:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:26:08 INFO - Using env: {'DISPLAY': ':0', 01:26:08 INFO - 'HOME': '/home/cltbld', 01:26:08 INFO - 'LANG': 'en_US.UTF-8', 01:26:08 INFO - 'LANGUAGE': 'en_US:en', 01:26:08 INFO - 'LOGNAME': 'cltbld', 01:26:08 INFO - 'MAIL': '/var/mail/cltbld', 01:26:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:26:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:08 INFO - 'MOZ_NO_REMOTE': '1', 01:26:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:26:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:08 INFO - 'NO_EM_RESTART': '1', 01:26:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:08 INFO - 'PWD': '/builds/slave/test', 01:26:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:26:08 INFO - 'SHELL': '/bin/bash', 01:26:08 INFO - 'SHLVL': '1', 01:26:08 INFO - 'TERM': 'linux', 01:26:08 INFO - 'TMOUT': '86400', 01:26:08 INFO - 'USER': 'cltbld', 01:26:08 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368', 01:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:08 INFO - '_': '/tools/buildbot/bin/python'} 01:26:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:26:08 INFO - mozversion application_buildid: 20161107223014 01:26:08 INFO - mozversion application_changeset: f13e90d496cf1bc6dfc4fd398da33e4afe785bde 01:26:08 INFO - mozversion application_display_name: Nightly 01:26:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:26:08 INFO - mozversion application_name: Firefox 01:26:08 INFO - mozversion application_remotingname: firefox 01:26:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:26:08 INFO - mozversion application_vendor: Mozilla 01:26:08 INFO - mozversion application_version: 52.0a1 01:26:08 INFO - mozversion platform_buildid: 20161107223014 01:26:08 INFO - mozversion platform_changeset: f13e90d496cf1bc6dfc4fd398da33e4afe785bde 01:26:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:26:08 INFO - mozversion platform_version: 52.0a1 01:26:08 INFO - using testdate: 1478597168 01:26:08 INFO - actual date: 1478597168 01:26:08 INFO - starting webserver on 'localhost:58478' 01:26:08 INFO - SUITE-START | Running 2 tests 01:26:08 INFO - TEST-START | dromaeo_css 01:26:08 INFO - operating with platform_type : linux_ 01:26:08 INFO - Initialising browser for dromaeo_css test... 01:26:08 INFO - TEST-INFO | started process 30926 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ozUaS/profile http://localhost:58478/getInfo.html) 01:26:12 INFO - PROCESS | 30926 | __metrics Screen width/height:1600/1200 01:26:12 INFO - PROCESS | 30926 | colorDepth:24 01:26:12 INFO - PROCESS | 30926 | Browser inner width/height: 1024/697 01:26:12 INFO - PROCESS | 30926 | __metrics 01:26:12 INFO - PROCESS | 30926 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:26:12 INFO - PROCESS | 30926 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:26:13 INFO - PROCESS | 30926 | console.error: PushService: 01:26:13 INFO - PROCESS | 30926 | stateChangeProcessEnqueue: Error transitioning state 01:26:13 INFO - PROCESS | 30926 | UnknownError 01:26:13 INFO - TEST-INFO | 30926: exit 0 01:26:13 INFO - Browser initialized. 01:26:13 INFO - Running cycle 1/1 for dromaeo_css test... 01:26:14 INFO - TEST-INFO | started process 31011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ozUaS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:26:26 INFO - PROCESS | 31011 | RSS: Main: 172638208 01:26:26 INFO - PROCESS | 31011 | 01:27:17 INFO - PROCESS | 31011 | 1478597237526 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:29:28 INFO - PROCESS | 31011 | Cycle 1(1): loaded http://localhost:58478/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58478/tests/dromaeo/cssquery-ext.html) 01:29:29 INFO - PROCESS | 31011 | RSS: Main: 325292032 01:29:29 INFO - PROCESS | 31011 | 01:32:32 INFO - PROCESS | 31011 | Cycle 1(1): loaded http://localhost:58478/tests/dromaeo/cssquery-ext.html (next: http://localhost:58478/tests/dromaeo/cssquery-jquery.html) 01:32:32 INFO - PROCESS | 31011 | RSS: Main: 285728768 01:32:32 INFO - PROCESS | 31011 | 01:35:34 INFO - PROCESS | 31011 | Cycle 1(1): loaded http://localhost:58478/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58478/tests/dromaeo/cssquery-mootools.html) 01:35:35 INFO - PROCESS | 31011 | RSS: Main: 217968640 01:35:35 INFO - PROCESS | 31011 | 01:38:37 INFO - PROCESS | 31011 | Cycle 1(1): loaded http://localhost:58478/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58478/tests/dromaeo/cssquery-prototype.html) 01:38:38 INFO - PROCESS | 31011 | RSS: Main: 215220224 01:38:38 INFO - PROCESS | 31011 | 01:41:41 INFO - PROCESS | 31011 | Cycle 1(1): loaded http://localhost:58478/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58478/tests/dromaeo/cssquery-yui.html) 01:41:41 INFO - PROCESS | 31011 | RSS: Main: 219041792 01:41:41 INFO - PROCESS | 31011 | 01:44:44 INFO - PROCESS | 31011 | Cycle 1(1): loaded http://localhost:58478/tests/dromaeo/cssquery-yui.html (next: http://localhost:58478/tests/dromaeo/cssquery-dojo.html) 01:44:44 INFO - PROCESS | 31011 | RSS: Main: 312913920 01:44:44 INFO - PROCESS | 31011 | 01:44:44 INFO - PROCESS | 31011 | __start_tp_report 01:44:44 INFO - PROCESS | 31011 | _x_x_mozilla_page_load 01:44:44 INFO - PROCESS | 31011 | _x_x_mozilla_page_load_details 01:44:44 INFO - PROCESS | 31011 | |i|pagename|runs| 01:44:44 INFO - PROCESS | 31011 | |0;dojo.html;3042.939141217176;3046.345035817299;3081.830499322538;3086.9073927782174;3095.489244274695;5237.947620523793;5255.973720131404;5302.840914772553;5309.177077552976;5342.477393942722;5371.248025276464;5392.78428862846;5395.946040539593;5428.891422171554;5437.456254374561;4823.228283474645;4837.371141751567;4868.099401610696;4888.853334399956;4949.579285760715;4849.127157111719;4859.295402166684;4913.606911447094;4930.260460930853;4998.425181104183;5014.047331007116;5024.723640199788;5051.267566202899;5056.544910958013;5067.341245638062;344.06409468260046;4995.100881841267;4996.700197988114;5011.523905228997;5040.96660184665;4178.435911151986;4854.635902307341;4863.27050942358;4869.318295438641;4958.157113290713;5327.866803329909;5341.4925582069645;5433.212184233304;5439.673619582838;5457.126859702468;5772.076467765138;5805.912911306334;5813.273340832396;5823.359430462646;5865.677387743673;5617.38208797032;5643.8589035274035;5685.971570142165;5769.913451298234;5776.104703770922;5316.175992721057;5318.521333080042;5321.866953326159;5323.387810401853;5329.307190065306;5903.498202652737;5946.4648181663;5954.4045595440975;5967.015442452033;5968.791092311748;5486.3690675572025;5489.286392768914;5537.723113844291;5555.611107222537;5675.460831221028;5669.971650141805;5685.459881311269;5687.687177205294;5688.06146985751;5731.083026715789;5668.348139963874;5672.262605861294;5683.204351390808;5692.516136128475;5692.800751973661;5495.065838807413;5540.445955404508;5555;5664.376918538957;5672.7730890763905;4350.390945267665;4381.9123617527475;4427.933580996288;4428.2914733642465;4431.335299705005;3916.2754890345377;3927.5286965563746;3935.704822138351;3940.8817735467983;3948.565657777642;5489.094299440628;5497.422770609109;5499.780008799683;5501.14732216507;5514.117741161475;5717.571182161355;5759.481646651738;5761.9135712964335;5762.683052432157;5763.106718458645;5427.945720542744;5454.263674403905;5455.8090466834265;5456.127019676833;5458.1266997280245;4925.916298414343;4945.826896058621;4951.356323677971;4951.702897826142;4957.380327459067;6001.819945401645;6009.609375390585;6011.128386384037;6014.548908831943;6031.668258245751;5636.464535869086;5705.971470142623;5710.114932185518;5768.2501274834;5774.8845023098465;5905.2913650360515;5923.614965027259;5927.673977931255;6072.240969878765;6105.9084113737445;5664.858378540404;5683.857903552444;5687.317521897234;5687.8862422752145;5730.713464326684;5784.21913041734;5791.247137872218;5800.274965629296;5814.273215848019;5819.447152520504;5478.780848766005;5548.167774833807;5566.053770859045;5618.241537392563;5678.006348889011;5566.693831839288;5725.570582206435;5727.513161381163;5728.369879313355;5728.942710572841;5599.832005039855;5627.155926611041;5627.465390787868;5635.887282254414;5643.181738647955;5678.119891416837;5695;5751.971240143773;5761.423857614205;5765.59640825155;5339.252504649275;5383.111786555174;5503.807366742145;5548.4174161712435;5548.861278467909 01:44:44 INFO - PROCESS | 31011 | |1;ext.html;546.4699241735515;611.4680228201465;623.7660877171061;627.0187157099142;627.0656721484986;31615.525767113482;41367.79316103419;42202.78898605503;42217.366739498895;42490.7875460623;43434.34848477275;43954.56045439545;43989.99999999992;44023.559764402344;44040.339394909024;7902.723404680837;8721.825563488726;8849.513276769776;8864.157904999014;8873.778155546099;7910.050793904739;8160.836783264331;8180.181981801832;10031.746031746032;10306.123979461754;10667.413292268922;10724.946375268113;10732.73168170794;10732.78534429311;10732.946335268312;10452.111570516516;10466.476676166161;10518.842217366746;10528.684139475828;10533.31533450331;10417.9479102604;10469.9476502617;10493.790124197474;10494.422806745626;10494.79010419795;41233;41602.79198604018;41663;41701.791491042655;41745.1650966982;3483.4600636901323;3486.3027394520946;3488.215151590897;3523;3540.6990405815536;30986.380272394425;31484.842575786974;31615.20961975969;31784.523232151536;32324.191895202574;3766.246750649881;3843.8270277837564;3969.98015009926;3972.6424621784176;3980.86066987654;335608.64391356264;337416;337682;338530.30734846415;339019;58982;59625.40374596285;59715;59808;59832.70083649554;36311;37431.4385284221;63399.68300158469;63531.682341588;63644;15361.846381536265;15937.760933586005;16037.198140092949;16040.43858464948;16047.919760401122;12099.274043557414;12313.199642023239;12337;12339.814902776465;12345.444454999546;17285;17871;18220;18766;19045.90477047606;6819.761308354283;6945.47908906834;6977.686004129826;7056;7155.284471552803;919.6735159018452;1046.2885238038207;1081.1026847716375;1085.3270971997413;1112.2881355932209;30646.69353306483;31197.376052478823;31203.687963120534;31578.526322105186;31896.521552176735;1057.7144171073767;1064.3986147826454;1074.505727365405;1129.3844854554288;1161.1523587780966;15529.534113976599;16552;17077.658446830992;17176.398826041277;17698;469065;470130;472696;473468;474316;57459.71270143706;57880.71059644675;57897;57954.420455794905;57961.710191449616;1206.90344772418;1235.6910772306924;1306.3402981494285;1347.4677502386503;1361.4213959067356;28426.57360139641;31799.68200317967;31916.36167276595;32243.35513289768;32549.674503254664;48934.75532622314;49501;49555.75222123866;49637;49648.255276170166;373350;377339;377652;378037;379035;26961.325966850985;27516;27615.86192069027;28103.57844632373;29573.408531829675;44534.77732611316;44705.55294447144;45792.77103614594;46138.538614614765;46247.53752462432;38517.229655406176;38699.41950870796;39095.609043910335;39340.213195735356;39995.80002099971;38319.80840095893;38636.80681596574;38751.78666026963;38974;39441.40837887491;38320.80839595896;39101.6089839098;39577.802110990415;39585.60414395819;39692.40461393024;32535.674643253264;34557.481637775956;34706.305873882884;35495.11262218362;35649.46525802063;26683.7331626689;26766.598501022112;26997.1900842975;27062.458750825266;27229.455410892067 01:44:44 INFO - PROCESS | 31011 | |2;jquery.html;384.9153186299013;397.2670423069438;402.9697772667051;408.29772790799825;415.9206858202962;13236;15121.697566048673;18549.072546372678;19249.23003079875;19250.61498770024;18120.194759100606;18643.906780466114;18946.905265473688;19147;19511.21955121797;5096.668716533432;5391.218273350371;5626.915596266059;5634.802781902634;5635.436456354352;5511.145772405283;5627;5647.717614119299;5654.745536450849;5658.632188907708;5316.627836051478;5578.525825304854;5616.803411880585;5625.38120806711;5630.971845140769;5661.377248502661;5735.541156707453;5742.052561327376;5743.684097374643;5744.937186620467;5350.117230656937;5564.888702225933;5566.332040155207;5653;5708.115242137475;14192.858071419258;14384;17482.15392613623;22256.332310030564;22726.431839203986;2030.3198428526462;2072.3990042887694;2217.3347995601257;2523.2556395863267;2770.6536682914634;10477.37135771856;10570.365778053265;10609.204309676728;10665.65355621762;12271.141020128594;1835.853131749457;1860.2744929477515;1878.6524492968845;1896.1846406045395;1927.1038966880467;80132.59933700295;82501;82629.76055359235;83116.58441707813;91015.7246068847;9436.339456237998;9921.900780992242;9969.40183588987;10010.49947502622;10020.09819116283;13596.320183990762;13611.387487563083;13625.454981800814;13627.318634068257;13647.317634118255;7595.354394876387;7656.808579785438;7785;7815.882761758578;7867.803304917308;7584.241575842482;7634.809129771689;7654.961725191339;7826.960865195638;7845.450818442654;4174.165166966619;4180.937285940713;4242.557530439665;4256.595623415832;4290.828366865353;1918.788933217345;1981.2075169931854;2005.7091721700272;2018.3944816554974;2053.16846677093;929.869818225449;937.3438592984802;948.6584829461389;963.0417734354222;965.2422848064236;18351.485222745734;19869.801301986794;19941.302054428317;19962.500937476678;20209.292674756314;944.8299306124826;957.9988911587408;978.8776402949632;981.8772653418323;1006.3609607899036;10674.199435042403;11051.557937682403;11075.280106793194;11086.778264434666;11087.390193539271;455901;458812;464701;467637;473748;86578.56710716407;88186.55906720426;88663.55668221618;89097;91137;982.4989255479613;997.2597816809568;999.8550210219478;1005.788784355279;1039.2725092435173;16909.492715218563;17020.893641913237;17638.38265660696;17674.823251767833;17976.640467190846;40905.59094409018;41050.79474602608;41052.38421423621;41464.79267603643;42225.577744222166;54942.450575493735;55235.44764552303;55591.44408555863;56136.43863561312;56154.43845561492;7346;7644.12092609357;7777.455578109478;7812.453128280966;7900.68397264103;10771.92493681729;12231.87768122343;12777.297248651414;12941.417636206204;13027.544035958696;11094.833577496183;11283.887161128283;11342.149338799789;11892.227005244631;12566.560170393992;10775.191860610328;11179.66461006171;11220.66338009861;11243.831342529706;11356.829647555129;11295;11362.375069371265;11554.537818487166;11778.882211177779;11828.23116497425;7873.645685944031;8024.438289319692;8030.23712747288;8087.272145506932;8192.918070819216;10769.353838769699;11493.48279327449;11515.654530364103;11544.769104617693;11725.472353744273 01:44:44 INFO - PROCESS | 31011 | |3;mootools.html;1310.0894878059753;1427.1651084115792;1455.9199244041577;1555.4555905433092;1700.4388551777922;7430.591317477537;8028.39787015974;8321.209485098914;8343.582820858963;8613.095624959384;8463.746087617366;8464.407491475598;8525.275351595123;8529.701460448885;8529.872051919227;2203.2178576605274;2232.408411770882;2233.9218127365543;2237.3847192022163;2266.2634643740766;2249.80876625487;2288.6338185890263;2330.9533809323802;2335.988320058397;2337.5909215887236;2197.213556262056;2216.92240771573;2235.16181431963;2264.4904896398343;2268.8411811173223;2172.663237198237;2174.945626359338;2196.8242540596716;2203.6914831923546;2203.713517242756;2214.490667146549;2232.0402227042364;2234.9553008939893;2236.7875051870046;2237.932862014126;8376.246137847562;8422.747317580483;8490.957545212295;8493.66025358985;8504.574771261474;4987.251912213161;5187.766550505236;5204.42751297357;5216.58267338612;5218.66078704883;3238.87044518219;3274.754393420503;3311;3363.327334533103;3367.7305815534696;1125.7523344864117;1131.5021390588197;1797.3035473619877;1880.9623807523774;2069.5653912678354;11641.126915481289;11906.702332441671;12034.939825300906;12047.759044819055;12071.336076515789;4287.528371879091;4445.599896009375;4490.550944905549;4544.091181763661;4548.204064288736;9425.811483770423;9437.292203084797;9441.055894410503;9446.149846513847;9447.449188719145;5118.283440318359;5124.846254612367;5127.8718032048755;5130.743462826918;5134.563562097189;3972.920541589152;4195.664346852305;4728.621710263171;4783.282507623815;4787.880302992453;3648.4527320901548;3689.0816775276708;3731.477593136963;3793.9241215175543;3808.4287356896134;1085.6742977106994;1105.6019832860163;1106.2366966792888;1120.966371008871;1121.7195701074731;667.6194569095666;804.8430556041633;902.8104098139333;907.8093600344001;958.5399008475971;5370.2750128732905;5539.750711218005;5585.245991791137;5715.599908006399;5790.565707571865;854.769212312672;863.1612290148955;867.3018220332567;878.4119106699752;899.8110396816742;3665.6700896918874;3755.117547376364;3767.1335592813257;3879.7090218233743;4001.919961600752;9258.814823703487;9941.701748947544;10006.599736010477;10018.949905250427;10051.849222261671;9736.95131524352;9936.850947235796;9955.751106222258;9972.650957216463;9979.900200997898;7501.249875012564;7952.324052455606;7957.721479748181;7960.920390796134;7968.12350641429;5327.6803391795065;5541.556675466034;5587.413321601173;5682.289713785777;5874.911876321773;9482.95258523703;9637.18083962871;9663.855042174233;9780.657676981271;9861.950690246504;9576.281778866474;9701.272404569827;9835.803283934425;9868.210543156387;10008;6723.697433615401;6929.722811087701;7363.15323737777;7575.848483030199;7749.186335434698;7961.800954976172;8343.290820280345;8345.749627511184;8345.916540834514;8376.958115209385;7212.783616491513;7350.852982940418;7451.850962980601;7540.283673051052;7570.205128461433;7028.121484814398;7075.6815943281645;7194;7202.855942881218;7430.96284518574;6602.471802255904;6726.865462690621;6732.394084532416;6732.697028633821;6743.393094621508;4967.82612608557;5065.620078494201;5090.872728181825;5286.656367336111;5349.625526213128;4922.261660750916;5068.417132029864;5102.826349939461;5149.9957508287025;5183.092958732283 01:44:44 INFO - PROCESS | 31011 | |4;prototype.html;326.4760060103534;337.3506000948175;340.61850727185555;343.81434025626146;343.87276707618184;5162.174052151657;5219.138842091051;5226.163813789794;5260.210968354744;5281.70950597717;5138.254953031808;5160.509751573604;5189.792408303663;5209.687418754868;5217.895642087156;3966.9008274793073;4113.444684967521;4116.917661646773;4130.339145736682;4144.917101657965;4105.753654780708;4119.4757939562405;4123.092919557707;4128.2362762888815;4140.565240649734;4085.346344584867;4087.1008378156757;4099.7745124018165;4123.814428350732;4131.876043718693;3881.3789793633023;3998.660113890323;4003.8598649047144;4057.69567282455;4100.282450571153;3651.835667394974;3653.707703383723;3656.835442405098;3666.120131168527;3670.1925576373155;5098.566621837148;5099.011385559635;5109.131447653871;5113.51421614946;5117.232415137759;4327.891802704926;4464.441944756905;4652.162610730067;4659.7204167749705;4711.175544279771;5424.647397919122;5428.96849598575;5429.782808687648;5442.619016668835;5454.61817672763;3991.860284890044;4012.6557603202964;4014.197160567898;4019.6382325590544;4026.5570787213383;5382.892342153135;5633.943660563383;5636.605437619327;5650.265465489501;5659.773609055633;3969.8809035728973;3980.949810847416;4010.63904248619;4018.9799051005143;4032.959670403317;4059.9647089991863;4060.715749897479;4071.592840715905;4073.7148399612333;4084.101497670508;4452.755098469551;4604.240300350471;4622.722636641813;4679.268670591835;4679.625629949596;5425.131978883439;5445.992491389026;5456.563474921997;5466.398696143421;5501.5323697486165;1351.6485713714308;1368.7057282684073;1375.40170026039;1375.6492094516034;1385.764420048594;906.935182847444;958.3004406783087;961.8124465729115;970.9271804614682;974.7660561465339;5079.8984020319385;5089.185730283137;5143.588512918957;5145.845624631193;5176.4047134580005;5329.866753331198;5371.543418809445;5372.435894231049;5379.300690910157;5412.296401467784;5010.348654674869;5122.334096567497;5139.897202056013;5152.278680984665;5314.946850531445;2722.441899410616;2790.4279622677304;2791.6510436195476;2855.000749737617;2897.8116422432477;5560.499555040065;5580.302462192226;5607.271054762855;5616.343178762275;5622.847316300149;5442.782288708487;5494.945050549523;5508.9724551376985;5520.834374968757;5705.91734017089;5792.710364481674;5795.985702502046;5809.564282678816;5822.282426684138;5836.649801011953;5585.720713964367;5613.494785469327;5636.4927156556105;5659.547236221175;5685.232493613309;5435.701036442875;5526.50261476469;5553.805616803393;5579.497845193952;5609.354924183608;5788.842231553622;5809.79665711715;5840.569060580185;5843.590948633555;5845.883082338244;3960.128771670228;4011.5587285399165;4050.67594592426;4051.0277533392364;4052.2098190852503;5634.915476267777;5636.915446268227;5637.633553818989;5652.7173641318595;5676.631018983753;5522.116461366162;5533.557315414677;5538.363088244742;5553.72264379187;5565.30433695788;5338.46615338463;5483.314585676791;5488.69812160335;5531.197976293495;5534.6993456538485;5433.483819037185;5442.537384322377;5446.591505637014;5460.726963651722;5465.9726701366235;5515.531179849597;5537.390887002507;5555.666660000413;5585.776568937359;5605.608606792995;5304.9920515102;5354.544863686475;5402.783888644411;5431.103867861917;5444.223446042468 01:44:44 INFO - PROCESS | 31011 | |5;yui.html;631.2866460899183;647.2556559956048;699.765578531192;761.9961900190501;781.8514482248376;12221.755564888708;12995.025373097033;13041.478340866353;13081.934590327059;13109.213447193175;12768;12897.09720319578;12901;12905.1611645243;12923.159994600344;634.517766497463;646.890028695123;741.4105785900223;750.8198032472195;753.088762597258;764.5221736414741;767.3937589304443;767.9747537038061;768.2624680306913;768.4505578511363;809.114020147937;811.7929927868415;818.2186012358213;818.382121498268;818.9631466583988;676.455453360045;689.0972825598457;790.130856058337;792.3186059988406;817.6320655704927;592.7984485275027;593.4184499190774;593.4451288045648;593.7862369546959;593.8040446652594;12191.51233950641;12249.816252756216;12253.326067066308;12253.632391028283;12260.203086799418;11549.249298795636;11627.476763545661;11792.174547781658;11915.702107447383;12227.266364018187;10434.16526677864;10491.685249442453;10658.893411065868;10660.253782235246;10724.892751072468;3572.285542891432;3574.1064733816547;3590.299891521154;3654.908627284339;3740.420234863573;60071.69964150195;60167;60428.69785651087;60462.697686511725;63720.04419933751;9253.352265341497;9291.21024712907;9405.858912116324;9553.522323883917;9555;17582;17584.208710608054;17591.12044397775;17593.560160996076;17598;7134.92865071353;7290.817729556804;7345.449091318173;7421.443391745533;7593.544387336778;4027.624802786262;4084.36692312692;4097.1191193893455;4100.835966561363;4150.501939767248;2917.766578673701;2981.7912746107563;2995.4608170529077;3012.3071693510615;3017.109952563999;546.2189069630388;549.5356423821864;562.8536580489102;566.5977156219049;572.2760707704757;614.6834380294152;636.7962252079383;643.613831700985;657.6120089147425;661.7121552124842;7637.923620763832;7807.336376407955;7917.406194535318;7918.960405197937;8347.040090389683;591.8313280715062;639.2137670665107;643.9581427207216;657.8750037492861;673.2493270003911;3757.1170774867883;3829.636184562518;3933.7246392752804;3940.389239667856;3955.268275369066;85438;90605.54697226603;92253.89350600135;92434.07565924388;95596;46930.5306946933;65277;73655;78364;78996;43034.13931721348;43093.784531077144;45644.77177614091;45957.7702111494;54388;7257.963710181415;7412.592307422928;7526.736564220445;7698.923010770045;7761.573113478587;46639;48814;48837.267440989126;48891.26663099985;49856.501434985184;68230.65884670545;69337.65331173311;69581.30418695748;69623.65188174027;70911.00879363707;9190.471708861;9502.23982081418;9517.23862091045;9539.952300238732;9654.565544550653;10527.315724477885;10577.894221057692;10746.946265268623;10764;10767.508396566736;9812.362196457207;10264.076233138754;10269.077725264962;10335.276530643083;10420;9441.716748497556;9564.66523671668;9616.182624476998;9622.51887405613;9889.3571917828;9634.13292803651;10090.747731306776;10292.948535257576;10329.380237185793;10330.535125919201;8188.50868947865;8258.339332853237;8261.793455163668;8510.74467765968;8648.740537783877;7289.781306560812;7709.113451953097;7907.288344048833;8207.580058767771;8359.122292159236 01:44:44 INFO - PROCESS | 31011 | __end_tp_report 01:44:44 INFO - PROCESS | 31011 | __start_cc_report 01:44:44 INFO - PROCESS | 31011 | _x_x_mozilla_cycle_collect,1433 01:44:44 INFO - PROCESS | 31011 | __end_cc_report 01:44:44 INFO - PROCESS | 31011 | __startTimestamp1478598284949__endTimestamp 01:44:44 INFO - PROCESS | 31011 | 01:44:44 INFO - PROCESS | 31011 | ------- Summary: start ------- 01:44:44 INFO - PROCESS | 31011 | Number of tests: 6 01:44:44 INFO - PROCESS | 31011 | 01:44:44 INFO - PROCESS | 31011 | [#0] dojo.html Cycles:165 Average:5315.25 Median:5537.72 stddev:725.72 (13.1%) stddev-sans-first:705.71 01:44:44 INFO - PROCESS | 31011 | Values: 3042.9 3046.3 3081.8 3086.9 3095.5 5237.9 5256.0 5302.8 5309.2 5342.5 5371.2 5392.8 5395.9 5428.9 5437.5 4823.2 4837.4 4868.1 4888.9 4949.6 4849.1 4859.3 4913.6 4930.3 4998.4 5014.0 5024.7 5051.3 5056.5 5067.3 344.1 4995.1 4996.7 5011.5 5041.0 4178.4 4854.6 4863.3 4869.3 4958.2 5327.9 5341.5 5433.2 5439.7 5457.1 5772.1 5805.9 5813.3 5823.4 5865.7 5617.4 5643.9 5686.0 5769.9 5776.1 5316.2 5318.5 5321.9 5323.4 5329.3 5903.5 5946.5 5954.4 5967.0 5968.8 5486.4 5489.3 5537.7 5555.6 5675.5 5670.0 5685.5 5687.7 5688.1 5731.1 5668.3 5672.3 5683.2 5692.5 5692.8 5495.1 5540.4 5555.0 5664.4 5672.8 4350.4 4381.9 4427.9 4428.3 4431.3 3916.3 3927.5 3935.7 3940.9 3948.6 5489.1 5497.4 5499.8 5501.1 5514.1 5717.6 5759.5 5761.9 5762.7 5763.1 5427.9 5454.3 5455.8 5456.1 5458.1 4925.9 4945.8 4951.4 4951.7 4957.4 6001.8 6009.6 6011.1 6014.5 6031.7 5636.5 5706.0 5710.1 5768.3 5774.9 5905.3 5923.6 5927.7 6072.2 6105.9 5664.9 5683.9 5687.3 5687.9 5730.7 5784.2 5791.2 5800.3 5814.3 5819.4 5478.8 5548.2 5566.1 5618.2 5678.0 5566.7 5725.6 5727.5 5728.4 5728.9 5599.8 5627.2 5627.5 5635.9 5643.2 5678.1 5695.0 5752.0 5761.4 5765.6 5339.3 5383.1 5503.8 5548.4 5548.9 01:44:44 INFO - PROCESS | 31011 | 01:44:44 INFO - PROCESS | 31011 | [#1] ext.html Cycles:180 Average:55813.85 Median:35572.29 stddev:105475.55 (296.5%) stddev-sans-first:105689.81 01:44:44 INFO - PROCESS | 31011 | Values: 546.5 611.5 623.8 627.0 627.1 31615.5 41367.8 42202.8 42217.4 42490.8 43434.3 43954.6 43990.0 44023.6 44040.3 7902.7 8721.8 8849.5 8864.2 8873.8 7910.1 8160.8 8180.2 10031.7 10306.1 10667.4 10724.9 10732.7 10732.8 10732.9 10452.1 10466.5 10518.8 10528.7 10533.3 10417.9 10469.9 10493.8 10494.4 10494.8 41233.0 41602.8 41663.0 41701.8 41745.2 3483.5 3486.3 3488.2 3523.0 3540.7 30986.4 31484.8 31615.2 31784.5 32324.2 3766.2 3843.8 3970.0 3972.6 3980.9 335608.6 337416.0 337682.0 338530.3 339019.0 58982.0 59625.4 59715.0 59808.0 59832.7 36311.0 37431.4 63399.7 63531.7 63644.0 15361.8 15937.8 16037.2 16040.4 16047.9 12099.3 12313.2 12337.0 12339.8 12345.4 17285.0 17871.0 18220.0 18766.0 19045.9 6819.8 6945.5 6977.7 7056.0 7155.3 919.7 1046.3 1081.1 1085.3 1112.3 30646.7 31197.4 31203.7 31578.5 31896.5 1057.7 1064.4 1074.5 1129.4 1161.2 15529.5 16552.0 17077.7 17176.4 17698.0 469065.0 470130.0 472696.0 473468.0 474316.0 57459.7 57880.7 57897.0 57954.4 57961.7 1206.9 1235.7 1306.3 1347.5 1361.4 28426.6 31799.7 31916.4 32243.4 32549.7 48934.8 49501.0 49555.8 49637.0 49648.3 373350.0 377339.0 377652.0 378037.0 379035.0 26961.3 27516.0 27615.9 28103.6 29573.4 44534.8 44705.6 45792.8 46138.5 46247.5 38517.2 38699.4 39095.6 39340.2 39995.8 38319.8 38636.8 38751.8 38974.0 39441.4 38320.8 39101.6 39577.8 39585.6 39692.4 32535.7 34557.5 34706.3 35495.1 35649.5 26683.7 26766.6 26997.2 27062.5 27229.5 01:44:44 INFO - PROCESS | 31011 | 01:44:44 INFO - PROCESS | 31011 | [#2] jquery.html Cycles:180 Average:27817.00 Median:41051.59 stddev:76713.45 (186.9%) stddev-sans-first:76901.00 01:44:44 INFO - PROCESS | 31011 | Values: 384.9 397.3 403.0 408.3 415.9 13236.0 15121.7 18549.1 19249.2 19250.6 18120.2 18643.9 18946.9 19147.0 19511.2 5096.7 5391.2 5626.9 5634.8 5635.4 5511.1 5627.0 5647.7 5654.7 5658.6 5316.6 5578.5 5616.8 5625.4 5631.0 5661.4 5735.5 5742.1 5743.7 5744.9 5350.1 5564.9 5566.3 5653.0 5708.1 14192.9 14384.0 17482.2 22256.3 22726.4 2030.3 2072.4 2217.3 2523.3 2770.7 10477.4 10570.4 10609.2 10665.7 12271.1 1835.9 1860.3 1878.7 1896.2 1927.1 80132.6 82501.0 82629.8 83116.6 91015.7 9436.3 9921.9 9969.4 10010.5 10020.1 13596.3 13611.4 13625.5 13627.3 13647.3 7595.4 7656.8 7785.0 7815.9 7867.8 7584.2 7634.8 7655.0 7827.0 7845.5 4174.2 4180.9 4242.6 4256.6 4290.8 1918.8 1981.2 2005.7 2018.4 2053.2 929.9 937.3 948.7 963.0 965.2 18351.5 19869.8 19941.3 19962.5 20209.3 944.8 958.0 978.9 981.9 1006.4 10674.2 11051.6 11075.3 11086.8 11087.4 455901.0 458812.0 464701.0 467637.0 473748.0 86578.6 88186.6 88663.6 89097.0 91137.0 982.5 997.3 999.9 1005.8 1039.3 16909.5 17020.9 17638.4 17674.8 17976.6 40905.6 41050.8 41052.4 41464.8 42225.6 54942.5 55235.4 55591.4 56136.4 56154.4 7346.0 7644.1 7777.5 7812.5 7900.7 10771.9 12231.9 12777.3 12941.4 13027.5 11094.8 11283.9 11342.1 11892.2 12566.6 10775.2 11179.7 11220.7 11243.8 11356.8 11295.0 11362.4 11554.5 11778.9 11828.2 7873.6 8024.4 8030.2 8087.3 8192.9 10769.4 11493.5 11515.7 11544.8 11725.5 01:44:44 INFO - PROCESS | 31011 | 01:44:44 INFO - PROCESS | 31011 | [#3] mootools.html Cycles:180 Average:5531.70 Median:5217.62 stddev:3089.92 (59.2%) stddev-sans-first:3082.30 01:44:44 INFO - PROCESS | 31011 | Values: 1310.1 1427.2 1455.9 1555.5 1700.4 7430.6 8028.4 8321.2 8343.6 8613.1 8463.7 8464.4 8525.3 8529.7 8529.9 2203.2 2232.4 2233.9 2237.4 2266.3 2249.8 2288.6 2331.0 2336.0 2337.6 2197.2 2216.9 2235.2 2264.5 2268.8 2172.7 2174.9 2196.8 2203.7 2203.7 2214.5 2232.0 2235.0 2236.8 2237.9 8376.2 8422.7 8491.0 8493.7 8504.6 4987.3 5187.8 5204.4 5216.6 5218.7 3238.9 3274.8 3311.0 3363.3 3367.7 1125.8 1131.5 1797.3 1881.0 2069.6 11641.1 11906.7 12034.9 12047.8 12071.3 4287.5 4445.6 4490.6 4544.1 4548.2 9425.8 9437.3 9441.1 9446.1 9447.4 5118.3 5124.8 5127.9 5130.7 5134.6 3972.9 4195.7 4728.6 4783.3 4787.9 3648.5 3689.1 3731.5 3793.9 3808.4 1085.7 1105.6 1106.2 1121.0 1121.7 667.6 804.8 902.8 907.8 958.5 5370.3 5539.8 5585.2 5715.6 5790.6 854.8 863.2 867.3 878.4 899.8 3665.7 3755.1 3767.1 3879.7 4001.9 9258.8 9941.7 10006.6 10018.9 10051.8 9737.0 9936.9 9955.8 9972.7 9979.9 7501.2 7952.3 7957.7 7960.9 7968.1 5327.7 5541.6 5587.4 5682.3 5874.9 9483.0 9637.2 9663.9 9780.7 9862.0 9576.3 9701.3 9835.8 9868.2 10008.0 6723.7 6929.7 7363.2 7575.8 7749.2 7961.8 8343.3 8345.7 8345.9 8377.0 7212.8 7350.9 7451.9 7540.3 7570.2 7028.1 7075.7 7194.0 7202.9 7431.0 6602.5 6726.9 6732.4 6732.7 6743.4 4967.8 5065.6 5090.9 5286.7 5349.6 4922.3 5068.4 5102.8 5150.0 5183.1 01:44:44 INFO - PROCESS | 31011 | 01:44:44 INFO - PROCESS | 31011 | [#4] prototype.html Cycles:180 Average:4594.86 Median:5222.65 stddev:1345.88 (25.8%) stddev-sans-first:1310.97 01:44:44 INFO - PROCESS | 31011 | Values: 326.5 337.4 340.6 343.8 343.9 5162.2 5219.1 5226.2 5260.2 5281.7 5138.3 5160.5 5189.8 5209.7 5217.9 3966.9 4113.4 4116.9 4130.3 4144.9 4105.8 4119.5 4123.1 4128.2 4140.6 4085.3 4087.1 4099.8 4123.8 4131.9 3881.4 3998.7 4003.9 4057.7 4100.3 3651.8 3653.7 3656.8 3666.1 3670.2 5098.6 5099.0 5109.1 5113.5 5117.2 4327.9 4464.4 4652.2 4659.7 4711.2 5424.6 5429.0 5429.8 5442.6 5454.6 3991.9 4012.7 4014.2 4019.6 4026.6 5382.9 5633.9 5636.6 5650.3 5659.8 3969.9 3980.9 4010.6 4019.0 4033.0 4060.0 4060.7 4071.6 4073.7 4084.1 4452.8 4604.2 4622.7 4679.3 4679.6 5425.1 5446.0 5456.6 5466.4 5501.5 1351.6 1368.7 1375.4 1375.6 1385.8 906.9 958.3 961.8 970.9 974.8 5079.9 5089.2 5143.6 5145.8 5176.4 5329.9 5371.5 5372.4 5379.3 5412.3 5010.3 5122.3 5139.9 5152.3 5314.9 2722.4 2790.4 2791.7 2855.0 2897.8 5560.5 5580.3 5607.3 5616.3 5622.8 5442.8 5494.9 5509.0 5520.8 5705.9 5792.7 5796.0 5809.6 5822.3 5836.6 5585.7 5613.5 5636.5 5659.5 5685.2 5435.7 5526.5 5553.8 5579.5 5609.4 5788.8 5809.8 5840.6 5843.6 5845.9 3960.1 4011.6 4050.7 4051.0 4052.2 5634.9 5636.9 5637.6 5652.7 5676.6 5522.1 5533.6 5538.4 5553.7 5565.3 5338.5 5483.3 5488.7 5531.2 5534.7 5433.5 5442.5 5446.6 5460.7 5466.0 5515.5 5537.4 5555.7 5585.8 5605.6 5305.0 5354.5 5402.8 5431.1 5444.2 01:44:44 INFO - PROCESS | 31011 | 01:44:44 INFO - PROCESS | 31011 | [#5] yui.html Cycles:180 Average:16190.80 Median:632.90 stddev:22946.17 (3625.5%) stddev-sans-first:22980.79 01:44:44 INFO - PROCESS | 31011 | Values: 631.3 647.3 699.8 762.0 781.9 12221.8 12995.0 13041.5 13081.9 13109.2 12768.0 12897.1 12901.0 12905.2 12923.2 634.5 646.9 741.4 750.8 753.1 764.5 767.4 768.0 768.3 768.5 809.1 811.8 818.2 818.4 819.0 676.5 689.1 790.1 792.3 817.6 592.8 593.4 593.4 593.8 593.8 12191.5 12249.8 12253.3 12253.6 12260.2 11549.2 11627.5 11792.2 11915.7 12227.3 10434.2 10491.7 10658.9 10660.3 10724.9 3572.3 3574.1 3590.3 3654.9 3740.4 60071.7 60167.0 60428.7 60462.7 63720.0 9253.4 9291.2 9405.9 9553.5 9555.0 17582.0 17584.2 17591.1 17593.6 17598.0 7134.9 7290.8 7345.4 7421.4 7593.5 4027.6 4084.4 4097.1 4100.8 4150.5 2917.8 2981.8 2995.5 3012.3 3017.1 546.2 549.5 562.9 566.6 572.3 614.7 636.8 643.6 657.6 661.7 7637.9 7807.3 7917.4 7919.0 8347.0 591.8 639.2 644.0 657.9 673.2 3757.1 3829.6 3933.7 3940.4 3955.3 85438.0 90605.5 92253.9 92434.1 95596.0 46930.5 65277.0 73655.0 78364.0 78996.0 43034.1 43093.8 45644.8 45957.8 54388.0 7258.0 7412.6 7526.7 7698.9 7761.6 46639.0 48814.0 48837.3 48891.3 49856.5 68230.7 69337.7 69581.3 69623.7 70911.0 9190.5 9502.2 9517.2 9540.0 9654.6 10527.3 10577.9 10746.9 10764.0 10767.5 9812.4 10264.1 10269.1 10335.3 10420.0 9441.7 9564.7 9616.2 9622.5 9889.4 9634.1 10090.7 10292.9 10329.4 10330.5 8188.5 8258.3 8261.8 8510.7 8648.7 7289.8 7709.1 7907.3 8207.6 8359.1 01:44:44 INFO - PROCESS | 31011 | -------- Summary: end -------- 01:44:44 INFO - PROCESS | 31011 | 01:44:45 INFO - TEST-INFO | 31011: exit 0 01:44:45 INFO - TEST-OK | dromaeo_css | took 1117343ms 01:44:45 INFO - TEST-START | kraken 01:44:45 INFO - operating with platform_type : linux_ 01:44:45 INFO - Initialising browser for kraken test... 01:44:45 INFO - TEST-INFO | started process 31321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYqfvgy/profile http://localhost:58478/getInfo.html) 01:44:49 INFO - PROCESS | 31321 | __metrics Screen width/height:1600/1200 01:44:49 INFO - PROCESS | 31321 | colorDepth:24 01:44:49 INFO - PROCESS | 31321 | Browser inner width/height: 1024/697 01:44:49 INFO - PROCESS | 31321 | __metrics 01:44:50 INFO - PROCESS | 31321 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:44:50 INFO - PROCESS | 31321 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:44:50 INFO - PROCESS | 31321 | console.error: PushService: 01:44:50 INFO - PROCESS | 31321 | stateChangeProcessEnqueue: Error transitioning state 01:44:50 INFO - PROCESS | 31321 | UnknownError 01:44:51 INFO - TEST-INFO | 31321: exit 0 01:44:51 INFO - Browser initialized. 01:44:51 INFO - Running cycle 1/1 for kraken test... 01:44:51 INFO - TEST-INFO | started process 31405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYqfvgy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:45:03 INFO - PROCESS | 31405 | RSS: Main: 172920832 01:45:03 INFO - PROCESS | 31405 | 01:45:06 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58478/tests/kraken/driver.html?testName=audio-beat-detection) 01:45:06 INFO - PROCESS | 31405 | RSS: Main: 229625856 01:45:06 INFO - PROCESS | 31405 | 01:45:09 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58478/tests/kraken/driver.html?testName=audio-dft) 01:45:10 INFO - PROCESS | 31405 | RSS: Main: 216248320 01:45:10 INFO - PROCESS | 31405 | 01:45:13 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58478/tests/kraken/driver.html?testName=audio-fft) 01:45:14 INFO - PROCESS | 31405 | RSS: Main: 297213952 01:45:14 INFO - PROCESS | 31405 | 01:45:16 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58478/tests/kraken/driver.html?testName=audio-oscillator) 01:45:16 INFO - PROCESS | 31405 | RSS: Main: 208838656 01:45:16 INFO - PROCESS | 31405 | 01:45:18 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58478/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:45:19 INFO - PROCESS | 31405 | RSS: Main: 213159936 01:45:19 INFO - PROCESS | 31405 | 01:45:22 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58478/tests/kraken/driver.html?testName=imaging-darkroom) 01:45:23 INFO - PROCESS | 31405 | RSS: Main: 247758848 01:45:23 INFO - PROCESS | 31405 | 01:45:26 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58478/tests/kraken/driver.html?testName=imaging-desaturate) 01:45:27 INFO - PROCESS | 31405 | RSS: Main: 247341056 01:45:27 INFO - PROCESS | 31405 | 01:45:29 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58478/tests/kraken/driver.html?testName=json-parse-financial) 01:45:30 INFO - PROCESS | 31405 | RSS: Main: 246702080 01:45:30 INFO - PROCESS | 31405 | 01:45:31 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58478/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:45:32 INFO - PROCESS | 31405 | RSS: Main: 208912384 01:45:32 INFO - PROCESS | 31405 | 01:45:34 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58478/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:45:34 INFO - PROCESS | 31405 | RSS: Main: 216195072 01:45:34 INFO - PROCESS | 31405 | 01:45:36 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58478/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:45:37 INFO - PROCESS | 31405 | RSS: Main: 225501184 01:45:37 INFO - PROCESS | 31405 | 01:45:40 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58478/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:45:40 INFO - PROCESS | 31405 | RSS: Main: 234024960 01:45:40 INFO - PROCESS | 31405 | 01:45:43 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58478/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:45:44 INFO - PROCESS | 31405 | RSS: Main: 231903232 01:45:44 INFO - PROCESS | 31405 | 01:45:45 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58478/tests/kraken/driver.html?testName=ai-astar) 01:45:46 INFO - PROCESS | 31405 | RSS: Main: 281706496 01:45:46 INFO - PROCESS | 31405 | 01:45:46 INFO - PROCESS | 31405 | __start_tp_report 01:45:46 INFO - PROCESS | 31405 | _x_x_mozilla_page_load 01:45:46 INFO - PROCESS | 31405 | _x_x_mozilla_page_load_details 01:45:46 INFO - PROCESS | 31405 | |i|pagename|runs| 01:45:46 INFO - PROCESS | 31405 | |0;ai-astar;108;115;116;114;115;114;115;115;114;114 01:45:46 INFO - PROCESS | 31405 | |1;audio-beat-detection;146;123;126;165;122;125;124;121;160;123 01:45:46 INFO - PROCESS | 31405 | |2;audio-dft;162;162;162;161;161;161;161;162;161;162 01:45:46 INFO - PROCESS | 31405 | |3;audio-fft;75;76;76;109;78;76;75;76;98;76 01:45:46 INFO - PROCESS | 31405 | |4;audio-oscillator;83;85;118;85;84;83;100;83;84;121 01:45:46 INFO - PROCESS | 31405 | |5;imaging-gaussian-blur;117;117;118;118;117;118;119;118;118;118 01:45:46 INFO - PROCESS | 31405 | |6;imaging-darkroom;147;146;146;146;147;146;145;147;147;146 01:45:46 INFO - PROCESS | 31405 | |7;imaging-desaturate;85;85;85;85;85;85;86;85;85;85 01:45:46 INFO - PROCESS | 31405 | |8;json-parse-financial;55;55;53;54;54;55;54;55;53;53 01:45:46 INFO - PROCESS | 31405 | |9;json-stringify-tinderbox;63;63;62;62;62;62;62;62;62;63 01:45:46 INFO - PROCESS | 31405 | |10;stanford-crypto-aes;79;80;80;83;80;86;80;80;82;79 01:45:46 INFO - PROCESS | 31405 | |11;stanford-crypto-ccm;138;153;129;130;139;140;132;129;181;136 01:45:46 INFO - PROCESS | 31405 | |12;stanford-crypto-pbkdf2;169;166;163;164;165;165;167;168;169;168 01:45:46 INFO - PROCESS | 31405 | |13;stanford-crypto-sha256-iterative;65;65;65;65;64;65;66;70;63;63 01:45:46 INFO - PROCESS | 31405 | __end_tp_report 01:45:46 INFO - PROCESS | 31405 | __start_cc_report 01:45:46 INFO - PROCESS | 31405 | _x_x_mozilla_cycle_collect,1679 01:45:46 INFO - PROCESS | 31405 | __end_cc_report 01:45:46 INFO - PROCESS | 31405 | __startTimestamp1478598346191__endTimestamp 01:45:46 INFO - PROCESS | 31405 | 01:45:46 INFO - PROCESS | 31405 | ------- Summary: start ------- 01:45:46 INFO - PROCESS | 31405 | Number of tests: 14 01:45:46 INFO - PROCESS | 31405 | 01:45:46 INFO - PROCESS | 31405 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:2.21 (1.9%) stddev-sans-first:0.71 01:45:46 INFO - PROCESS | 31405 | Values: 108.0 115.0 116.0 114.0 115.0 114.0 115.0 115.0 114.0 114.0 01:45:46 INFO - PROCESS | 31405 | 01:45:46 INFO - PROCESS | 31405 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:125.50 stddev:16.93 (13.5%) stddev-sans-first:17.34 01:45:46 INFO - PROCESS | 31405 | Values: 146.0 123.0 126.0 165.0 122.0 125.0 124.0 121.0 160.0 123.0 01:45:46 INFO - PROCESS | 31405 | 01:45:46 INFO - PROCESS | 31405 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 01:45:46 INFO - PROCESS | 31405 | Values: 162.0 162.0 162.0 161.0 161.0 161.0 161.0 162.0 161.0 162.0 01:45:46 INFO - PROCESS | 31405 | 01:45:46 INFO - PROCESS | 31405 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:11.91 (15.7%) stddev-sans-first:12.40 01:45:46 INFO - PROCESS | 31405 | Values: 75.0 76.0 76.0 109.0 78.0 76.0 75.0 76.0 98.0 76.0 01:45:46 INFO - PROCESS | 31405 | 01:45:46 INFO - PROCESS | 31405 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:83.50 stddev:15.08 (18.1%) stddev-sans-first:15.59 01:45:46 INFO - PROCESS | 31405 | Values: 83.0 85.0 118.0 85.0 84.0 83.0 100.0 83.0 84.0 121.0 01:45:46 INFO - PROCESS | 31405 | 01:45:46 INFO - PROCESS | 31405 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 01:45:46 INFO - PROCESS | 31405 | Values: 117.0 117.0 118.0 118.0 117.0 118.0 119.0 118.0 118.0 118.0 01:45:46 INFO - PROCESS | 31405 | 01:45:46 INFO - PROCESS | 31405 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 01:45:46 INFO - PROCESS | 31405 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 145.0 147.0 147.0 146.0 01:45:46 INFO - PROCESS | 31405 | 01:45:46 INFO - PROCESS | 31405 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 01:45:46 INFO - PROCESS | 31405 | Values: 85.0 85.0 85.0 85.0 85.0 85.0 86.0 85.0 85.0 85.0 01:45:46 INFO - PROCESS | 31405 | 01:45:46 INFO - PROCESS | 31405 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.50 stddev:0.88 (1.6%) stddev-sans-first:0.87 01:45:46 INFO - PROCESS | 31405 | Values: 55.0 55.0 53.0 54.0 54.0 55.0 54.0 55.0 53.0 53.0 01:45:46 INFO - PROCESS | 31405 | 01:45:46 INFO - PROCESS | 31405 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 01:45:46 INFO - PROCESS | 31405 | Values: 63.0 63.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 63.0 01:45:46 INFO - PROCESS | 31405 | 01:45:46 INFO - PROCESS | 31405 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.00 stddev:2.18 (2.7%) stddev-sans-first:2.20 01:45:46 INFO - PROCESS | 31405 | Values: 79.0 80.0 80.0 83.0 80.0 86.0 80.0 80.0 82.0 79.0 01:45:46 INFO - PROCESS | 31405 | 01:45:46 INFO - PROCESS | 31405 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:138.50 stddev:15.89 (11.5%) stddev-sans-first:16.82 01:45:46 INFO - PROCESS | 31405 | Values: 138.0 153.0 129.0 130.0 139.0 140.0 132.0 129.0 181.0 136.0 01:45:46 INFO - PROCESS | 31405 | 01:45:46 INFO - PROCESS | 31405 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:167.50 stddev:2.12 (1.3%) stddev-sans-first:2.03 01:45:46 INFO - PROCESS | 31405 | Values: 169.0 166.0 163.0 164.0 165.0 165.0 167.0 168.0 169.0 168.0 01:45:46 INFO - PROCESS | 31405 | 01:45:46 INFO - PROCESS | 31405 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:1.97 (3.0%) stddev-sans-first:2.09 01:45:46 INFO - PROCESS | 31405 | Values: 65.0 65.0 65.0 65.0 64.0 65.0 66.0 70.0 63.0 63.0 01:45:46 INFO - PROCESS | 31405 | -------- Summary: end -------- 01:45:46 INFO - PROCESS | 31405 | 01:45:47 INFO - TEST-INFO | 31405: exit 0 01:45:47 INFO - TEST-OK | kraken | took 61538ms 01:45:47 INFO - SUITE-END | took 1178s 01:45:47 INFO - Completed test suite (00:19:39) 01:45:47 INFO - javascript benchmark 01:45:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3042.939141217176, 3046.345035817299, 3081.830499322538, 3086.9073927782174, 3095.489244274695, 5237.947620523793, 5255.973720131404, 5302.840914772553, 5309.177077552976, 5342.477393942722, 5371.248025276464, 5392.78428862846, 5395.946040539593, 5428.891422171554, 5437.456254374561, 4823.228283474645, 4837.371141751567, 4868.099401610696, 4888.853334399956, 4949.579285760715, 4849.127157111719, 4859.295402166684, 4913.606911447094, 4930.260460930853, 4998.425181104183, 5014.047331007116, 5024.723640199788, 5051.267566202899, 5056.544910958013, 5067.341245638062, 344.06409468260046, 4995.100881841267, 4996.700197988114, 5011.523905228997, 5040.96660184665, 4178.435911151986, 4854.635902307341, 4863.27050942358, 4869.318295438641, 4958.157113290713, 5327.866803329909, 5341.4925582069645, 5433.212184233304, 5439.673619582838, 5457.126859702468, 5772.076467765138, 5805.912911306334, 5813.273340832396, 5823.359430462646, 5865.677387743673, 5617.38208797032, 5643.8589035274035, 5685.971570142165, 5769.913451298234, 5776.104703770922, 5316.175992721057, 5318.521333080042, 5321.866953326159, 5323.387810401853, 5329.307190065306, 5903.498202652737, 5946.4648181663, 5954.4045595440975, 5967.015442452033, 5968.791092311748, 5486.3690675572025, 5489.286392768914, 5537.723113844291, 5555.611107222537, 5675.460831221028, 5669.971650141805, 5685.459881311269, 5687.687177205294, 5688.06146985751, 5731.083026715789, 5668.348139963874, 5672.262605861294, 5683.204351390808, 5692.516136128475, 5692.800751973661, 5495.065838807413, 5540.445955404508, 5555.0, 5664.376918538957, 5672.7730890763905, 4350.390945267665, 4381.9123617527475, 4427.933580996288, 4428.2914733642465, 4431.335299705005, 3916.2754890345377, 3927.5286965563746, 3935.704822138351, 3940.8817735467983, 3948.565657777642, 5489.094299440628, 5497.422770609109, 5499.780008799683, 5501.14732216507, 5514.117741161475, 5717.571182161355, 5759.481646651738, 5761.9135712964335, 5762.683052432157, 5763.106718458645, 5427.945720542744, 5454.263674403905, 5455.8090466834265, 5456.127019676833, 5458.1266997280245, 4925.916298414343, 4945.826896058621, 4951.356323677971, 4951.702897826142, 4957.380327459067, 6001.819945401645, 6009.609375390585, 6011.128386384037, 6014.548908831943, 6031.668258245751, 5636.464535869086, 5705.971470142623, 5710.114932185518, 5768.2501274834, 5774.8845023098465, 5905.2913650360515, 5923.614965027259, 5927.673977931255, 6072.240969878765, 6105.9084113737445, 5664.858378540404, 5683.857903552444, 5687.317521897234, 5687.8862422752145, 5730.713464326684, 5784.21913041734, 5791.247137872218, 5800.274965629296, 5814.273215848019, 5819.447152520504, 5478.780848766005, 5548.167774833807, 5566.053770859045, 5618.241537392563, 5678.006348889011, 5566.693831839288, 5725.570582206435, 5727.513161381163, 5728.369879313355, 5728.942710572841, 5599.832005039855, 5627.155926611041, 5627.465390787868, 5635.887282254414, 5643.181738647955, 5678.119891416837, 5695.0, 5751.971240143773, 5761.423857614205, 5765.59640825155, 5339.252504649275, 5383.111786555174, 5503.807366742145, 5548.4174161712435, 5548.861278467909], "value": 5268.6616734880645, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.4699241735515, 611.4680228201465, 623.7660877171061, 627.0187157099142, 627.0656721484986, 31615.525767113482, 41367.79316103419, 42202.78898605503, 42217.366739498895, 42490.7875460623, 43434.34848477275, 43954.56045439545, 43989.99999999992, 44023.559764402344, 44040.339394909024, 7902.723404680837, 8721.825563488726, 8849.513276769776, 8864.157904999014, 8873.778155546099, 7910.050793904739, 8160.836783264331, 8180.181981801832, 10031.746031746032, 10306.123979461754, 10667.413292268922, 10724.946375268113, 10732.73168170794, 10732.78534429311, 10732.946335268312, 10452.111570516516, 10466.476676166161, 10518.842217366746, 10528.684139475828, 10533.31533450331, 10417.9479102604, 10469.9476502617, 10493.790124197474, 10494.422806745626, 10494.79010419795, 41233.0, 41602.79198604018, 41663.0, 41701.791491042655, 41745.1650966982, 3483.4600636901323, 3486.3027394520946, 3488.215151590897, 3523.0, 3540.6990405815536, 30986.380272394425, 31484.842575786974, 31615.20961975969, 31784.523232151536, 32324.191895202574, 3766.246750649881, 3843.8270277837564, 3969.98015009926, 3972.6424621784176, 3980.86066987654, 335608.64391356264, 337416.0, 337682.0, 338530.30734846415, 339019.0, 58982.0, 59625.40374596285, 59715.0, 59808.0, 59832.70083649554, 36311.0, 37431.4385284221, 63399.68300158469, 63531.682341588, 63644.0, 15361.846381536265, 15937.760933586005, 16037.198140092949, 16040.43858464948, 16047.919760401122, 12099.274043557414, 12313.199642023239, 12337.0, 12339.814902776465, 12345.444454999546, 17285.0, 17871.0, 18220.0, 18766.0, 19045.90477047606, 6819.761308354283, 6945.47908906834, 6977.686004129826, 7056.0, 7155.284471552803, 919.6735159018452, 1046.2885238038207, 1081.1026847716375, 1085.3270971997413, 1112.2881355932209, 30646.69353306483, 31197.376052478823, 31203.687963120534, 31578.526322105186, 31896.521552176735, 1057.7144171073767, 1064.3986147826454, 1074.505727365405, 1129.3844854554288, 1161.1523587780966, 15529.534113976599, 16552.0, 17077.658446830992, 17176.398826041277, 17698.0, 469065.0, 470130.0, 472696.0, 473468.0, 474316.0, 57459.71270143706, 57880.71059644675, 57897.0, 57954.420455794905, 57961.710191449616, 1206.90344772418, 1235.6910772306924, 1306.3402981494285, 1347.4677502386503, 1361.4213959067356, 28426.57360139641, 31799.68200317967, 31916.36167276595, 32243.35513289768, 32549.674503254664, 48934.75532622314, 49501.0, 49555.75222123866, 49637.0, 49648.255276170166, 373350.0, 377339.0, 377652.0, 378037.0, 379035.0, 26961.325966850985, 27516.0, 27615.86192069027, 28103.57844632373, 29573.408531829675, 44534.77732611316, 44705.55294447144, 45792.77103614594, 46138.538614614765, 46247.53752462432, 38517.229655406176, 38699.41950870796, 39095.609043910335, 39340.213195735356, 39995.80002099971, 38319.80840095893, 38636.80681596574, 38751.78666026963, 38974.0, 39441.40837887491, 38320.80839595896, 39101.6089839098, 39577.802110990415, 39585.60414395819, 39692.40461393024, 32535.674643253264, 34557.481637775956, 34706.305873882884, 35495.11262218362, 35649.46525802063, 26683.7331626689, 26766.598501022112, 26997.1900842975, 27062.458750825266, 27229.455410892067], "value": 19714.2807023641, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.9153186299013, 397.2670423069438, 402.9697772667051, 408.29772790799825, 415.9206858202962, 13236.0, 15121.697566048673, 18549.072546372678, 19249.23003079875, 19250.61498770024, 18120.194759100606, 18643.906780466114, 18946.905265473688, 19147.0, 19511.21955121797, 5096.668716533432, 5391.218273350371, 5626.915596266059, 5634.802781902634, 5635.436456354352, 5511.145772405283, 5627.0, 5647.717614119299, 5654.745536450849, 5658.632188907708, 5316.627836051478, 5578.525825304854, 5616.803411880585, 5625.38120806711, 5630.971845140769, 5661.377248502661, 5735.541156707453, 5742.052561327376, 5743.684097374643, 5744.937186620467, 5350.117230656937, 5564.888702225933, 5566.332040155207, 5653.0, 5708.115242137475, 14192.858071419258, 14384.0, 17482.15392613623, 22256.332310030564, 22726.431839203986, 2030.3198428526462, 2072.3990042887694, 2217.3347995601257, 2523.2556395863267, 2770.6536682914634, 10477.37135771856, 10570.365778053265, 10609.204309676728, 10665.65355621762, 12271.141020128594, 1835.853131749457, 1860.2744929477515, 1878.6524492968845, 1896.1846406045395, 1927.1038966880467, 80132.59933700295, 82501.0, 82629.76055359235, 83116.58441707813, 91015.7246068847, 9436.339456237998, 9921.900780992242, 9969.40183588987, 10010.49947502622, 10020.09819116283, 13596.320183990762, 13611.387487563083, 13625.454981800814, 13627.318634068257, 13647.317634118255, 7595.354394876387, 7656.808579785438, 7785.0, 7815.882761758578, 7867.803304917308, 7584.241575842482, 7634.809129771689, 7654.961725191339, 7826.960865195638, 7845.450818442654, 4174.165166966619, 4180.937285940713, 4242.557530439665, 4256.595623415832, 4290.828366865353, 1918.788933217345, 1981.2075169931854, 2005.7091721700272, 2018.3944816554974, 2053.16846677093, 929.869818225449, 937.3438592984802, 948.6584829461389, 963.0417734354222, 965.2422848064236, 18351.485222745734, 19869.801301986794, 19941.302054428317, 19962.500937476678, 20209.292674756314, 944.8299306124826, 957.9988911587408, 978.8776402949632, 981.8772653418323, 1006.3609607899036, 10674.199435042403, 11051.557937682403, 11075.280106793194, 11086.778264434666, 11087.390193539271, 455901.0, 458812.0, 464701.0, 467637.0, 473748.0, 86578.56710716407, 88186.55906720426, 88663.55668221618, 89097.0, 91137.0, 982.4989255479613, 997.2597816809568, 999.8550210219478, 1005.788784355279, 1039.2725092435173, 16909.492715218563, 17020.893641913237, 17638.38265660696, 17674.823251767833, 17976.640467190846, 40905.59094409018, 41050.79474602608, 41052.38421423621, 41464.79267603643, 42225.577744222166, 54942.450575493735, 55235.44764552303, 55591.44408555863, 56136.43863561312, 56154.43845561492, 7346.0, 7644.12092609357, 7777.455578109478, 7812.453128280966, 7900.68397264103, 10771.92493681729, 12231.87768122343, 12777.297248651414, 12941.417636206204, 13027.544035958696, 11094.833577496183, 11283.887161128283, 11342.149338799789, 11892.227005244631, 12566.560170393992, 10775.191860610328, 11179.66461006171, 11220.66338009861, 11243.831342529706, 11356.829647555129, 11295.0, 11362.375069371265, 11554.537818487166, 11778.882211177779, 11828.23116497425, 7873.645685944031, 8024.438289319692, 8030.23712747288, 8087.272145506932, 8192.918070819216, 10769.353838769699, 11493.48279327449, 11515.654530364103, 11544.769104617693, 11725.472353744273], "value": 8902.32666070217, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.0894878059753, 1427.1651084115792, 1455.9199244041577, 1555.4555905433092, 1700.4388551777922, 7430.591317477537, 8028.39787015974, 8321.209485098914, 8343.582820858963, 8613.095624959384, 8463.746087617366, 8464.407491475598, 8525.275351595123, 8529.701460448885, 8529.872051919227, 2203.2178576605274, 2232.408411770882, 2233.9218127365543, 2237.3847192022163, 2266.2634643740766, 2249.80876625487, 2288.6338185890263, 2330.9533809323802, 2335.988320058397, 2337.5909215887236, 2197.213556262056, 2216.92240771573, 2235.16181431963, 2264.4904896398343, 2268.8411811173223, 2172.663237198237, 2174.945626359338, 2196.8242540596716, 2203.6914831923546, 2203.713517242756, 2214.490667146549, 2232.0402227042364, 2234.9553008939893, 2236.7875051870046, 2237.932862014126, 8376.246137847562, 8422.747317580483, 8490.957545212295, 8493.66025358985, 8504.574771261474, 4987.251912213161, 5187.766550505236, 5204.42751297357, 5216.58267338612, 5218.66078704883, 3238.87044518219, 3274.754393420503, 3311.0, 3363.327334533103, 3367.7305815534696, 1125.7523344864117, 1131.5021390588197, 1797.3035473619877, 1880.9623807523774, 2069.5653912678354, 11641.126915481289, 11906.702332441671, 12034.939825300906, 12047.759044819055, 12071.336076515789, 4287.528371879091, 4445.599896009375, 4490.550944905549, 4544.091181763661, 4548.204064288736, 9425.811483770423, 9437.292203084797, 9441.055894410503, 9446.149846513847, 9447.449188719145, 5118.283440318359, 5124.846254612367, 5127.8718032048755, 5130.743462826918, 5134.563562097189, 3972.920541589152, 4195.664346852305, 4728.621710263171, 4783.282507623815, 4787.880302992453, 3648.4527320901548, 3689.0816775276708, 3731.477593136963, 3793.9241215175543, 3808.4287356896134, 1085.6742977106994, 1105.6019832860163, 1106.2366966792888, 1120.966371008871, 1121.7195701074731, 667.6194569095666, 804.8430556041633, 902.8104098139333, 907.8093600344001, 958.5399008475971, 5370.2750128732905, 5539.750711218005, 5585.245991791137, 5715.599908006399, 5790.565707571865, 854.769212312672, 863.1612290148955, 867.3018220332567, 878.4119106699752, 899.8110396816742, 3665.6700896918874, 3755.117547376364, 3767.1335592813257, 3879.7090218233743, 4001.919961600752, 9258.814823703487, 9941.701748947544, 10006.599736010477, 10018.949905250427, 10051.849222261671, 9736.95131524352, 9936.850947235796, 9955.751106222258, 9972.650957216463, 9979.900200997898, 7501.249875012564, 7952.324052455606, 7957.721479748181, 7960.920390796134, 7968.12350641429, 5327.6803391795065, 5541.556675466034, 5587.413321601173, 5682.289713785777, 5874.911876321773, 9482.95258523703, 9637.18083962871, 9663.855042174233, 9780.657676981271, 9861.950690246504, 9576.281778866474, 9701.272404569827, 9835.803283934425, 9868.210543156387, 10008.0, 6723.697433615401, 6929.722811087701, 7363.15323737777, 7575.848483030199, 7749.186335434698, 7961.800954976172, 8343.290820280345, 8345.749627511184, 8345.916540834514, 8376.958115209385, 7212.783616491513, 7350.852982940418, 7451.850962980601, 7540.283673051052, 7570.205128461433, 7028.121484814398, 7075.6815943281645, 7194.0, 7202.855942881218, 7430.96284518574, 6602.471802255904, 6726.865462690621, 6732.394084532416, 6732.697028633821, 6743.393094621508, 4967.82612608557, 5065.620078494201, 5090.872728181825, 5286.656367336111, 5349.625526213128, 4922.261660750916, 5068.417132029864, 5102.826349939461, 5149.9957508287025, 5183.092958732283], "value": 4459.228466681947, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.4760060103534, 337.3506000948175, 340.61850727185555, 343.81434025626146, 343.87276707618184, 5162.174052151657, 5219.138842091051, 5226.163813789794, 5260.210968354744, 5281.70950597717, 5138.254953031808, 5160.509751573604, 5189.792408303663, 5209.687418754868, 5217.895642087156, 3966.9008274793073, 4113.444684967521, 4116.917661646773, 4130.339145736682, 4144.917101657965, 4105.753654780708, 4119.4757939562405, 4123.092919557707, 4128.2362762888815, 4140.565240649734, 4085.346344584867, 4087.1008378156757, 4099.7745124018165, 4123.814428350732, 4131.876043718693, 3881.3789793633023, 3998.660113890323, 4003.8598649047144, 4057.69567282455, 4100.282450571153, 3651.835667394974, 3653.707703383723, 3656.835442405098, 3666.120131168527, 3670.1925576373155, 5098.566621837148, 5099.011385559635, 5109.131447653871, 5113.51421614946, 5117.232415137759, 4327.891802704926, 4464.441944756905, 4652.162610730067, 4659.7204167749705, 4711.175544279771, 5424.647397919122, 5428.96849598575, 5429.782808687648, 5442.619016668835, 5454.61817672763, 3991.860284890044, 4012.6557603202964, 4014.197160567898, 4019.6382325590544, 4026.5570787213383, 5382.892342153135, 5633.943660563383, 5636.605437619327, 5650.265465489501, 5659.773609055633, 3969.8809035728973, 3980.949810847416, 4010.63904248619, 4018.9799051005143, 4032.959670403317, 4059.9647089991863, 4060.715749897479, 4071.592840715905, 4073.7148399612333, 4084.101497670508, 4452.755098469551, 4604.240300350471, 4622.722636641813, 4679.268670591835, 4679.625629949596, 5425.131978883439, 5445.992491389026, 5456.563474921997, 5466.398696143421, 5501.5323697486165, 1351.6485713714308, 1368.7057282684073, 1375.40170026039, 1375.6492094516034, 1385.764420048594, 906.935182847444, 958.3004406783087, 961.8124465729115, 970.9271804614682, 974.7660561465339, 5079.8984020319385, 5089.185730283137, 5143.588512918957, 5145.845624631193, 5176.4047134580005, 5329.866753331198, 5371.543418809445, 5372.435894231049, 5379.300690910157, 5412.296401467784, 5010.348654674869, 5122.334096567497, 5139.897202056013, 5152.278680984665, 5314.946850531445, 2722.441899410616, 2790.4279622677304, 2791.6510436195476, 2855.000749737617, 2897.8116422432477, 5560.499555040065, 5580.302462192226, 5607.271054762855, 5616.343178762275, 5622.847316300149, 5442.782288708487, 5494.945050549523, 5508.9724551376985, 5520.834374968757, 5705.91734017089, 5792.710364481674, 5795.985702502046, 5809.564282678816, 5822.282426684138, 5836.649801011953, 5585.720713964367, 5613.494785469327, 5636.4927156556105, 5659.547236221175, 5685.232493613309, 5435.701036442875, 5526.50261476469, 5553.805616803393, 5579.497845193952, 5609.354924183608, 5788.842231553622, 5809.79665711715, 5840.569060580185, 5843.590948633555, 5845.883082338244, 3960.128771670228, 4011.5587285399165, 4050.67594592426, 4051.0277533392364, 4052.2098190852503, 5634.915476267777, 5636.915446268227, 5637.633553818989, 5652.7173641318595, 5676.631018983753, 5522.116461366162, 5533.557315414677, 5538.363088244742, 5553.72264379187, 5565.30433695788, 5338.46615338463, 5483.314585676791, 5488.69812160335, 5531.197976293495, 5534.6993456538485, 5433.483819037185, 5442.537384322377, 5446.591505637014, 5460.726963651722, 5465.9726701366235, 5515.531179849597, 5537.390887002507, 5555.666660000413, 5585.776568937359, 5605.608606792995, 5304.9920515102, 5354.544863686475, 5402.783888644411, 5431.103867861917, 5444.223446042468], "value": 4169.237533765327, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.2866460899183, 647.2556559956048, 699.765578531192, 761.9961900190501, 781.8514482248376, 12221.755564888708, 12995.025373097033, 13041.478340866353, 13081.934590327059, 13109.213447193175, 12768.0, 12897.09720319578, 12901.0, 12905.1611645243, 12923.159994600344, 634.517766497463, 646.890028695123, 741.4105785900223, 750.8198032472195, 753.088762597258, 764.5221736414741, 767.3937589304443, 767.9747537038061, 768.2624680306913, 768.4505578511363, 809.114020147937, 811.7929927868415, 818.2186012358213, 818.382121498268, 818.9631466583988, 676.455453360045, 689.0972825598457, 790.130856058337, 792.3186059988406, 817.6320655704927, 592.7984485275027, 593.4184499190774, 593.4451288045648, 593.7862369546959, 593.8040446652594, 12191.51233950641, 12249.816252756216, 12253.326067066308, 12253.632391028283, 12260.203086799418, 11549.249298795636, 11627.476763545661, 11792.174547781658, 11915.702107447383, 12227.266364018187, 10434.16526677864, 10491.685249442453, 10658.893411065868, 10660.253782235246, 10724.892751072468, 3572.285542891432, 3574.1064733816547, 3590.299891521154, 3654.908627284339, 3740.420234863573, 60071.69964150195, 60167.0, 60428.69785651087, 60462.697686511725, 63720.04419933751, 9253.352265341497, 9291.21024712907, 9405.858912116324, 9553.522323883917, 9555.0, 17582.0, 17584.208710608054, 17591.12044397775, 17593.560160996076, 17598.0, 7134.92865071353, 7290.817729556804, 7345.449091318173, 7421.443391745533, 7593.544387336778, 4027.624802786262, 4084.36692312692, 4097.1191193893455, 4100.835966561363, 4150.501939767248, 2917.766578673701, 2981.7912746107563, 2995.4608170529077, 3012.3071693510615, 3017.109952563999, 546.2189069630388, 549.5356423821864, 562.8536580489102, 566.5977156219049, 572.2760707704757, 614.6834380294152, 636.7962252079383, 643.613831700985, 657.6120089147425, 661.7121552124842, 7637.923620763832, 7807.336376407955, 7917.406194535318, 7918.960405197937, 8347.040090389683, 591.8313280715062, 639.2137670665107, 643.9581427207216, 657.8750037492861, 673.2493270003911, 3757.1170774867883, 3829.636184562518, 3933.7246392752804, 3940.389239667856, 3955.268275369066, 85438.0, 90605.54697226603, 92253.89350600135, 92434.07565924388, 95596.0, 46930.5306946933, 65277.0, 73655.0, 78364.0, 78996.0, 43034.13931721348, 43093.784531077144, 45644.77177614091, 45957.7702111494, 54388.0, 7257.963710181415, 7412.592307422928, 7526.736564220445, 7698.923010770045, 7761.573113478587, 46639.0, 48814.0, 48837.267440989126, 48891.26663099985, 49856.501434985184, 68230.65884670545, 69337.65331173311, 69581.30418695748, 69623.65188174027, 70911.00879363707, 9190.471708861, 9502.23982081418, 9517.23862091045, 9539.952300238732, 9654.565544550653, 10527.315724477885, 10577.894221057692, 10746.946265268623, 10764.0, 10767.508396566736, 9812.362196457207, 10264.076233138754, 10269.077725264962, 10335.276530643083, 10420.0, 9441.716748497556, 9564.66523671668, 9616.182624476998, 9622.51887405613, 9889.3571917828, 9634.13292803651, 10090.747731306776, 10292.948535257576, 10329.380237185793, 10330.535125919201, 8188.50868947865, 8258.339332853237, 8261.793455163668, 8510.74467765968, 8648.740537783877, 7289.781306560812, 7709.113451953097, 7907.288344048833, 8207.580058767771, 8359.122292159236], "value": 6235.397419484487, "unit": "score"}], "name": "dromaeo_css", "value": 6892.370392580968, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 116.0, 114.0, 115.0, 114.0, 115.0, 115.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 123.0, 126.0, 165.0, 122.0, 125.0, 124.0, 121.0, 160.0, 123.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 161.0, 161.0, 161.0, 162.0, 161.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 109.0, 78.0, 76.0, 75.0, 76.0, 98.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 118.0, 85.0, 84.0, 83.0, 100.0, 83.0, 84.0, 121.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 119.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 147.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 86.0, 85.0, 85.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 53.0, 54.0, 54.0, 55.0, 54.0, 55.0, 53.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 83.0, 80.0, 86.0, 80.0, 80.0, 82.0, 79.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 153.0, 129.0, 130.0, 139.0, 140.0, 132.0, 129.0, 181.0, 136.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 163.0, 164.0, 165.0, 165.0, 167.0, 168.0, 169.0, 168.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 66.0, 70.0, 63.0, 63.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1501.8000000000002, "alertThreshold": 2.0}]} 01:45:47 INFO - Return code: 0 01:45:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:45:48 INFO - # TBPL SUCCESS # 01:45:48 INFO - Running post-action listener: _resource_record_post_action 01:45:48 INFO - [mozharness: 2016-11-08 09:45:48.002633Z] Finished run-tests step (success) 01:45:48 INFO - Running post-run listener: _resource_record_post_run 01:45:48 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 16384; Write bytes: 408977408; Read time: 360; Write time: 264792 01:45:48 INFO - TinderboxPrint: CPU usage
13.1% 01:45:48 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 360 01:45:48 INFO - TinderboxPrint: I/O write bytes / time
408,977,408 / 264,792 01:45:48 INFO - TinderboxPrint: CPU idle
8,290.5 (86.9%) 01:45:48 INFO - TinderboxPrint: CPU user
1,202.0 (12.6%) 01:45:48 INFO - TinderboxPrint: Swap in / out
0 / 0 01:45:48 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103854080; Read time: 0; Write time: 85836 01:45:48 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 12288; Write bytes: 288530432; Read time: 348; Write time: 173488 01:45:48 INFO - Running post-run listener: _upload_blobber_files 01:45:48 INFO - Blob upload gear active. 01:45:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:45:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:45:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:45:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:45:49 INFO - (blobuploader) - INFO - Open directory for files ... 01:45:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:45:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:45:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:52 INFO - (blobuploader) - INFO - Done attempting. 01:45:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:45:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:45:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:52 INFO - (blobuploader) - INFO - Done attempting. 01:45:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:45:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:45:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:53 INFO - (blobuploader) - INFO - Done attempting. 01:45:53 INFO - (blobuploader) - INFO - Iteration through files over. 01:45:53 INFO - Return code: 0 01:45:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:45:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:45:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d236d308b252981a82e36380819a4507e8f7631c20aae075c1743f4ac62abc266fc23aa3c9953f92c04b9909c747d25257bbc33ae554141c933f6abe7bc14c75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da27f073f7530082a1faeb27a0cef41a31197a4b0123b1fc4042fd55b82e20c54d802bdc8bd7a55be09298d9d513607156fc86baad09debfd5457d08a16c9973", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/542c1bb1c5002caa5725c93a0bc72ea0d0cc33fe6066cf681ba73935aec5fbce1022e5ad254808f24f47bbbac0f10dee8862d359c40fd36e7d4a7486e7585367"} 01:45:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:45:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:45:53 INFO - Contents: 01:45:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d236d308b252981a82e36380819a4507e8f7631c20aae075c1743f4ac62abc266fc23aa3c9953f92c04b9909c747d25257bbc33ae554141c933f6abe7bc14c75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da27f073f7530082a1faeb27a0cef41a31197a4b0123b1fc4042fd55b82e20c54d802bdc8bd7a55be09298d9d513607156fc86baad09debfd5457d08a16c9973", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/542c1bb1c5002caa5725c93a0bc72ea0d0cc33fe6066cf681ba73935aec5fbce1022e5ad254808f24f47bbbac0f10dee8862d359c40fd36e7d4a7486e7585367"} 01:45:53 INFO - Running post-run listener: copy_logs_to_upload_dir 01:45:53 INFO - Copying logs to upload dir... 01:45:53 INFO - mkdir: /builds/slave/test/build/upload/logs 01:45:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.213030 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-11-08 01:45:53.643124) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 01:45:53.647671) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d236d308b252981a82e36380819a4507e8f7631c20aae075c1743f4ac62abc266fc23aa3c9953f92c04b9909c747d25257bbc33ae554141c933f6abe7bc14c75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da27f073f7530082a1faeb27a0cef41a31197a4b0123b1fc4042fd55b82e20c54d802bdc8bd7a55be09298d9d513607156fc86baad09debfd5457d08a16c9973", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/542c1bb1c5002caa5725c93a0bc72ea0d0cc33fe6066cf681ba73935aec5fbce1022e5ad254808f24f47bbbac0f10dee8862d359c40fd36e7d4a7486e7585367"} build_url:https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010766 build_url: 'https://queue.taskcluster.net/v1/task/YGDYhu8QSfuPuuYxCq1qAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d236d308b252981a82e36380819a4507e8f7631c20aae075c1743f4ac62abc266fc23aa3c9953f92c04b9909c747d25257bbc33ae554141c933f6abe7bc14c75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da27f073f7530082a1faeb27a0cef41a31197a4b0123b1fc4042fd55b82e20c54d802bdc8bd7a55be09298d9d513607156fc86baad09debfd5457d08a16c9973", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/542c1bb1c5002caa5725c93a0bc72ea0d0cc33fe6066cf681ba73935aec5fbce1022e5ad254808f24f47bbbac0f10dee8862d359c40fd36e7d4a7486e7585367"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 01:45:53.679274) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 01:45:53.679635) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1478595511.935035-945907368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004616 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 01:45:53.729140) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 01:45:53.729492) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 01:45:53.729795) ========= ========= Total master_lag: 0.34 =========