builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1476537914.95 results: success (0) buildid: 20161015033004 builduid: 47ca784e24334724926e3df233fdfa8b revision: 44b01519b5668699f2c1a10d362445be59711d35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-15 06:25:14.951986) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-15 06:25:14.952415) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-15 06:25:14.952718) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-15 06:25:14.992057) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 06:25:14.992347) ========= 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=826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-15 06:25:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.0M=0.001s 2016-10-15 06:25:16 (23.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125428 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 06:25:15.131705) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 06:25:15.132042) ========= 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=826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017779 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 06:25:15.181592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 06:25:15.181994) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 44b01519b5668699f2c1a10d362445be59711d35 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 44b01519b5668699f2c1a10d362445be59711d35 --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=826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-15 06:25:16,565 truncating revision to first 12 chars 2016-10-15 06:25:16,565 Setting DEBUG logging. 2016-10-15 06:25:16,565 attempt 1/10 2016-10-15 06:25:16,565 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/44b01519b566?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-15 06:25:17,180 unpacking tar archive at: fx-team-44b01519b566/testing/mozharness/ program finished with exit code 0 elapsedTime=0.939257 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 06:25:16.135382) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-15 06:25:16.135851) ========= script_repo_revision: 44b01519b5668699f2c1a10d362445be59711d35 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-15 06:25:16.136390) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-15 06:25:16.136805) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-15 06:25:16.147138) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-15 06:25:16.147664) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:25:17 INFO - MultiFileLogger online at 20161015 06:25:17 in /builds/slave/test 06:25:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:25:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:25:17 INFO - {'append_to_log': False, 06:25:17 INFO - 'base_work_dir': '/builds/slave/test', 06:25:17 INFO - 'blob_upload_branch': 'Fx-Team', 06:25:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:25:17 INFO - 'branch': 'Fx-Team', 06:25:17 INFO - 'buildbot_json_path': 'buildprops.json', 06:25:17 INFO - 'config_files': ('talos/linux_config.py',), 06:25:17 INFO - 'default_actions': ('clobber', 06:25:17 INFO - 'read-buildbot-config', 06:25:17 INFO - 'download-and-extract', 06:25:17 INFO - 'populate-webroot', 06:25:17 INFO - 'create-virtualenv', 06:25:17 INFO - 'install', 06:25:17 INFO - 'run-tests'), 06:25:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:25:17 INFO - 'download_minidump_stackwalk': True, 06:25:17 INFO - 'download_symbols': 'ondemand', 06:25:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:25:17 INFO - 'tooltool.py': '/tools/tooltool.py', 06:25:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:25:17 INFO - '/tools/misc-python/virtualenv.py')}, 06:25:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:25:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:25:17 INFO - 'installer_path': 'installer.exe', 06:25:17 INFO - 'log_level': 'info', 06:25:17 INFO - 'log_name': 'talos', 06:25:17 INFO - 'log_to_console': True, 06:25:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:25:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:25:17 INFO - 'opt_config_files': (), 06:25:17 INFO - 'pip_index': False, 06:25:17 INFO - 'sps_profile': False, 06:25:17 INFO - 'sps_profile_interval': 0, 06:25:17 INFO - 'suite': 'dromaeojs', 06:25:17 INFO - 'system_bits': '32', 06:25:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:25:17 INFO - 'title': 'talos-linux64-ix-052', 06:25:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:25:17 INFO - 'use_talos_json': True, 06:25:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:25:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:25:17 INFO - 'work_dir': 'build'} 06:25:17 INFO - [mozharness: 2016-10-15 13:25:17.635710Z] Running clobber step. 06:25:17 INFO - Running pre-action listener: _resource_record_pre_action 06:25:17 INFO - Running main action method: clobber 06:25:17 INFO - rmtree: /builds/slave/test/build 06:25:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:25:18 INFO - Running post-action listener: _resource_record_post_action 06:25:18 INFO - [mozharness: 2016-10-15 13:25:18.089321Z] Finished clobber step (success) 06:25:18 INFO - [mozharness: 2016-10-15 13:25:18.089422Z] Running read-buildbot-config step. 06:25:18 INFO - Running pre-action listener: _resource_record_pre_action 06:25:18 INFO - Running main action method: read_buildbot_config 06:25:18 INFO - Using buildbot properties: 06:25:18 INFO - { 06:25:18 INFO - "project": "", 06:25:18 INFO - "product": "firefox", 06:25:18 INFO - "script_repo_revision": "production", 06:25:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:25:18 INFO - "repository": "", 06:25:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:25:18 INFO - "buildid": "20161015033004", 06:25:18 INFO - "pgo_build": "True", 06:25:18 INFO - "basedir": "/builds/slave/test", 06:25:18 INFO - "buildnumber": 1141, 06:25:18 INFO - "slavename": "talos-linux64-ix-052", 06:25:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:25:18 INFO - "platform": "ubuntu64_hw", 06:25:18 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:25:18 INFO - "branch": "fx-team", 06:25:18 INFO - "repo_path": "integration/fx-team", 06:25:18 INFO - "revision": "44b01519b5668699f2c1a10d362445be59711d35", 06:25:18 INFO - "stage_platform": "linux64-pgo", 06:25:18 INFO - "builduid": "47ca784e24334724926e3df233fdfa8b", 06:25:18 INFO - "slavebuilddir": "test" 06:25:18 INFO - } 06:25:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:25:18 INFO - Running post-action listener: _resource_record_post_action 06:25:18 INFO - [mozharness: 2016-10-15 13:25:18.091837Z] Finished read-buildbot-config step (success) 06:25:18 INFO - [mozharness: 2016-10-15 13:25:18.091926Z] Running download-and-extract step. 06:25:18 INFO - Running pre-action listener: _resource_record_pre_action 06:25:18 INFO - Running main action method: download_and_extract 06:25:18 INFO - mkdir: /builds/slave/test/build/tests 06:25:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:25:18 INFO - trying https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:25:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/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 06:25:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/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 06:25:18 INFO - Downloaded 1361 bytes. 06:25:18 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:25:18 INFO - Using the following test package requirements: 06:25:18 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:25:18 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:25:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:25:18 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:25:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:25:18 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:25:18 INFO - u'jsshell-linux-x86_64.zip'], 06:25:18 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:25:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:25:18 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:25:18 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:25:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:25:18 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:25:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:25:18 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:25:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:25:18 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:25:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:25:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:25:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:25:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:25:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:25:19 INFO - Http code: 200 06:25:19 INFO - via: 1.1 dc7c4fb5024ff022cad1642ec506a6e8.cloudfront.net (CloudFront) 06:25:19 INFO - x-amz-cf-id: GH8uJT_5XOIIpvMKX0r1ahXJ9mKynq2PKp1oJlQDPHSKgqxwJpiyFg== 06:25:19 INFO - x-amz-version-id: VlOYNHsZOOqDKPa6GrZ5ONcR7lYzEDsm 06:25:19 INFO - Expected file size: 22123369 06:25:19 INFO - Obtained file size: 22123369 06:25:23 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 06:25:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:25:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:25:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:25:24 INFO - Http code: 200 06:25:24 INFO - via: 1.1 bfdd5909914586f5bc4851846228c27f.cloudfront.net (CloudFront) 06:25:24 INFO - x-amz-cf-id: MHPNfwRQyDmAwPR5gp8tWU8E9QlwR1BUopeS49s1OVuy4HQq6bGsrw== 06:25:24 INFO - x-amz-version-id: VlOYNHsZOOqDKPa6GrZ5ONcR7lYzEDsm 06:25:24 INFO - Expected file size: 22123369 06:25:24 INFO - Obtained file size: 22123369 06:25:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:25:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:25:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:25:29 INFO - Http code: 200 06:25:29 INFO - via: 1.1 dc7c4fb5024ff022cad1642ec506a6e8.cloudfront.net (CloudFront) 06:25:29 INFO - x-amz-cf-id: CMXZ_dMV5fFj0rfOtNiH4oAZG4K4glQM-tmugr15c3Jv6X23_N_hlw== 06:25:29 INFO - x-amz-version-id: szDkKgaDWgiNQjw.hc1ctn7L9o3DMgyl 06:25:29 INFO - Expected file size: 14409028 06:25:29 INFO - Obtained file size: 14409028 06:25:29 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')]} 06:25:29 INFO - trying https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:25:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/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 06:25:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/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 06:25:31 INFO - Downloaded 59594332 bytes. 06:25:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:25:31 INFO - mkdir: /builds/slave/test/properties 06:25:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:25:31 INFO - Writing to file /builds/slave/test/properties/build_url 06:25:31 INFO - Contents: 06:25:31 INFO - build_url:https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:25:31 INFO - Running post-action listener: _resource_record_post_action 06:25:31 INFO - Running post-action listener: set_extra_try_arguments 06:25:31 INFO - [mozharness: 2016-10-15 13:25:31.706895Z] Finished download-and-extract step (success) 06:25:31 INFO - [mozharness: 2016-10-15 13:25:31.707194Z] Running populate-webroot step. 06:25:31 INFO - Running pre-action listener: _resource_record_pre_action 06:25:31 INFO - Running main action method: populate_webroot 06:25:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:25:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:25:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:25:31 INFO - '--tppagecycles', 06:25:31 INFO - '7'], 06:25:31 INFO - 'tests': ['tsvgm']}}, 06:25:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:25:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:25:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:25:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:25:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:25:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:25:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:31 INFO - 'talos_options': ['--disable-e10s'], 06:25:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:25:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:25:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:31 INFO - 'talos_options': ['--disable-e10s'], 06:25:31 INFO - 'tests': ['damp', 'tps']}, 06:25:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:31 INFO - 'tests': ['damp', 'tps']}, 06:25:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:25:31 INFO - 'tests': ['dromaeo_dom']}, 06:25:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:25:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:25:31 INFO - 'tests': ['basic_compositor_video']}, 06:25:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:25:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:25:31 INFO - 'tests': ['a11yr', 06:25:31 INFO - 'ts_paint', 06:25:31 INFO - 'tpaint', 06:25:31 INFO - 'sessionrestore', 06:25:31 INFO - 'sessionrestore_no_auto_restore', 06:25:31 INFO - 'tabpaint']}, 06:25:31 INFO - 'other-e10s': {'tests': ['a11yr', 06:25:31 INFO - 'ts_paint', 06:25:31 INFO - 'tpaint', 06:25:31 INFO - 'sessionrestore', 06:25:31 INFO - 'sessionrestore_no_auto_restore', 06:25:31 INFO - 'tabpaint']}, 06:25:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:25:31 INFO - 'ts_paint', 06:25:31 INFO - 'tpaint', 06:25:31 INFO - 'sessionrestore', 06:25:31 INFO - 'sessionrestore_no_auto_restore', 06:25:31 INFO - 'tabpaint']}, 06:25:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:25:31 INFO - 'ts_paint', 06:25:31 INFO - 'tpaint', 06:25:31 INFO - 'sessionrestore', 06:25:31 INFO - 'sessionrestore_no_auto_restore', 06:25:31 INFO - 'tabpaint']}, 06:25:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:25:31 INFO - 'tests': ['a11yr', 06:25:31 INFO - 'ts_paint', 06:25:31 INFO - 'tpaint', 06:25:31 INFO - 'sessionrestore', 06:25:31 INFO - 'sessionrestore_no_auto_restore', 06:25:31 INFO - 'tabpaint']}, 06:25:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:25:31 INFO - 'tests': ['a11yr', 06:25:31 INFO - 'ts_paint', 06:25:31 INFO - 'tpaint', 06:25:31 INFO - 'sessionrestore', 06:25:31 INFO - 'sessionrestore_no_auto_restore', 06:25:31 INFO - 'tabpaint']}, 06:25:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:25:31 INFO - 'tests': ['tsvgx', 06:25:31 INFO - 'tsvgr_opacity', 06:25:31 INFO - 'tart', 06:25:31 INFO - 'tscrollx', 06:25:31 INFO - 'cart']}, 06:25:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:25:31 INFO - 'tsvgr_opacity', 06:25:31 INFO - 'tart', 06:25:31 INFO - 'tscrollx', 06:25:31 INFO - 'cart']}, 06:25:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:31 INFO - 'talos_options': ['--disable-e10s'], 06:25:31 INFO - 'tests': ['tp5o']}, 06:25:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:31 INFO - 'tests': ['tp5o']}, 06:25:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:31 INFO - 'talos_options': ['--disable-e10s', 06:25:31 INFO - '--xperf_path', 06:25:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:25:31 INFO - 'tests': ['tp5n']}, 06:25:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:31 INFO - 'talos_options': ['--xperf_path', 06:25:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:25:31 INFO - 'tests': ['tp5n']}}, 06:25:31 INFO - 'talos.zip': {'path': '', 06:25:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:25:31 INFO - Running post-action listener: _resource_record_post_action 06:25:31 INFO - [mozharness: 2016-10-15 13:25:31.730722Z] Finished populate-webroot step (success) 06:25:31 INFO - [mozharness: 2016-10-15 13:25:31.730816Z] Running create-virtualenv step. 06:25:31 INFO - Running pre-action listener: _resource_record_pre_action 06:25:31 INFO - Running main action method: create_virtualenv 06:25:31 INFO - Creating virtualenv /builds/slave/test/build/venv 06:25:31 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 06:25:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:25:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:25:31 INFO - Using real prefix '/usr' 06:25:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:25:32 INFO - Installing distribute.............................................................................................................................................................................................done. 06:25:34 INFO - Installing pip.................done. 06:25:34 INFO - Return code: 0 06:25:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:25:34 INFO - Reading from file tmpfile_stdout 06:25:34 INFO - Output received: 06:25:34 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) 06:25:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06: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')]} 06:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4673e3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07930>, '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 0xe08830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe08cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', '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 06: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', 'pip>=1.5'] in /builds/slave/test/build 06: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 pip>=1.5 06:25:34 INFO - Using env: {'DISPLAY': ':0', 06:25:34 INFO - 'HOME': '/home/cltbld', 06:25:34 INFO - 'LANG': 'en_US.UTF-8', 06:25:34 INFO - 'LANGUAGE': 'en_US:en', 06:25:34 INFO - 'LOGNAME': 'cltbld', 06:25:34 INFO - 'MAIL': '/var/mail/cltbld', 06:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:34 INFO - 'MOZ_NO_REMOTE': '1', 06:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:34 INFO - 'NO_EM_RESTART': '1', 06:25:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:34 INFO - 'PWD': '/builds/slave/test', 06:25:34 INFO - 'SHELL': '/bin/bash', 06:25:34 INFO - 'SHLVL': '1', 06:25:34 INFO - 'TERM': 'linux', 06:25:34 INFO - 'TMOUT': '86400', 06:25:34 INFO - 'USER': 'cltbld', 06:25:34 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', 06:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:34 INFO - '_': '/tools/buildbot/bin/python'} 06:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:34 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 06:25:34 INFO - Cleaning up... 06:25:34 INFO - Return code: 0 06:25:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06: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')]} 06:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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', '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 0x7f4673e3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07930>, '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 0xe08830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe08cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', '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 06: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', 'psutil>=3.1.1'] in /builds/slave/test/build 06: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 psutil>=3.1.1 06:25:34 INFO - Using env: {'DISPLAY': ':0', 06:25:34 INFO - 'HOME': '/home/cltbld', 06:25:34 INFO - 'LANG': 'en_US.UTF-8', 06:25:34 INFO - 'LANGUAGE': 'en_US:en', 06:25:34 INFO - 'LOGNAME': 'cltbld', 06:25:34 INFO - 'MAIL': '/var/mail/cltbld', 06:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:34 INFO - 'MOZ_NO_REMOTE': '1', 06:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:34 INFO - 'NO_EM_RESTART': '1', 06:25:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:34 INFO - 'PWD': '/builds/slave/test', 06:25:34 INFO - 'SHELL': '/bin/bash', 06:25:34 INFO - 'SHLVL': '1', 06:25:34 INFO - 'TERM': 'linux', 06:25:34 INFO - 'TMOUT': '86400', 06:25:34 INFO - 'USER': 'cltbld', 06:25:34 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', 06:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:34 INFO - '_': '/tools/buildbot/bin/python'} 06:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:34 INFO - Downloading/unpacking psutil>=3.1.1 06: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 06: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 06: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 06: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 06: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 06: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 06:25:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:25:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:25:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:25:37 INFO - Installing collected packages: psutil 06:25:37 INFO - Running setup.py install for psutil 06:25:37 INFO - building 'psutil._psutil_linux' extension 06:25:37 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 06:25:37 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 06:25:37 INFO - building 'psutil._psutil_posix' extension 06:25:37 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 06:25:37 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 06:25:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:25:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:25:37 INFO - Successfully installed psutil 06:25:37 INFO - Cleaning up... 06:25:37 INFO - Return code: 0 06:25:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:25:37 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')]} 06:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:37 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')]} 06:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:37 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 0x7f4673e3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07930>, '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 0xe08830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe08cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', '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 06:25:37 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 06:25:37 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 06:25:37 INFO - Using env: {'DISPLAY': ':0', 06:25:37 INFO - 'HOME': '/home/cltbld', 06:25:37 INFO - 'LANG': 'en_US.UTF-8', 06:25:37 INFO - 'LANGUAGE': 'en_US:en', 06:25:37 INFO - 'LOGNAME': 'cltbld', 06:25:37 INFO - 'MAIL': '/var/mail/cltbld', 06:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:37 INFO - 'MOZ_NO_REMOTE': '1', 06:25:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:37 INFO - 'NO_EM_RESTART': '1', 06:25:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:37 INFO - 'PWD': '/builds/slave/test', 06:25:37 INFO - 'SHELL': '/bin/bash', 06:25:37 INFO - 'SHLVL': '1', 06:25:37 INFO - 'TERM': 'linux', 06:25:37 INFO - 'TMOUT': '86400', 06:25:37 INFO - 'USER': 'cltbld', 06:25:37 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', 06:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:37 INFO - '_': '/tools/buildbot/bin/python'} 06:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 06: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 06: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 06: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 06: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 06: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 06: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 06:25:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:25:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:25:39 INFO - Installing collected packages: mozsystemmonitor 06:25:39 INFO - Running setup.py install for mozsystemmonitor 06:25:39 INFO - Successfully installed mozsystemmonitor 06:25:39 INFO - Cleaning up... 06:25:39 INFO - Return code: 0 06:25:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06: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')]} 06:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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', '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 0x7f4673e3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07930>, '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 0xe08830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe08cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', '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 06: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 06: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 jsonschema==2.5.1 06:25:39 INFO - Using env: {'DISPLAY': ':0', 06:25:39 INFO - 'HOME': '/home/cltbld', 06:25:39 INFO - 'LANG': 'en_US.UTF-8', 06:25:39 INFO - 'LANGUAGE': 'en_US:en', 06:25:39 INFO - 'LOGNAME': 'cltbld', 06:25:39 INFO - 'MAIL': '/var/mail/cltbld', 06:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:39 INFO - 'MOZ_NO_REMOTE': '1', 06:25:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:39 INFO - 'NO_EM_RESTART': '1', 06:25:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:39 INFO - 'PWD': '/builds/slave/test', 06:25:39 INFO - 'SHELL': '/bin/bash', 06:25:39 INFO - 'SHLVL': '1', 06:25:39 INFO - 'TERM': 'linux', 06:25:39 INFO - 'TMOUT': '86400', 06:25:39 INFO - 'USER': 'cltbld', 06:25:39 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', 06:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:39 INFO - '_': '/tools/buildbot/bin/python'} 06:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:40 INFO - Downloading/unpacking jsonschema==2.5.1 06: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 06: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 06: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 06: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 06: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 06: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 06:25:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:25:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06: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 06: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 06: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 06: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 06: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 06: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 06:25:42 INFO - Downloading functools32-3.2.3-2.tar.gz 06:25:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:25:42 INFO - warning: no files found matching '*.txt' 06:25:42 INFO - no previously-included directories found matching 'build' 06:25:42 INFO - no previously-included directories found matching 'dist' 06:25:42 INFO - no previously-included directories found matching '.git*' 06:25:42 INFO - Installing collected packages: jsonschema, functools32 06:25:42 INFO - Running setup.py install for functools32 06:25:42 INFO - warning: no files found matching '*.txt' 06:25:42 INFO - no previously-included directories found matching 'build' 06:25:42 INFO - no previously-included directories found matching 'dist' 06:25:42 INFO - no previously-included directories found matching '.git*' 06:25:42 INFO - Successfully installed jsonschema functools32 06:25:42 INFO - Cleaning up... 06:25:42 INFO - Return code: 0 06:25:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:25:42 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')]} 06:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:42 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')]} 06:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:42 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 0x7f4673e3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07930>, '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 0xe08830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe08cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', '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 06:25:42 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 06:25:42 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 06:25:42 INFO - Using env: {'DISPLAY': ':0', 06:25:42 INFO - 'HOME': '/home/cltbld', 06:25:42 INFO - 'LANG': 'en_US.UTF-8', 06:25:42 INFO - 'LANGUAGE': 'en_US:en', 06:25:42 INFO - 'LOGNAME': 'cltbld', 06:25:42 INFO - 'MAIL': '/var/mail/cltbld', 06:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:42 INFO - 'MOZ_NO_REMOTE': '1', 06:25:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:42 INFO - 'NO_EM_RESTART': '1', 06:25:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:42 INFO - 'PWD': '/builds/slave/test', 06:25:42 INFO - 'SHELL': '/bin/bash', 06:25:42 INFO - 'SHLVL': '1', 06:25:42 INFO - 'TERM': 'linux', 06:25:42 INFO - 'TMOUT': '86400', 06:25:42 INFO - 'USER': 'cltbld', 06:25:42 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', 06:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:42 INFO - '_': '/tools/buildbot/bin/python'} 06:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:25:42 INFO - Cleaning up... 06:25:42 INFO - Return code: 0 06:25:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:25:42 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')]} 06:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:42 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')]} 06:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:42 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 0x7f4673e3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07930>, '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 0xe08830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe08cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', '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 06:25:42 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 06:25:42 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 06:25:42 INFO - Using env: {'DISPLAY': ':0', 06:25:42 INFO - 'HOME': '/home/cltbld', 06:25:42 INFO - 'LANG': 'en_US.UTF-8', 06:25:42 INFO - 'LANGUAGE': 'en_US:en', 06:25:42 INFO - 'LOGNAME': 'cltbld', 06:25:42 INFO - 'MAIL': '/var/mail/cltbld', 06:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:42 INFO - 'MOZ_NO_REMOTE': '1', 06:25:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:42 INFO - 'NO_EM_RESTART': '1', 06:25:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:42 INFO - 'PWD': '/builds/slave/test', 06:25:42 INFO - 'SHELL': '/bin/bash', 06:25:42 INFO - 'SHLVL': '1', 06:25:42 INFO - 'TERM': 'linux', 06:25:42 INFO - 'TMOUT': '86400', 06:25:42 INFO - 'USER': 'cltbld', 06:25:42 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', 06:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:42 INFO - '_': '/tools/buildbot/bin/python'} 06:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:42 INFO - Downloading/unpacking blobuploader==1.2.4 06: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 06: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 06: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 06: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 06: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 06: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 06:25:44 INFO - Downloading blobuploader-1.2.4.tar.gz 06:25:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:25:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:25:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:25:45 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 06:25:45 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 06:25:45 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 06:25:45 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 06:25:45 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 06:25:45 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 06:25:45 INFO - Downloading docopt-0.6.1.tar.gz 06:25:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:25:45 INFO - Installing collected packages: blobuploader, requests, docopt 06:25:45 INFO - Running setup.py install for blobuploader 06:25:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:25:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:25:45 INFO - Running setup.py install for requests 06:25:46 INFO - Running setup.py install for docopt 06:25:46 INFO - Successfully installed blobuploader requests docopt 06:25:46 INFO - Cleaning up... 06:25:46 INFO - Return code: 0 06:25:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06: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')]} 06:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:46 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 0x7f4673e3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07930>, '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 0xe08830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe08cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', '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 06:25:46 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 06:25:46 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 06:25:46 INFO - Using env: {'DISPLAY': ':0', 06:25:46 INFO - 'HOME': '/home/cltbld', 06:25:46 INFO - 'LANG': 'en_US.UTF-8', 06:25:46 INFO - 'LANGUAGE': 'en_US:en', 06:25:46 INFO - 'LOGNAME': 'cltbld', 06:25:46 INFO - 'MAIL': '/var/mail/cltbld', 06:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:46 INFO - 'MOZ_NO_REMOTE': '1', 06:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:46 INFO - 'NO_EM_RESTART': '1', 06:25:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:46 INFO - 'PWD': '/builds/slave/test', 06:25:46 INFO - 'SHELL': '/bin/bash', 06:25:46 INFO - 'SHLVL': '1', 06:25:46 INFO - 'TERM': 'linux', 06:25:46 INFO - 'TMOUT': '86400', 06:25:46 INFO - 'USER': 'cltbld', 06:25:46 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', 06:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:46 INFO - '_': '/tools/buildbot/bin/python'} 06:25:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:25:46 INFO - Running setup.py (path:/tmp/pip-oUSk1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:25:46 INFO - Running setup.py (path:/tmp/pip-gghXRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:25:46 INFO - Running setup.py (path:/tmp/pip-pOSPrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:25:46 INFO - Running setup.py (path:/tmp/pip-M32jg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:25:46 INFO - Running setup.py (path:/tmp/pip-E4Vec6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:25:46 INFO - Running setup.py (path:/tmp/pip-K33VUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:25:46 INFO - Running setup.py (path:/tmp/pip-i2DUGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:25:47 INFO - Running setup.py (path:/tmp/pip-yIZnHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:25:47 INFO - Running setup.py (path:/tmp/pip-Ms3JSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:25:47 INFO - Running setup.py (path:/tmp/pip-_H78K7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:25:47 INFO - Running setup.py (path:/tmp/pip-IJiYFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:25:47 INFO - Running setup.py (path:/tmp/pip-Mr44Gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:25:47 INFO - Running setup.py (path:/tmp/pip-r4ThKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:25:47 INFO - Running setup.py (path:/tmp/pip-M_ggMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:47 INFO - Running setup.py (path:/tmp/pip-Aj1fHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:25:47 INFO - Running setup.py (path:/tmp/pip-91LUqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:25:47 INFO - Running setup.py (path:/tmp/pip-XouaZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:25:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:25:47 INFO - Running setup.py install for manifestparser 06:25:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:25:47 INFO - Running setup.py install for mozcrash 06:25:47 INFO - Running setup.py install for mozdebug 06:25:48 INFO - Running setup.py install for mozdevice 06:25:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:25:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:25:48 INFO - Running setup.py install for mozfile 06:25:48 INFO - Running setup.py install for mozhttpd 06:25:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:25:48 INFO - Running setup.py install for mozinfo 06:25:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:25:48 INFO - Running setup.py install for mozInstall 06:25:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:25:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:25:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:25:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:25:48 INFO - Running setup.py install for mozleak 06:25:48 INFO - Running setup.py install for mozlog 06:25:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:25:48 INFO - Running setup.py install for moznetwork 06:25:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:25:48 INFO - Running setup.py install for mozprocess 06:25:48 INFO - Running setup.py install for mozprofile 06:25:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:25:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:25:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:25:49 INFO - Running setup.py install for mozrunner 06:25:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:25:49 INFO - Running setup.py install for mozscreenshot 06:25:49 INFO - Running setup.py install for moztest 06:25:49 INFO - Running setup.py install for mozversion 06:25:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:25:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:25:49 INFO - Cleaning up... 06:25:49 INFO - Return code: 0 06:25:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:49 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')]} 06:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:49 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')]} 06:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:49 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 0x7f4673e3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07930>, '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 0xe08830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe08cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', '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 06:25:49 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 06:25:49 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 06:25:49 INFO - Using env: {'DISPLAY': ':0', 06:25:49 INFO - 'HOME': '/home/cltbld', 06:25:49 INFO - 'LANG': 'en_US.UTF-8', 06:25:49 INFO - 'LANGUAGE': 'en_US:en', 06:25:49 INFO - 'LOGNAME': 'cltbld', 06:25:49 INFO - 'MAIL': '/var/mail/cltbld', 06:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:49 INFO - 'MOZ_NO_REMOTE': '1', 06:25:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:49 INFO - 'NO_EM_RESTART': '1', 06:25:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:49 INFO - 'PWD': '/builds/slave/test', 06:25:49 INFO - 'SHELL': '/bin/bash', 06:25:49 INFO - 'SHLVL': '1', 06:25:49 INFO - 'TERM': 'linux', 06:25:49 INFO - 'TMOUT': '86400', 06:25:49 INFO - 'USER': 'cltbld', 06:25:49 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', 06:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:49 INFO - '_': '/tools/buildbot/bin/python'} 06:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:25:49 INFO - Running setup.py (path:/tmp/pip-Tkaj1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:25:49 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)) 06:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:25:49 INFO - Running setup.py (path:/tmp/pip-WTagu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:25:49 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)) 06:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:25:49 INFO - Running setup.py (path:/tmp/pip-DQA4xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:25:49 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)) 06:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:25:50 INFO - Running setup.py (path:/tmp/pip-bYo0kG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:25:50 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)) 06:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:25:50 INFO - Running setup.py (path:/tmp/pip-v1Lmr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:25:50 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)) 06:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:25:50 INFO - Running setup.py (path:/tmp/pip-_YPISl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:25:50 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)) 06:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:25:50 INFO - Running setup.py (path:/tmp/pip-CwHWzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:25:50 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)) 06:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:25:50 INFO - Running setup.py (path:/tmp/pip-WwCPTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:25:50 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)) 06:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:25:50 INFO - Running setup.py (path:/tmp/pip-ZcAYUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:25:50 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)) 06:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:25:50 INFO - Running setup.py (path:/tmp/pip-CULcOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:25:50 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)) 06:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:25:50 INFO - Running setup.py (path:/tmp/pip-u5Fzow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:25:50 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)) 06:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:25:50 INFO - Running setup.py (path:/tmp/pip-jxWBnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:25:50 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)) 06:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:25:50 INFO - Running setup.py (path:/tmp/pip-cMdjnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:25:50 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)) 06:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:25:50 INFO - Running setup.py (path:/tmp/pip-DxTT8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:25:50 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)) 06:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:50 INFO - Running setup.py (path:/tmp/pip-7M7YTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:50 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)) 06:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:25:50 INFO - Running setup.py (path:/tmp/pip-FHxnuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:25:50 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)) 06:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:25:50 INFO - Running setup.py (path:/tmp/pip-06DIdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:25:51 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)) 06:25:51 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)) 06:25:51 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)) 06:25:51 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)) 06:25:51 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)) 06:25:51 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)) 06:25:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:25:51 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 06:25:51 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 06:25:51 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 06:25:51 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 06:25:51 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 06:25:51 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 06:25:52 INFO - Downloading blessings-1.6.tar.gz 06:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:25:53 INFO - Installing collected packages: blessings 06:25:53 INFO - Running setup.py install for blessings 06:25:53 INFO - Successfully installed blessings 06:25:53 INFO - Cleaning up... 06:25:53 INFO - Return code: 0 06:25:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:25:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:25:53 INFO - Reading from file tmpfile_stdout 06:25:53 INFO - Current package versions: 06:25:53 INFO - argparse == 1.2.1 06:25:53 INFO - blessings == 1.6 06:25:53 INFO - blobuploader == 1.2.4 06:25:53 INFO - docopt == 0.6.1 06:25:53 INFO - functools32 == 3.2.3-2 06:25:53 INFO - jsonschema == 2.5.1 06:25:53 INFO - manifestparser == 1.1 06:25:53 INFO - mozInstall == 1.12 06:25:53 INFO - mozcrash == 0.17 06:25:53 INFO - mozdebug == 0.1 06:25:53 INFO - mozdevice == 0.48 06:25:53 INFO - mozfile == 1.2 06:25:53 INFO - mozhttpd == 0.7 06:25:53 INFO - mozinfo == 0.9 06:25:53 INFO - mozleak == 0.1 06:25:53 INFO - mozlog == 3.4 06:25:53 INFO - moznetwork == 0.27 06:25:53 INFO - mozprocess == 0.23 06:25:53 INFO - mozprofile == 0.28 06:25:53 INFO - mozrunner == 6.12 06:25:53 INFO - mozscreenshot == 0.1 06:25:53 INFO - mozsystemmonitor == 0.3 06:25:53 INFO - moztest == 0.7 06:25:53 INFO - mozversion == 1.4 06:25:53 INFO - psutil == 3.1.1 06:25:53 INFO - requests == 1.2.3 06:25:53 INFO - wsgiref == 0.1.2 06:25:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:53 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')]} 06:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:53 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')]} 06:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:53 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 0x7f4673e3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07930>, '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 0xe08830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe08cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', '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 06:25:53 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 06:25:53 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 06:25:53 INFO - Using env: {'DISPLAY': ':0', 06:25:53 INFO - 'HOME': '/home/cltbld', 06:25:53 INFO - 'LANG': 'en_US.UTF-8', 06:25:53 INFO - 'LANGUAGE': 'en_US:en', 06:25:53 INFO - 'LOGNAME': 'cltbld', 06:25:53 INFO - 'MAIL': '/var/mail/cltbld', 06:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:53 INFO - 'MOZ_NO_REMOTE': '1', 06:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:53 INFO - 'NO_EM_RESTART': '1', 06:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:53 INFO - 'PWD': '/builds/slave/test', 06:25:53 INFO - 'SHELL': '/bin/bash', 06:25:53 INFO - 'SHLVL': '1', 06:25:53 INFO - 'TERM': 'linux', 06:25:53 INFO - 'TMOUT': '86400', 06:25:53 INFO - 'USER': 'cltbld', 06:25:53 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', 06:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:53 INFO - '_': '/tools/buildbot/bin/python'} 06:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:53 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)) 06:25:53 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)) 06:25:53 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)) 06:25:53 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)) 06:25:53 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)) 06:25:53 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)) 06:25:53 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)) 06:25:53 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)) 06:25:53 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)) 06:25:53 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)) 06:25:53 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)) 06:25:53 INFO - Cleaning up... 06:25:53 INFO - Return code: 0 06:25:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:25:53 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')]} 06:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:53 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')]} 06:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:53 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 0x7f4673e3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07930>, '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 0xe08830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe08cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', '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 06:25:53 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 06:25:53 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 06:25:53 INFO - Using env: {'DISPLAY': ':0', 06:25:53 INFO - 'HOME': '/home/cltbld', 06:25:53 INFO - 'LANG': 'en_US.UTF-8', 06:25:53 INFO - 'LANGUAGE': 'en_US:en', 06:25:53 INFO - 'LOGNAME': 'cltbld', 06:25:53 INFO - 'MAIL': '/var/mail/cltbld', 06:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:53 INFO - 'MOZ_NO_REMOTE': '1', 06:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:53 INFO - 'NO_EM_RESTART': '1', 06:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:53 INFO - 'PWD': '/builds/slave/test', 06:25:53 INFO - 'SHELL': '/bin/bash', 06:25:53 INFO - 'SHLVL': '1', 06:25:53 INFO - 'TERM': 'linux', 06:25:53 INFO - 'TMOUT': '86400', 06:25:53 INFO - 'USER': 'cltbld', 06:25:53 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', 06:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:53 INFO - '_': '/tools/buildbot/bin/python'} 06:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:25:53 INFO - Cleaning up... 06:25:53 INFO - Return code: 0 06:25:53 INFO - Running post-action listener: _resource_record_post_action 06:25:53 INFO - Running post-action listener: _start_resource_monitoring 06:25:53 INFO - Starting resource monitoring. 06:25:53 INFO - [mozharness: 2016-10-15 13:25:53.892325Z] Finished create-virtualenv step (success) 06:25:53 INFO - [mozharness: 2016-10-15 13:25:53.892895Z] Running install step. 06:25:53 INFO - Running pre-action listener: _resource_record_pre_action 06:25:53 INFO - Running main action method: install 06:25:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:25:54 INFO - Reading from file tmpfile_stdout 06:25:54 INFO - Detecting whether we're running mozinstall >=1.0... 06:25:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:25:54 INFO - Reading from file tmpfile_stdout 06:25:54 INFO - Output received: 06:25:54 INFO - Usage: mozinstall [options] installer 06:25:54 INFO - Options: 06:25:54 INFO - -h, --help show this help message and exit 06:25:54 INFO - -d DEST, --destination=DEST 06:25:54 INFO - Directory to install application into. [default: 06:25:54 INFO - "/builds/slave/test"] 06:25:54 INFO - --app=APP Application being installed. [default: firefox] 06:25:54 INFO - mkdir: /builds/slave/test/build/application 06:25:54 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'] 06:25:54 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 06:26:11 INFO - Reading from file tmpfile_stdout 06:26:11 INFO - Output received: 06:26:11 INFO - /builds/slave/test/build/application/firefox/firefox 06:26:11 INFO - Running post-action listener: _resource_record_post_action 06:26:11 INFO - [mozharness: 2016-10-15 13:26:11.171709Z] Finished install step (success) 06:26:11 INFO - [mozharness: 2016-10-15 13:26:11.171954Z] Running run-tests step. 06:26:11 INFO - Running pre-action listener: _resource_record_pre_action 06:26:11 INFO - Running main action method: run_tests 06:26:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:26:11 INFO - Python 2.7.3 06:26:11 INFO - Return code: 0 06:26:11 INFO - grabbing minidump binary from tooltool 06:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:26:11 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 0xe07930>, '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 0xe08830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe08cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:26:11 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 06:26:11 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 06:26:11 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 06:26:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:26:11 INFO - Return code: 0 06:26:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:26:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:26:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:26:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:26:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:26:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 06:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 06:26:11 INFO - Using env: {'DISPLAY': ':0', 06:26:11 INFO - 'HOME': '/home/cltbld', 06:26:11 INFO - 'LANG': 'en_US.UTF-8', 06:26:11 INFO - 'LANGUAGE': 'en_US:en', 06:26:11 INFO - 'LOGNAME': 'cltbld', 06:26:11 INFO - 'MAIL': '/var/mail/cltbld', 06:26:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:26:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:11 INFO - 'MOZ_NO_REMOTE': '1', 06:26:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:11 INFO - 'NO_EM_RESTART': '1', 06:26:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:26:11 INFO - 'PWD': '/builds/slave/test', 06:26:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:26:11 INFO - 'SHELL': '/bin/bash', 06:26:11 INFO - 'SHLVL': '1', 06:26:11 INFO - 'TERM': 'linux', 06:26:11 INFO - 'TMOUT': '86400', 06:26:11 INFO - 'USER': 'cltbld', 06:26:11 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642', 06:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:11 INFO - '_': '/tools/buildbot/bin/python'} 06:26:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 06:26:11 INFO - mozversion application_buildid: 20161015033004 06:26:11 INFO - mozversion application_changeset: 44b01519b5668699f2c1a10d362445be59711d35 06:26:11 INFO - mozversion application_display_name: Nightly 06:26:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:26:11 INFO - mozversion application_name: Firefox 06:26:11 INFO - mozversion application_remotingname: firefox 06:26:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:26:11 INFO - mozversion application_vendor: Mozilla 06:26:11 INFO - mozversion application_version: 52.0a1 06:26:11 INFO - mozversion platform_buildid: 20161015033004 06:26:11 INFO - mozversion platform_changeset: 44b01519b5668699f2c1a10d362445be59711d35 06:26:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:26:11 INFO - mozversion platform_version: 52.0a1 06:26:11 INFO - using testdate: 1476537971 06:26:11 INFO - actual date: 1476537971 06:26:11 INFO - starting webserver on 'localhost:35887' 06:26:11 INFO - SUITE-START | Running 2 tests 06:26:11 INFO - TEST-START | dromaeo_css 06:26:11 INFO - operating with platform_type : linux_ 06:26:11 INFO - Initialising browser for dromaeo_css test... 06:26:11 INFO - TEST-INFO | started process 17009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa_fAmh/profile http://localhost:35887/getInfo.html) 06:26:15 INFO - PROCESS | 17009 | __metrics Screen width/height:1600/1200 06:26:15 INFO - PROCESS | 17009 | colorDepth:24 06:26:15 INFO - PROCESS | 17009 | Browser inner width/height: 1024/697 06:26:15 INFO - PROCESS | 17009 | __metrics 06:26:15 INFO - PROCESS | 17009 | 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" 06:26:15 INFO - PROCESS | 17009 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:26:16 INFO - PROCESS | 17009 | console.error: PushService: 06:26:16 INFO - PROCESS | 17009 | stateChangeProcessEnqueue: Error transitioning state 06:26:16 INFO - PROCESS | 17009 | UnknownError 06:26:17 INFO - TEST-INFO | 17009: exit 0 06:26:17 INFO - Browser initialized. 06:26:17 INFO - Running cycle 1/1 for dromaeo_css test... 06:26:17 INFO - TEST-INFO | started process 17094 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa_fAmh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:26:29 INFO - PROCESS | 17094 | RSS: Main: 171913216 06:26:29 INFO - PROCESS | 17094 | 06:27:20 INFO - PROCESS | 17094 | 1476538040521 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] 06:29:31 INFO - PROCESS | 17094 | Cycle 1(1): loaded http://localhost:35887/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35887/tests/dromaeo/cssquery-ext.html) 06:29:33 INFO - PROCESS | 17094 | RSS: Main: 283480064 06:29:33 INFO - PROCESS | 17094 | 06:32:35 INFO - PROCESS | 17094 | Cycle 1(1): loaded http://localhost:35887/tests/dromaeo/cssquery-ext.html (next: http://localhost:35887/tests/dromaeo/cssquery-jquery.html) 06:32:36 INFO - PROCESS | 17094 | RSS: Main: 281157632 06:32:36 INFO - PROCESS | 17094 | 06:35:38 INFO - PROCESS | 17094 | Cycle 1(1): loaded http://localhost:35887/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35887/tests/dromaeo/cssquery-mootools.html) 06:35:39 INFO - PROCESS | 17094 | RSS: Main: 257191936 06:35:39 INFO - PROCESS | 17094 | 06:38:41 INFO - PROCESS | 17094 | Cycle 1(1): loaded http://localhost:35887/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35887/tests/dromaeo/cssquery-prototype.html) 06:38:41 INFO - PROCESS | 17094 | RSS: Main: 216846336 06:38:41 INFO - PROCESS | 17094 | 06:41:44 INFO - PROCESS | 17094 | Cycle 1(1): loaded http://localhost:35887/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35887/tests/dromaeo/cssquery-yui.html) 06:41:44 INFO - PROCESS | 17094 | RSS: Main: 218980352 06:41:44 INFO - PROCESS | 17094 | 06:44:47 INFO - PROCESS | 17094 | Cycle 1(1): loaded http://localhost:35887/tests/dromaeo/cssquery-yui.html (next: http://localhost:35887/tests/dromaeo/cssquery-dojo.html) 06:44:48 INFO - PROCESS | 17094 | RSS: Main: 305991680 06:44:48 INFO - PROCESS | 17094 | 06:44:48 INFO - PROCESS | 17094 | __start_tp_report 06:44:48 INFO - PROCESS | 17094 | _x_x_mozilla_page_load 06:44:48 INFO - PROCESS | 17094 | _x_x_mozilla_page_load_details 06:44:48 INFO - PROCESS | 17094 | |i|pagename|runs| 06:44:48 INFO - PROCESS | 17094 | |0;dojo.html;2955.6748757636665;3055.991522797476;3056.1137270191643;3091.3199096198828;3109.067279816056;5014.84955451337;5089.083964886319;5245.134552798789;5310.4424035476295;5358.41057483677;5126;5142.280080788683;5145;5145.253938178962;5156.922646160301;4611.146937816507;4631.745254011028;4646.326282689008;4677.204875171229;4708.929366059495;4690.9296360554445;4723.14983303007;4729.692569982957;4732.124556956956;4734.431868175807;4634.328022436762;4645.27998160284;4679.344891715163;4692.36653051837;4722.50413706561;4696.600788932962;4702.952970470285;4728.929066064012;4736.171170045228;4787.976060119712;4588.2888152336445;4625.791839367203;4649.139909116824;4676.719396836201;4707.917179048838;5211.895762084737;5227.712475813829;5228.660137091077;5248.239005344204;5321.388040375329;5593.161025846115;5613.382527921966;5644.294463192101;5645.830625081254;5649.378568357477;5399.379071406799;5541.889162216733;5557.6109672322955;5708.315002199721;5766.452187042224;5237.188235823453;5239.764210610531;5257.08001099806;5322.20166974953;5327.147656374961;5686.0333743263745;5697.800576979786;5709.314882214161;5717.342505611908;5723.742431590588;5232.450592687789;5352.250684904038;5456.317960254968;5466.125419932871;5527.640703354269;5441.5374693151525;5494.066008778517;5507.03626865297;5571.331440227118;5573.804916827891;5454.59090568209;5501.642393244426;5503.669779813144;5506.779728810883;5507.476789704971;5412.972935135378;5445.782168713286;5456.863578410572;5517.44825517445;5578.665280083208;4284.485861696554;4288.35674648799;4308.202982448257;4320.870373888788;4367.039251364695;3851.8266677998995;3859.8842034739005;3862.0731024553907;3900.1029763154634;3908.472356231929;5312.3890752563175;5327.573794096463;5329.706866122323;5331.840044798585;5333.306670132858;5314.202869569518;5349.170878513759;5355.651882627694;5563.443655634485;5586.91619625706;5352.384475785335;5364.678119312854;5405.7837686492885;5408.242846001563;5419.756110975016;4842.58837998774;4851.417829860368;4852.514748525119;4855.101806165871;4875.24433712775;5566.721663916707;5805.129230615442;5828.417158284137;5852.561057920673;5867.178594996619;5366.758495867617;5545.057340252086;5600;5604.6917419542315;5696.458836410535;5830.854228644148;5830.883382332415;5832.066869300891;5833.329167145663;5839.270091238595;5502.009638265151;5502.8349149525575;5507.862303442446;5514.972425137848;5560.082586373203;5329.067413202752;5417.6478528895495;5468.070428027325;5536.307961504812;5568.832935011957;5432;5465.098258787415;5466.289382380265;5481.0408178567795;5521.613487055867;5433.673979561081;5444.809431670031;5445.391863253426;5446.428125046813;5517.2275881377445;5294.814681486129;5336.519713225828;5443.346798384219;5459.617826752089;5530.91703624454;5580.916286255629;5584.46947539983;5585.664860108406;5619.80330688424;5652.943470565242;5188.948110518846;5438.184272359178;5455.208994695826;5455.536279416294;5456.372517160577 06:44:48 INFO - PROCESS | 17094 | |1;ext.html;559.2556317335946;585.698365341849;600.7446835095084;604.7308947518351;609.8079105081899;31762.20594485139;42932.78533607331;43947.34078988818;44023.616575596556;47116.293255601195;45219.77390113045;45609;45612.54387456133;45641.31538026932;45643.543564564425;7831.960840195791;8813.91186088139;8941.061188575204;8977.102289771003;8981.730548083535;8004.919950800476;10381.325213861075;10627.043566079052;10642.09542188911;10988.780224395507;10795.622153224638;10824.24230303879;10843.240973131844;10847.51186196623;10865.728356791104;10692.411917344543;10750.354978701225;10756.354618722902;10761.408122553257;10768.946155269212;10487.79024419515;10540.209484288709;10545.261831671785;10548.578056877715;10549.947250263776;40912.38631420531;41433.79283103565;41500;41509.584904151176;41548.169036619096;3223.2425380035675;3686.262747450494;4077.3680079587416;4090.2637525245445;4119.155573107506;31445.685543144733;32325.51511727326;32543.51184732231;33775;33788.6621133788;3654.963450365489;3739.9813000934823;3748.7938163401004;3755.0800053986677;3872.5740168581433;315032;317378;317893;319585;319762;59170.408295917354;59700.402995970355;59703.70148149232;59874.70062649659;60086.39913600896;64486;64511.354886450536;64557;64608.35391646117;64665.67667161634;15789.763153552705;15888.92055539738;15895.443659471863;16013;16022.359105635876;10285.228607854291;10522.105621022145;10995.945020274847;11439.084873210124;11467.942660286812;18654.626907461774;19336.226550937805;19377;19392.515187120436;19402.223911043682;5702.287214098238;6938.410235130071;7071.29287071299;7099.858002839915;7165;874.6851133591902;920.7007722490083;986.8223719730518;1081.0486771640906;1096.3641088168843;31538.526922096185;32272.35455290881;32318.676813232036;32617;32771.28539287894;1070.3684825952726;1073.7959787640323;1078.8435676826816;1079.2337440417234;1136.494260054268;15742.606434838992;16696.332146714238;16849.41027064047;16872.57818554546;17100.230489627997;495067;500455;500555;500834;501370;56675.71662141745;57208.42791572114;57224.141637875466;57235.713821430625;57237.71381143151;1169.4445138559117;1221.2367270455966;1223.4127618743053;1277.6486466221863;1313.3630189358153;29989.41304531553;34924.30151397009;34987.65012349844;35011.82494087513;35238;54716.45283547273;55480;55533.44466555283;55551;55570.72214638901;432598;435608;435967;437786;438279;26958.865205673847;27550.44899102047;27659.861700691366;27737.861310694123;29092.418151637274;34177.487337689454;40153.39769903395;42028.57971420369;43983.78008109939;49320.91424231288;38783;40070.599294006686;40387.798061009504;41138.588614113476;41918.790406047774;41139.38290925699;42338.364924525544;42407.36388954106;42639.36040959326;42773.786131069144;43384.566154339314;43433.3484997719;44391.55608444003;44589.55410445854;44698.55301446944;34152.316953661284;36806.39001211581;36852.262954741294;37477;37544.62455375411;28121.98619835052;28223.93185465135;28483.715162848108;28493.715062849107;28694 06:44:48 INFO - PROCESS | 17094 | |2;jquery.html;372.2369143256322;381.99809000954997;382.2660491855636;405.4951585276331;406.51421551246256;14282.285885705725;14952.327145278461;17053.232604532794;19433.611327773455;19993.900030499844;15232.923835380807;17895.19471623777;18289.54276143097;19024.61950760984;19095.331663391786;5481.12302031675;5726.7422965966425;5732.31212254528;5733.369329373786;5734.541236701075;5401.540869026117;5671.546276297886;5689.459501347365;5694.373618901917;5695.487406133447;4020.8190631421658;4206.936895946563;5663;6046.183765191687;6299.307076221612;6134.478569321613;6404.839879003039;6408.551401401857;6416.743330266784;6418.93581064188;5451.427600102012;5483.204935284361;5488.313960754906;5490.396056433789;5492.752826122834;21811.345659630235;22168.445788855246;22307.665385019238;22352.55294894109;22632.43418914524;2003.769566499842;2083.812456878888;2089.540301133748;2265.8187345012525;2415.7221919479134;9720.319577629569;10138.9493052535;10603.628872989408;10743.677689669323;12137.817932731015;1880.548668319607;1925.5089952062274;1928.2190712761214;1967.6950072738748;1984.9503762405911;71861.28138718651;73263.63368183126;83210;84723;87211.56394218052;10501.31741436804;10549.525271362807;10595.84106238407;11016.504257308441;11025.692292312275;15010.273818510792;15025.098494090389;15033.323500442506;15043.473478428203;15047.623809404633;6853.554518956252;7126.429885609243;7184.497085203986;7251.746188883364;7364.852702945911;6557.344265573404;6628.370304821035;6756.358145976124;6773.695183716744;6809.38715515606;4560.224761790503;4590.67865249436;4614.838480653161;4673.088747694167;4745.6440766942615;1886.735856980024;1896.4310706787908;1940.474238788616;1977.4364306172672;1999.3502111813427;932.379967321737;938.6996161228478;943.9008904065112;944.8866136063579;992.806402751471;18423.52812355339;19942.20231190765;19954.20183192685;20070.19719211215;20341;940.9012053734397;941.152962333905;943.9575219115156;992.3946392700446;1002.1932344462632;10274.178065754722;10920.617778377718;10959.83560246597;10960.671179864617;11057.668269951915;434458;442442;444260;445136;445319;82669.58665206756;84465;84592.57703711442;85227;85746.5712671445;932.5943214701762;979.5151400057017;995.0645595493323;995.1740055753708;1000.2198285337448;16750.664986699954;17020.829791701923;17499.21253543619;17559.1220438975;17856.107194639957;40023;40618.1876362477;40702.59297406988;40738;41356.58643413648;54149;56365.436345636015;56400;56402;56540.43459565516;8309.320583844672;8454.281386082252;8495.108013658477;8515.74452766418;8723.476591404537;10502.894971050191;12817.935910320388;13233.536826211037;13383.39774710121;13445;10626.574937002433;11287.266327689002;11445.427728613702;11468.770624587629;11476.770464590494;11436.256643318158;11496.195266331277;11662.650120496399;11689.824652630388;11822.881771182178;11873.643790686294;11972.820407694066;12099.75800484003;12311.076669249664;12345.197562158432;7369.299916507923;8344.040435350013;8743.12568743146;8769.605367758339;9014.684486042957;10069.949650251701;11677.941610291895;11797.17419780607;12234.388280585757;12322.507099715911 06:44:48 INFO - PROCESS | 17094 | |3;mootools.html;1339.6375098502756;1474.7640377539597;1508.8868334874883;1668.6662667466503;1811.4927820210346;7754.8836767448465;8385.664573417063;8761.080086590911;9104.13510716481;9106.225970792473;9050.411723237985;9122.179003889649;9129.634814607425;9133;9139.497327646977;2254.830887683426;2262.886855657219;2275.8862056897174;2275.8975846086964;2280.407094155515;2193.8683678979232;2225.121077174515;2231.107556977206;2232.531168454618;2239.0595949701083;2178.7603363629987;2200.9449763755956;2208.558288342338;2212.3694746997107;2248.6964259824877;2117.3542069668747;2140.753813311466;2144.2280778919653;2147.6671115977047;2155.665871789875;2156.277646988261;2158.816500597451;2162.9891850540803;2172.3374370816896;2172.750133734625;8973.730788076367;9112.225460835836;9147.268218542567;9165.17513423795;9181.265498760149;5173.405058418292;5336.039512887679;5352.304200453955;5357.973210133924;5361.544268737162;3221.951670724941;3433.2790114076074;3445.5176275321473;3481.704055155315;3506.50908872758;947.7630592351912;1007.4056306779036;1009.5204777730593;1020.5611587017579;1020.5764607687801;12182.573609923698;12305.938470307681;12334.81497777534;12335.876641233652;12345.13584049117;4182.121754431603;4300.37644541546;4373.343998400202;4415.712978656377;4429.180601588717;9684.757881052888;9691.854622180674;9696.903030969741;9697.612095516242;9706.90293097074;5069.290299358093;5100.336956195671;5114.105031619526;5115.462876397924;5141.948580514222;4059.3505039193587;4128.938065929014;4778.37881075458;4801.975990120027;4946.851594452172;3520.2783429396914;3611.3680105981875;3680.815959202083;3714.4428335749312;3720;1039.153090231459;1047.2983101322131;1049.6850944716555;1053.9420331881668;1065.6962765611918;774.2412435812935;911.7355966769562;972.9270304727174;981.7202097402206;990.9108180263811;6031.909521357183;6041.667708276087;6156.384361563808;6164.4143806338325;6193.975531204174;419.2223425545569;424.757888003841;425.94888613366595;429.09675133843433;431.2044278306519;4198.85304014358;4344.500382455994;4352.107817897323;4357.237483440385;4357.978210108992;11145.72135696614;11441;11474.368909710047;11476.655700329004;11506.827397589042;11398;11413.144014198968;11425.200235983568;11425.771484570261;11440.599579014695;8054.154313797084;8401.495910245405;8414.495130292202;8630.352723545759;8633.91366086331;6041.395860413923;6206.131141640264;6237.126802247598;6266.373362663697;6516.120323756422;10166.440845753259;10491.580336786748;10515.421651809223;10535.789284214427;10656.413897235727;10775.6228532001;10785.946070269598;10788.730281743019;10797.190210734068;10939.179561532757;7804.570748608881;7942.245486678757;7990.84018319642;8006.719764808204;8069.354451643737;8648.78378040554;8681.739547813575;8700.521471319138;8731.476111433334;8784.385093043426;7765.339946104645;7864.5281283123195;7911;8018.278354947849;8067.193280671886;7480.663370148248;7525.736599219001;7585.886211706939;7660.195679453577;7711.768646940601;6973.3375329343635;7071.964640176766;7104.218535960937;7116.359527642537;7121.323474269936;5337.759800808895;5351.785928562814;5433.565314774887;5435.945640543544;5578.497935185853;5455.099908515051;5477.698726569917;5494.423085575957;5560.221568980265;5703.20155178267 06:44:48 INFO - PROCESS | 17094 | |4;prototype.html;320.46002485811397;325;335.3193018173109;337.8006975884228;338.4770529531873;5280.1551751719735;5288.629795914278;5289.5503882170015;5293.735313234342;5333.280007199027;5128.5640720538795;5162.418790604697;5233;5234.162533994561;5252.52727254547;3853.7880416577077;4083.4074710862715;4090.734102283357;4096.9795151024355;4101.835926562934;4013.257547353749;4041.696872734542;4058.3100872851537;4075.6535694466006;4093.8302699569126;3972.1857019311115;3976.6818654507715;3988.501437320335;4011.5787842276577;4022.979885100585;3747.1381582235967;3869.3228684980018;3888.591697871711;3975.5030621172355;3976.602339766029;3503.91240218994;3513.9106876868254;3518.7712798668263;3519.6128425873135;3525.629808870083;5007.349044624212;5014.323066386028;5014.373203349582;5024.522670346311;5064.873378165538;4328.870133895988;4334.45819272591;4590.977045114753;4616.8153273869;4622.468416132154;5326;5368.489993450616;5390.218418329359;5392.514673679349;5463.890722185534;3944.6055394460614;3950.4864367632313;3951.5258169019903;3954.4266081418323;3959.089409435846;5379.623426360156;5556.194351818964;5630.746616402272;5645.774169033234;5658.830235092953;3964.345882929342;3975.900602484961;3983.601639836051;3989.8204580793936;4003.3994900764537;4047.838086476567;4050.1292222172374;4050.9797451012555;4053.777042262645;4056.229316429869;4527.615152712056;4596.448426188878;4638.628909687284;4643.326717625925;4655.255159174516;5420.349558053059;5424.050791111618;5425.864353391118;5429.83710488678;5434.83695489136;1379.1518216296904;1386.8821150202143;1392.004716627616;1397.6226418867052;1397.9585209019347;854.7734850264685;906.2297047509564;909.481595490564;922.8246633139682;927.7541451515353;4662.673612847136;4695.178343789823;4701.519021508282;4708.86987123088;4716.834910778106;4871.249138163595;4903.828366007173;4918.778654960535;4961.3798275215595;4967.900641987212;4433.490148632948;4687.273472611751;4698.919248572847;4727.645426592951;4753.35829662998;2632.9868350658126;2855.328997685542;2893.594896714462;2896.493113705093;2944.2492164497917;5757.971210144006;5760.337561180518;5780.826575202751;5795.304563452329;5820.417958204146;5520.66875987442;5600.991821472093;5631.662100273915;5692.459216374521;5723.570732195102;5647.463490968352;5732.3407808101765;5764.685305949012;5778.3643799182055;5785.681787501728;5586.38549759518;5607.719614019201;5629.943700563106;5675.035244008446;5677.403872593318;5370.462953704755;5501.202325662836;5531.3362396512675;5532.778688852401;5534.861628459321;5733.369329373849;5773.826785196451;5786.594938354275;5790.392008839011;5800.883982320414;4059.208454351491;4063.674906007453;4097.85657501998;4098.262312783728;4102.425660407485;5400.864978375572;5457.799284157479;5487.368952570346;5492.945070549403;5528.917066243929;5358.732063396893;5369.54358879484;5387.191921211849;5405.594580406407;5435.701036443033;5168.952325778923;5240.371155461369;5413.431589683027;5425.728713564385;5471.261379713687;5272.762725677277;5281.524662780368;5315.601329900195;5330.866728331823;5334.226537152013;5365.731713414236;5371.409144994126;5377.435369286325;5440.374356949002;5470.288862447856;5040.891003979119;5284.788608455772;5303.416624171261;5303.912697896999;5312.150055991023 06:44:48 INFO - PROCESS | 17094 | |5;yui.html;712.7647876200854;753.9849203015937;787.7400457848911;792.3027735592677;862.2627653356382;14986.175760333192;16319.673606527862;16412.09733464659;16453;16524.917375413122;15878.84121158788;16362.181890905467;16446.75329870053;16448.67102657946;16475.83524164758;808.3412019204329;829.7718127514921;832.3507664022072;832.4755404095441;833.3874602167402;672.8721542906832;705.1291654806311;793.6428607126816;826.1325608111489;831.1688311688312;865.074370423647;867.6746220167437;868.6438560190323;874.2918236228675;874.623911717961;869.0049892872657;869.4696235296464;869.8434281829268;870.0386073388878;870.3907264914585;511.4144304771053;529.6292595183348;606.9136246119441;635.240887139868;639.2009987515605;14797.704045919021;14882.479113231093;14884.553463396116;14917.552473425814;14953.551393458214;13624.795628065587;13884;14111.929440352835;14343;14391.280435978158;12649.936750316281;12726;12777.488900444065;12927.15973461722;12975.1566148201;4408.4709834819705;4422.469303683579;4422.889427764299;4539.046800171968;4697.224957881946;75432.99999999945;75493.24506754972;75785.17933386021;78085.60957195234;78303;11321.603743868925;11343.886561134448;11397.487113079931;11448.885511144948;11656.30062196271;20660.690089648666;20723.896380518;20780.376588702362;20831.687524687142;20843;8180.877286840702;8231.300339471092;8387.83224335522;8500.319974402033;8666.826663466696;4487.5288094749585;4521.89499365186;4575.336576196433;4639.025804581008;4707.78814953321;3352.8491217895253;3436.415809312423;3458.688718015391;3458.913527161841;3470.444728843373;609.2110716621985;612.574260888678;618.2735286038976;634.5875181132301;637.4422380417135;581.9243498345188;626.8276224038426;670.7892254480612;689.9896501552481;690.8652812701575;8684.6526138955;8954.641814327484;9077.973395737165;9085.318601104944;9222.799478971803;594.3343455330058;594.3610618585038;599.6012651586733;605.1618508365945;620.6431302001367;4152.960731560037;4316.762578058174;4373.562643735601;4427.690061695715;4480.215962206666;117535;117609;119279;121338;122428.38785806014;66542.66728666326;80481.59759201166;80940.19059809444;103691.4815425918;104867.4756626212;76612;79083.20916790873;80109;81649;84660;9069.183773460156;9298.209652179641;9405.247580193705;9423.953502259212;9439.339246252972;44617.55382446134;47040;47052.53000964903;47625.28562071641;48451.75774121107;63030.36969630428;63474;68478;70657.64671176611;71227.64386178037;11756.470958807045;11813.527458901548;12220.633380998584;12422.937885310515;12577.748445031231;13544.525941591997;14255.429782808571;14403.927980360031;14696.338664759898;15111.924440377728;12863.163894347212;13058.477660893457;13177.604671859859;13270.805627493572;13782.793258100935;13150.276734779296;13952.511662091778;13963;14305.141691498544;14359.138451692932;13954.58136255914;14246.928765356108;14383.928080359532;14561;15097.452098756563;11349.659510214708;11652.417379131179;11675.474603642686;11831.52673893069;12617.43221555014;10719.732006699895;11773.470193841127;11940.880591193976;12087.153899226969;12368.319742413894 06:44:48 INFO - PROCESS | 17094 | __end_tp_report 06:44:48 INFO - PROCESS | 17094 | __start_cc_report 06:44:48 INFO - PROCESS | 17094 | _x_x_mozilla_cycle_collect,1054 06:44:48 INFO - PROCESS | 17094 | __end_cc_report 06:44:48 INFO - PROCESS | 17094 | __startTimestamp1476539088089__endTimestamp 06:44:48 INFO - PROCESS | 17094 | 06:44:48 INFO - PROCESS | 17094 | ------- Summary: start ------- 06:44:48 INFO - PROCESS | 17094 | Number of tests: 6 06:44:48 INFO - PROCESS | 17094 | 06:44:48 INFO - PROCESS | 17094 | [#0] dojo.html Cycles:165 Average:5178.62 Median:5399.38 stddev:583.40 (10.8%) stddev-sans-first:558.52 06:44:48 INFO - PROCESS | 17094 | Values: 2955.7 3056.0 3056.1 3091.3 3109.1 5014.8 5089.1 5245.1 5310.4 5358.4 5126.0 5142.3 5145.0 5145.3 5156.9 4611.1 4631.7 4646.3 4677.2 4708.9 4690.9 4723.1 4729.7 4732.1 4734.4 4634.3 4645.3 4679.3 4692.4 4722.5 4696.6 4703.0 4728.9 4736.2 4788.0 4588.3 4625.8 4649.1 4676.7 4707.9 5211.9 5227.7 5228.7 5248.2 5321.4 5593.2 5613.4 5644.3 5645.8 5649.4 5399.4 5541.9 5557.6 5708.3 5766.5 5237.2 5239.8 5257.1 5322.2 5327.1 5686.0 5697.8 5709.3 5717.3 5723.7 5232.5 5352.3 5456.3 5466.1 5527.6 5441.5 5494.1 5507.0 5571.3 5573.8 5454.6 5501.6 5503.7 5506.8 5507.5 5413.0 5445.8 5456.9 5517.4 5578.7 4284.5 4288.4 4308.2 4320.9 4367.0 3851.8 3859.9 3862.1 3900.1 3908.5 5312.4 5327.6 5329.7 5331.8 5333.3 5314.2 5349.2 5355.7 5563.4 5586.9 5352.4 5364.7 5405.8 5408.2 5419.8 4842.6 4851.4 4852.5 4855.1 4875.2 5566.7 5805.1 5828.4 5852.6 5867.2 5366.8 5545.1 5600.0 5604.7 5696.5 5830.9 5830.9 5832.1 5833.3 5839.3 5502.0 5502.8 5507.9 5515.0 5560.1 5329.1 5417.6 5468.1 5536.3 5568.8 5432.0 5465.1 5466.3 5481.0 5521.6 5433.7 5444.8 5445.4 5446.4 5517.2 5294.8 5336.5 5443.3 5459.6 5530.9 5580.9 5584.5 5585.7 5619.8 5652.9 5188.9 5438.2 5455.2 5455.5 5456.4 06:44:48 INFO - PROCESS | 17094 | 06:44:48 INFO - PROCESS | 17094 | [#1] ext.html Cycles:180 Average:58664.19 Median:20612.90 stddev:112315.07 (544.9%) stddev-sans-first:112545.41 06:44:48 INFO - PROCESS | 17094 | Values: 559.3 585.7 600.7 604.7 609.8 31762.2 42932.8 43947.3 44023.6 47116.3 45219.8 45609.0 45612.5 45641.3 45643.5 7832.0 8813.9 8941.1 8977.1 8981.7 8004.9 10381.3 10627.0 10642.1 10988.8 10795.6 10824.2 10843.2 10847.5 10865.7 10692.4 10750.4 10756.4 10761.4 10768.9 10487.8 10540.2 10545.3 10548.6 10549.9 40912.4 41433.8 41500.0 41509.6 41548.2 3223.2 3686.3 4077.4 4090.3 4119.2 31445.7 32325.5 32543.5 33775.0 33788.7 3655.0 3740.0 3748.8 3755.1 3872.6 315032.0 317378.0 317893.0 319585.0 319762.0 59170.4 59700.4 59703.7 59874.7 60086.4 64486.0 64511.4 64557.0 64608.4 64665.7 15789.8 15888.9 15895.4 16013.0 16022.4 10285.2 10522.1 10995.9 11439.1 11467.9 18654.6 19336.2 19377.0 19392.5 19402.2 5702.3 6938.4 7071.3 7099.9 7165.0 874.7 920.7 986.8 1081.0 1096.4 31538.5 32272.4 32318.7 32617.0 32771.3 1070.4 1073.8 1078.8 1079.2 1136.5 15742.6 16696.3 16849.4 16872.6 17100.2 495067.0 500455.0 500555.0 500834.0 501370.0 56675.7 57208.4 57224.1 57235.7 57237.7 1169.4 1221.2 1223.4 1277.6 1313.4 29989.4 34924.3 34987.7 35011.8 35238.0 54716.5 55480.0 55533.4 55551.0 55570.7 432598.0 435608.0 435967.0 437786.0 438279.0 26958.9 27550.4 27659.9 27737.9 29092.4 34177.5 40153.4 42028.6 43983.8 49320.9 38783.0 40070.6 40387.8 41138.6 41918.8 41139.4 42338.4 42407.4 42639.4 42773.8 43384.6 43433.3 44391.6 44589.6 44698.6 34152.3 36806.4 36852.3 37477.0 37544.6 28122.0 28223.9 28483.7 28493.7 28694.0 06:44:48 INFO - PROCESS | 17094 | 06:44:48 INFO - PROCESS | 17094 | [#2] jquery.html Cycles:180 Average:27158.75 Median:2213.16 stddev:73047.36 (3300.6%) stddev-sans-first:73224.59 06:44:48 INFO - PROCESS | 17094 | Values: 372.2 382.0 382.3 405.5 406.5 14282.3 14952.3 17053.2 19433.6 19993.9 15232.9 17895.2 18289.5 19024.6 19095.3 5481.1 5726.7 5732.3 5733.4 5734.5 5401.5 5671.5 5689.5 5694.4 5695.5 4020.8 4206.9 5663.0 6046.2 6299.3 6134.5 6404.8 6408.6 6416.7 6418.9 5451.4 5483.2 5488.3 5490.4 5492.8 21811.3 22168.4 22307.7 22352.6 22632.4 2003.8 2083.8 2089.5 2265.8 2415.7 9720.3 10138.9 10603.6 10743.7 12137.8 1880.5 1925.5 1928.2 1967.7 1985.0 71861.3 73263.6 83210.0 84723.0 87211.6 10501.3 10549.5 10595.8 11016.5 11025.7 15010.3 15025.1 15033.3 15043.5 15047.6 6853.6 7126.4 7184.5 7251.7 7364.9 6557.3 6628.4 6756.4 6773.7 6809.4 4560.2 4590.7 4614.8 4673.1 4745.6 1886.7 1896.4 1940.5 1977.4 1999.4 932.4 938.7 943.9 944.9 992.8 18423.5 19942.2 19954.2 20070.2 20341.0 940.9 941.2 944.0 992.4 1002.2 10274.2 10920.6 10959.8 10960.7 11057.7 434458.0 442442.0 444260.0 445136.0 445319.0 82669.6 84465.0 84592.6 85227.0 85746.6 932.6 979.5 995.1 995.2 1000.2 16750.7 17020.8 17499.2 17559.1 17856.1 40023.0 40618.2 40702.6 40738.0 41356.6 54149.0 56365.4 56400.0 56402.0 56540.4 8309.3 8454.3 8495.1 8515.7 8723.5 10502.9 12817.9 13233.5 13383.4 13445.0 10626.6 11287.3 11445.4 11468.8 11476.8 11436.3 11496.2 11662.7 11689.8 11822.9 11873.6 11972.8 12099.8 12311.1 12345.2 7369.3 8344.0 8743.1 8769.6 9014.7 10069.9 11677.9 11797.2 12234.4 12322.5 06:44:48 INFO - PROCESS | 17094 | 06:44:48 INFO - PROCESS | 17094 | [#3] mootools.html Cycles:180 Average:5852.04 Median:4603.78 stddev:3448.53 (74.9%) stddev-sans-first:3441.53 06:44:48 INFO - PROCESS | 17094 | Values: 1339.6 1474.8 1508.9 1668.7 1811.5 7754.9 8385.7 8761.1 9104.1 9106.2 9050.4 9122.2 9129.6 9133.0 9139.5 2254.8 2262.9 2275.9 2275.9 2280.4 2193.9 2225.1 2231.1 2232.5 2239.1 2178.8 2200.9 2208.6 2212.4 2248.7 2117.4 2140.8 2144.2 2147.7 2155.7 2156.3 2158.8 2163.0 2172.3 2172.8 8973.7 9112.2 9147.3 9165.2 9181.3 5173.4 5336.0 5352.3 5358.0 5361.5 3222.0 3433.3 3445.5 3481.7 3506.5 947.8 1007.4 1009.5 1020.6 1020.6 12182.6 12305.9 12334.8 12335.9 12345.1 4182.1 4300.4 4373.3 4415.7 4429.2 9684.8 9691.9 9696.9 9697.6 9706.9 5069.3 5100.3 5114.1 5115.5 5141.9 4059.4 4128.9 4778.4 4802.0 4946.9 3520.3 3611.4 3680.8 3714.4 3720.0 1039.2 1047.3 1049.7 1053.9 1065.7 774.2 911.7 972.9 981.7 990.9 6031.9 6041.7 6156.4 6164.4 6194.0 419.2 424.8 425.9 429.1 431.2 4198.9 4344.5 4352.1 4357.2 4358.0 11145.7 11441.0 11474.4 11476.7 11506.8 11398.0 11413.1 11425.2 11425.8 11440.6 8054.2 8401.5 8414.5 8630.4 8633.9 6041.4 6206.1 6237.1 6266.4 6516.1 10166.4 10491.6 10515.4 10535.8 10656.4 10775.6 10785.9 10788.7 10797.2 10939.2 7804.6 7942.2 7990.8 8006.7 8069.4 8648.8 8681.7 8700.5 8731.5 8784.4 7765.3 7864.5 7911.0 8018.3 8067.2 7480.7 7525.7 7585.9 7660.2 7711.8 6973.3 7072.0 7104.2 7116.4 7121.3 5337.8 5351.8 5433.6 5435.9 5578.5 5455.1 5477.7 5494.4 5560.2 5703.2 06:44:48 INFO - PROCESS | 17094 | 06:44:48 INFO - PROCESS | 17094 | [#4] prototype.html Cycles:180 Average:4516.33 Median:5096.72 stddev:1327.62 (26.0%) stddev-sans-first:1293.46 06:44:48 INFO - PROCESS | 17094 | Values: 320.5 325.0 335.3 337.8 338.5 5280.2 5288.6 5289.6 5293.7 5333.3 5128.6 5162.4 5233.0 5234.2 5252.5 3853.8 4083.4 4090.7 4097.0 4101.8 4013.3 4041.7 4058.3 4075.7 4093.8 3972.2 3976.7 3988.5 4011.6 4023.0 3747.1 3869.3 3888.6 3975.5 3976.6 3503.9 3513.9 3518.8 3519.6 3525.6 5007.3 5014.3 5014.4 5024.5 5064.9 4328.9 4334.5 4591.0 4616.8 4622.5 5326.0 5368.5 5390.2 5392.5 5463.9 3944.6 3950.5 3951.5 3954.4 3959.1 5379.6 5556.2 5630.7 5645.8 5658.8 3964.3 3975.9 3983.6 3989.8 4003.4 4047.8 4050.1 4051.0 4053.8 4056.2 4527.6 4596.4 4638.6 4643.3 4655.3 5420.3 5424.1 5425.9 5429.8 5434.8 1379.2 1386.9 1392.0 1397.6 1398.0 854.8 906.2 909.5 922.8 927.8 4662.7 4695.2 4701.5 4708.9 4716.8 4871.2 4903.8 4918.8 4961.4 4967.9 4433.5 4687.3 4698.9 4727.6 4753.4 2633.0 2855.3 2893.6 2896.5 2944.2 5758.0 5760.3 5780.8 5795.3 5820.4 5520.7 5601.0 5631.7 5692.5 5723.6 5647.5 5732.3 5764.7 5778.4 5785.7 5586.4 5607.7 5629.9 5675.0 5677.4 5370.5 5501.2 5531.3 5532.8 5534.9 5733.4 5773.8 5786.6 5790.4 5800.9 4059.2 4063.7 4097.9 4098.3 4102.4 5400.9 5457.8 5487.4 5492.9 5528.9 5358.7 5369.5 5387.2 5405.6 5435.7 5169.0 5240.4 5413.4 5425.7 5471.3 5272.8 5281.5 5315.6 5330.9 5334.2 5365.7 5371.4 5377.4 5440.4 5470.3 5040.9 5284.8 5303.4 5303.9 5312.2 06:44:48 INFO - PROCESS | 17094 | 06:44:48 INFO - PROCESS | 17094 | [#5] yui.html Cycles:180 Average:20186.39 Median:4483.87 stddev:28849.45 (643.4%) stddev-sans-first:28893.33 06:44:48 INFO - PROCESS | 17094 | Values: 712.8 754.0 787.7 792.3 862.3 14986.2 16319.7 16412.1 16453.0 16524.9 15878.8 16362.2 16446.8 16448.7 16475.8 808.3 829.8 832.4 832.5 833.4 672.9 705.1 793.6 826.1 831.2 865.1 867.7 868.6 874.3 874.6 869.0 869.5 869.8 870.0 870.4 511.4 529.6 606.9 635.2 639.2 14797.7 14882.5 14884.6 14917.6 14953.6 13624.8 13884.0 14111.9 14343.0 14391.3 12649.9 12726.0 12777.5 12927.2 12975.2 4408.5 4422.5 4422.9 4539.0 4697.2 75433.0 75493.2 75785.2 78085.6 78303.0 11321.6 11343.9 11397.5 11448.9 11656.3 20660.7 20723.9 20780.4 20831.7 20843.0 8180.9 8231.3 8387.8 8500.3 8666.8 4487.5 4521.9 4575.3 4639.0 4707.8 3352.8 3436.4 3458.7 3458.9 3470.4 609.2 612.6 618.3 634.6 637.4 581.9 626.8 670.8 690.0 690.9 8684.7 8954.6 9078.0 9085.3 9222.8 594.3 594.4 599.6 605.2 620.6 4153.0 4316.8 4373.6 4427.7 4480.2 117535.0 117609.0 119279.0 121338.0 122428.4 66542.7 80481.6 80940.2 103691.5 104867.5 76612.0 79083.2 80109.0 81649.0 84660.0 9069.2 9298.2 9405.2 9424.0 9439.3 44617.6 47040.0 47052.5 47625.3 48451.8 63030.4 63474.0 68478.0 70657.6 71227.6 11756.5 11813.5 12220.6 12422.9 12577.7 13544.5 14255.4 14403.9 14696.3 15111.9 12863.2 13058.5 13177.6 13270.8 13782.8 13150.3 13952.5 13963.0 14305.1 14359.1 13954.6 14246.9 14383.9 14561.0 15097.5 11349.7 11652.4 11675.5 11831.5 12617.4 10719.7 11773.5 11940.9 12087.2 12368.3 06:44:48 INFO - PROCESS | 17094 | -------- Summary: end -------- 06:44:48 INFO - PROCESS | 17094 | 06:44:48 INFO - TEST-INFO | 17094: exit 0 06:44:48 INFO - TEST-OK | dromaeo_css | took 1117479ms 06:44:48 INFO - TEST-START | kraken 06:44:48 INFO - operating with platform_type : linux_ 06:44:48 INFO - Initialising browser for kraken test... 06:44:48 INFO - TEST-INFO | started process 17403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZYT6zU/profile http://localhost:35887/getInfo.html) 06:44:52 INFO - PROCESS | 17403 | __metrics Screen width/height:1600/1200 06:44:52 INFO - PROCESS | 17403 | colorDepth:24 06:44:52 INFO - PROCESS | 17403 | Browser inner width/height: 1024/697 06:44:52 INFO - PROCESS | 17403 | __metrics 06:44:53 INFO - PROCESS | 17403 | 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" 06:44:53 INFO - PROCESS | 17403 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:44:53 INFO - PROCESS | 17403 | console.error: PushService: 06:44:53 INFO - PROCESS | 17403 | stateChangeProcessEnqueue: Error transitioning state 06:44:53 INFO - PROCESS | 17403 | UnknownError 06:44:54 INFO - TEST-INFO | 17403: exit 0 06:44:54 INFO - Browser initialized. 06:44:54 INFO - Running cycle 1/1 for kraken test... 06:44:54 INFO - TEST-INFO | started process 17486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZYT6zU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:45:06 INFO - PROCESS | 17486 | RSS: Main: 172691456 06:45:06 INFO - PROCESS | 17486 | 06:45:09 INFO - PROCESS | 17486 | Cycle 1(1): loaded http://localhost:35887/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35887/tests/kraken/driver.html?testName=audio-beat-detection) 06:45:10 INFO - PROCESS | 17486 | RSS: Main: 228859904 06:45:10 INFO - PROCESS | 17486 | 06:45:12 INFO - PROCESS | 17486 | Cycle 1(1): loaded http://localhost:35887/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35887/tests/kraken/driver.html?testName=audio-dft) 06:45:13 INFO - PROCESS | 17486 | RSS: Main: 216199168 06:45:13 INFO - PROCESS | 17486 | 06:45:16 INFO - PROCESS | 17486 | Cycle 1(1): loaded http://localhost:35887/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35887/tests/kraken/driver.html?testName=audio-fft) 06:45:17 INFO - PROCESS | 17486 | RSS: Main: 297361408 06:45:17 INFO - PROCESS | 17486 | 06:45:19 INFO - PROCESS | 17486 | Cycle 1(1): loaded http://localhost:35887/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35887/tests/kraken/driver.html?testName=audio-oscillator) 06:45:19 INFO - PROCESS | 17486 | RSS: Main: 208617472 06:45:19 INFO - PROCESS | 17486 | 06:45:22 INFO - PROCESS | 17486 | Cycle 1(1): loaded http://localhost:35887/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35887/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:45:22 INFO - PROCESS | 17486 | RSS: Main: 211906560 06:45:22 INFO - PROCESS | 17486 | 06:45:25 INFO - PROCESS | 17486 | Cycle 1(1): loaded http://localhost:35887/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35887/tests/kraken/driver.html?testName=imaging-darkroom) 06:45:26 INFO - PROCESS | 17486 | RSS: Main: 248078336 06:45:26 INFO - PROCESS | 17486 | 06:45:29 INFO - PROCESS | 17486 | Cycle 1(1): loaded http://localhost:35887/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35887/tests/kraken/driver.html?testName=imaging-desaturate) 06:45:30 INFO - PROCESS | 17486 | RSS: Main: 246816768 06:45:30 INFO - PROCESS | 17486 | 06:45:32 INFO - PROCESS | 17486 | Cycle 1(1): loaded http://localhost:35887/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35887/tests/kraken/driver.html?testName=json-parse-financial) 06:45:33 INFO - PROCESS | 17486 | RSS: Main: 247103488 06:45:33 INFO - PROCESS | 17486 | 06:45:34 INFO - PROCESS | 17486 | Cycle 1(1): loaded http://localhost:35887/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35887/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:45:35 INFO - PROCESS | 17486 | RSS: Main: 208883712 06:45:35 INFO - PROCESS | 17486 | 06:45:37 INFO - PROCESS | 17486 | Cycle 1(1): loaded http://localhost:35887/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35887/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:45:37 INFO - PROCESS | 17486 | RSS: Main: 216571904 06:45:37 INFO - PROCESS | 17486 | 06:45:39 INFO - PROCESS | 17486 | Cycle 1(1): loaded http://localhost:35887/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35887/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:45:40 INFO - PROCESS | 17486 | RSS: Main: 225320960 06:45:40 INFO - PROCESS | 17486 | 06:45:43 INFO - PROCESS | 17486 | Cycle 1(1): loaded http://localhost:35887/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35887/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:45:43 INFO - PROCESS | 17486 | RSS: Main: 234057728 06:45:43 INFO - PROCESS | 17486 | 06:45:46 INFO - PROCESS | 17486 | Cycle 1(1): loaded http://localhost:35887/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35887/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:45:47 INFO - PROCESS | 17486 | RSS: Main: 231182336 06:45:47 INFO - PROCESS | 17486 | 06:45:48 INFO - PROCESS | 17486 | Cycle 1(1): loaded http://localhost:35887/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35887/tests/kraken/driver.html?testName=ai-astar) 06:45:49 INFO - PROCESS | 17486 | RSS: Main: 282345472 06:45:49 INFO - PROCESS | 17486 | 06:45:49 INFO - PROCESS | 17486 | __start_tp_report 06:45:49 INFO - PROCESS | 17486 | _x_x_mozilla_page_load 06:45:49 INFO - PROCESS | 17486 | _x_x_mozilla_page_load_details 06:45:49 INFO - PROCESS | 17486 | |i|pagename|runs| 06:45:49 INFO - PROCESS | 17486 | |0;ai-astar;104;109;109;109;110;110;111;111;110;109 06:45:49 INFO - PROCESS | 17486 | |1;audio-beat-detection;152;126;126;160;132;129;126;123;157;126 06:45:49 INFO - PROCESS | 17486 | |2;audio-dft;163;162;162;163;162;164;162;161;161;162 06:45:49 INFO - PROCESS | 17486 | |3;audio-fft;75;78;74;114;76;77;76;76;99;75 06:45:49 INFO - PROCESS | 17486 | |4;audio-oscillator;82;83;120;83;86;83;105;84;83;115 06:45:49 INFO - PROCESS | 17486 | |5;imaging-gaussian-blur;116;116;117;116;116;117;117;116;116;116 06:45:49 INFO - PROCESS | 17486 | |6;imaging-darkroom;146;146;147;147;146;147;147;148;147;146 06:45:49 INFO - PROCESS | 17486 | |7;imaging-desaturate;85;84;85;84;84;85;84;85;84;84 06:45:49 INFO - PROCESS | 17486 | |8;json-parse-financial;55;53;54;54;56;56;54;55;55;54 06:45:49 INFO - PROCESS | 17486 | |9;json-stringify-tinderbox;60;60;59;59;60;61;60;60;60;60 06:45:49 INFO - PROCESS | 17486 | |10;stanford-crypto-aes;81;89;83;79;86;79;79;80;78;88 06:45:49 INFO - PROCESS | 17486 | |11;stanford-crypto-ccm;133;135;139;130;140;146;130;139;174;130 06:45:49 INFO - PROCESS | 17486 | |12;stanford-crypto-pbkdf2;167;167;173;166;169;164;169;169;172;165 06:45:49 INFO - PROCESS | 17486 | |13;stanford-crypto-sha256-iterative;66;67;67;68;65;67;64;69;64;65 06:45:49 INFO - PROCESS | 17486 | __end_tp_report 06:45:49 INFO - PROCESS | 17486 | __start_cc_report 06:45:49 INFO - PROCESS | 17486 | _x_x_mozilla_cycle_collect,1715 06:45:49 INFO - PROCESS | 17486 | __end_cc_report 06:45:49 INFO - PROCESS | 17486 | __startTimestamp1476539149226__endTimestamp 06:45:49 INFO - PROCESS | 17486 | 06:45:49 INFO - PROCESS | 17486 | ------- Summary: start ------- 06:45:49 INFO - PROCESS | 17486 | Number of tests: 14 06:45:49 INFO - PROCESS | 17486 | 06:45:49 INFO - PROCESS | 17486 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:1.99 (1.8%) stddev-sans-first:0.83 06:45:49 INFO - PROCESS | 17486 | Values: 104.0 109.0 109.0 109.0 110.0 110.0 111.0 111.0 110.0 109.0 06:45:49 INFO - PROCESS | 17486 | 06:45:49 INFO - PROCESS | 17486 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:130.50 stddev:14.55 (11.2%) stddev-sans-first:14.19 06:45:49 INFO - PROCESS | 17486 | Values: 152.0 126.0 126.0 160.0 132.0 129.0 126.0 123.0 157.0 126.0 06:45:49 INFO - PROCESS | 17486 | 06:45:49 INFO - PROCESS | 17486 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 06:45:49 INFO - PROCESS | 17486 | Values: 163.0 162.0 162.0 163.0 162.0 164.0 162.0 161.0 161.0 162.0 06:45:49 INFO - PROCESS | 17486 | 06:45:49 INFO - PROCESS | 17486 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:13.43 (17.7%) stddev-sans-first:14.01 06:45:49 INFO - PROCESS | 17486 | Values: 75.0 78.0 74.0 114.0 76.0 77.0 76.0 76.0 99.0 75.0 06:45:49 INFO - PROCESS | 17486 | 06:45:49 INFO - PROCESS | 17486 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:83.00 stddev:14.92 (18.0%) stddev-sans-first:15.35 06:45:49 INFO - PROCESS | 17486 | Values: 82.0 83.0 120.0 83.0 86.0 83.0 105.0 84.0 83.0 115.0 06:45:49 INFO - PROCESS | 17486 | 06:45:49 INFO - PROCESS | 17486 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:45:49 INFO - PROCESS | 17486 | Values: 116.0 116.0 117.0 116.0 116.0 117.0 117.0 116.0 116.0 116.0 06:45:49 INFO - PROCESS | 17486 | 06:45:49 INFO - PROCESS | 17486 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 06:45:49 INFO - PROCESS | 17486 | Values: 146.0 146.0 147.0 147.0 146.0 147.0 147.0 148.0 147.0 146.0 06:45:49 INFO - PROCESS | 17486 | 06:45:49 INFO - PROCESS | 17486 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 06:45:49 INFO - PROCESS | 17486 | Values: 85.0 84.0 85.0 84.0 84.0 85.0 84.0 85.0 84.0 84.0 06:45:49 INFO - PROCESS | 17486 | 06:45:49 INFO - PROCESS | 17486 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 06:45:49 INFO - PROCESS | 17486 | Values: 55.0 53.0 54.0 54.0 56.0 56.0 54.0 55.0 55.0 54.0 06:45:49 INFO - PROCESS | 17486 | 06:45:49 INFO - PROCESS | 17486 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 06:45:49 INFO - PROCESS | 17486 | Values: 60.0 60.0 59.0 59.0 60.0 61.0 60.0 60.0 60.0 60.0 06:45:49 INFO - PROCESS | 17486 | 06:45:49 INFO - PROCESS | 17486 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:4.08 (5.0%) stddev-sans-first:4.30 06:45:49 INFO - PROCESS | 17486 | Values: 81.0 89.0 83.0 79.0 86.0 79.0 79.0 80.0 78.0 88.0 06:45:49 INFO - PROCESS | 17486 | 06:45:49 INFO - PROCESS | 17486 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:139.00 stddev:13.19 (9.5%) stddev-sans-first:13.77 06:45:49 INFO - PROCESS | 17486 | Values: 133.0 135.0 139.0 130.0 140.0 146.0 130.0 139.0 174.0 130.0 06:45:49 INFO - PROCESS | 17486 | 06:45:49 INFO - PROCESS | 17486 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:169.00 stddev:2.88 (1.7%) stddev-sans-first:3.03 06:45:49 INFO - PROCESS | 17486 | Values: 167.0 167.0 173.0 166.0 169.0 164.0 169.0 169.0 172.0 165.0 06:45:49 INFO - PROCESS | 17486 | 06:45:49 INFO - PROCESS | 17486 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:1.69 (2.5%) stddev-sans-first:1.79 06:45:49 INFO - PROCESS | 17486 | Values: 66.0 67.0 67.0 68.0 65.0 67.0 64.0 69.0 64.0 65.0 06:45:49 INFO - PROCESS | 17486 | -------- Summary: end -------- 06:45:49 INFO - PROCESS | 17486 | 06:45:50 INFO - TEST-INFO | 17486: exit 0 06:45:50 INFO - TEST-OK | kraken | took 61544ms 06:45:50 INFO - SUITE-END | took 1179s 06:45:50 INFO - Completed test suite (00:19:39) 06:45:50 INFO - javascript benchmark 06:45:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2955.6748757636665, 3055.991522797476, 3056.1137270191643, 3091.3199096198828, 3109.067279816056, 5014.84955451337, 5089.083964886319, 5245.134552798789, 5310.4424035476295, 5358.41057483677, 5126.0, 5142.280080788683, 5145.0, 5145.253938178962, 5156.922646160301, 4611.146937816507, 4631.745254011028, 4646.326282689008, 4677.204875171229, 4708.929366059495, 4690.9296360554445, 4723.14983303007, 4729.692569982957, 4732.124556956956, 4734.431868175807, 4634.328022436762, 4645.27998160284, 4679.344891715163, 4692.36653051837, 4722.50413706561, 4696.600788932962, 4702.952970470285, 4728.929066064012, 4736.171170045228, 4787.976060119712, 4588.2888152336445, 4625.791839367203, 4649.139909116824, 4676.719396836201, 4707.917179048838, 5211.895762084737, 5227.712475813829, 5228.660137091077, 5248.239005344204, 5321.388040375329, 5593.161025846115, 5613.382527921966, 5644.294463192101, 5645.830625081254, 5649.378568357477, 5399.379071406799, 5541.889162216733, 5557.6109672322955, 5708.315002199721, 5766.452187042224, 5237.188235823453, 5239.764210610531, 5257.08001099806, 5322.20166974953, 5327.147656374961, 5686.0333743263745, 5697.800576979786, 5709.314882214161, 5717.342505611908, 5723.742431590588, 5232.450592687789, 5352.250684904038, 5456.317960254968, 5466.125419932871, 5527.640703354269, 5441.5374693151525, 5494.066008778517, 5507.03626865297, 5571.331440227118, 5573.804916827891, 5454.59090568209, 5501.642393244426, 5503.669779813144, 5506.779728810883, 5507.476789704971, 5412.972935135378, 5445.782168713286, 5456.863578410572, 5517.44825517445, 5578.665280083208, 4284.485861696554, 4288.35674648799, 4308.202982448257, 4320.870373888788, 4367.039251364695, 3851.8266677998995, 3859.8842034739005, 3862.0731024553907, 3900.1029763154634, 3908.472356231929, 5312.3890752563175, 5327.573794096463, 5329.706866122323, 5331.840044798585, 5333.306670132858, 5314.202869569518, 5349.170878513759, 5355.651882627694, 5563.443655634485, 5586.91619625706, 5352.384475785335, 5364.678119312854, 5405.7837686492885, 5408.242846001563, 5419.756110975016, 4842.58837998774, 4851.417829860368, 4852.514748525119, 4855.101806165871, 4875.24433712775, 5566.721663916707, 5805.129230615442, 5828.417158284137, 5852.561057920673, 5867.178594996619, 5366.758495867617, 5545.057340252086, 5600.0, 5604.6917419542315, 5696.458836410535, 5830.854228644148, 5830.883382332415, 5832.066869300891, 5833.329167145663, 5839.270091238595, 5502.009638265151, 5502.8349149525575, 5507.862303442446, 5514.972425137848, 5560.082586373203, 5329.067413202752, 5417.6478528895495, 5468.070428027325, 5536.307961504812, 5568.832935011957, 5432.0, 5465.098258787415, 5466.289382380265, 5481.0408178567795, 5521.613487055867, 5433.673979561081, 5444.809431670031, 5445.391863253426, 5446.428125046813, 5517.2275881377445, 5294.814681486129, 5336.519713225828, 5443.346798384219, 5459.617826752089, 5530.91703624454, 5580.916286255629, 5584.46947539983, 5585.664860108406, 5619.80330688424, 5652.943470565242, 5188.948110518846, 5438.184272359178, 5455.208994695826, 5455.536279416294, 5456.372517160577], "value": 5140.075397717596, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.2556317335946, 585.698365341849, 600.7446835095084, 604.7308947518351, 609.8079105081899, 31762.20594485139, 42932.78533607331, 43947.34078988818, 44023.616575596556, 47116.293255601195, 45219.77390113045, 45609.0, 45612.54387456133, 45641.31538026932, 45643.543564564425, 7831.960840195791, 8813.91186088139, 8941.061188575204, 8977.102289771003, 8981.730548083535, 8004.919950800476, 10381.325213861075, 10627.043566079052, 10642.09542188911, 10988.780224395507, 10795.622153224638, 10824.24230303879, 10843.240973131844, 10847.51186196623, 10865.728356791104, 10692.411917344543, 10750.354978701225, 10756.354618722902, 10761.408122553257, 10768.946155269212, 10487.79024419515, 10540.209484288709, 10545.261831671785, 10548.578056877715, 10549.947250263776, 40912.38631420531, 41433.79283103565, 41500.0, 41509.584904151176, 41548.169036619096, 3223.2425380035675, 3686.262747450494, 4077.3680079587416, 4090.2637525245445, 4119.155573107506, 31445.685543144733, 32325.51511727326, 32543.51184732231, 33775.0, 33788.6621133788, 3654.963450365489, 3739.9813000934823, 3748.7938163401004, 3755.0800053986677, 3872.5740168581433, 315032.0, 317378.0, 317893.0, 319585.0, 319762.0, 59170.408295917354, 59700.402995970355, 59703.70148149232, 59874.70062649659, 60086.39913600896, 64486.0, 64511.354886450536, 64557.0, 64608.35391646117, 64665.67667161634, 15789.763153552705, 15888.92055539738, 15895.443659471863, 16013.0, 16022.359105635876, 10285.228607854291, 10522.105621022145, 10995.945020274847, 11439.084873210124, 11467.942660286812, 18654.626907461774, 19336.226550937805, 19377.0, 19392.515187120436, 19402.223911043682, 5702.287214098238, 6938.410235130071, 7071.29287071299, 7099.858002839915, 7165.0, 874.6851133591902, 920.7007722490083, 986.8223719730518, 1081.0486771640906, 1096.3641088168843, 31538.526922096185, 32272.35455290881, 32318.676813232036, 32617.0, 32771.28539287894, 1070.3684825952726, 1073.7959787640323, 1078.8435676826816, 1079.2337440417234, 1136.494260054268, 15742.606434838992, 16696.332146714238, 16849.41027064047, 16872.57818554546, 17100.230489627997, 495067.0, 500455.0, 500555.0, 500834.0, 501370.0, 56675.71662141745, 57208.42791572114, 57224.141637875466, 57235.713821430625, 57237.71381143151, 1169.4445138559117, 1221.2367270455966, 1223.4127618743053, 1277.6486466221863, 1313.3630189358153, 29989.41304531553, 34924.30151397009, 34987.65012349844, 35011.82494087513, 35238.0, 54716.45283547273, 55480.0, 55533.44466555283, 55551.0, 55570.72214638901, 432598.0, 435608.0, 435967.0, 437786.0, 438279.0, 26958.865205673847, 27550.44899102047, 27659.861700691366, 27737.861310694123, 29092.418151637274, 34177.487337689454, 40153.39769903395, 42028.57971420369, 43983.78008109939, 49320.91424231288, 38783.0, 40070.599294006686, 40387.798061009504, 41138.588614113476, 41918.790406047774, 41139.38290925699, 42338.364924525544, 42407.36388954106, 42639.36040959326, 42773.786131069144, 43384.566154339314, 43433.3484997719, 44391.55608444003, 44589.55410445854, 44698.55301446944, 34152.316953661284, 36806.39001211581, 36852.262954741294, 37477.0, 37544.62455375411, 28121.98619835052, 28223.93185465135, 28483.715162848108, 28493.715062849107, 28694.0], "value": 20228.45542336946, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.2369143256322, 381.99809000954997, 382.2660491855636, 405.4951585276331, 406.51421551246256, 14282.285885705725, 14952.327145278461, 17053.232604532794, 19433.611327773455, 19993.900030499844, 15232.923835380807, 17895.19471623777, 18289.54276143097, 19024.61950760984, 19095.331663391786, 5481.12302031675, 5726.7422965966425, 5732.31212254528, 5733.369329373786, 5734.541236701075, 5401.540869026117, 5671.546276297886, 5689.459501347365, 5694.373618901917, 5695.487406133447, 4020.8190631421658, 4206.936895946563, 5663.0, 6046.183765191687, 6299.307076221612, 6134.478569321613, 6404.839879003039, 6408.551401401857, 6416.743330266784, 6418.93581064188, 5451.427600102012, 5483.204935284361, 5488.313960754906, 5490.396056433789, 5492.752826122834, 21811.345659630235, 22168.445788855246, 22307.665385019238, 22352.55294894109, 22632.43418914524, 2003.769566499842, 2083.812456878888, 2089.540301133748, 2265.8187345012525, 2415.7221919479134, 9720.319577629569, 10138.9493052535, 10603.628872989408, 10743.677689669323, 12137.817932731015, 1880.548668319607, 1925.5089952062274, 1928.2190712761214, 1967.6950072738748, 1984.9503762405911, 71861.28138718651, 73263.63368183126, 83210.0, 84723.0, 87211.56394218052, 10501.31741436804, 10549.525271362807, 10595.84106238407, 11016.504257308441, 11025.692292312275, 15010.273818510792, 15025.098494090389, 15033.323500442506, 15043.473478428203, 15047.623809404633, 6853.554518956252, 7126.429885609243, 7184.497085203986, 7251.746188883364, 7364.852702945911, 6557.344265573404, 6628.370304821035, 6756.358145976124, 6773.695183716744, 6809.38715515606, 4560.224761790503, 4590.67865249436, 4614.838480653161, 4673.088747694167, 4745.6440766942615, 1886.735856980024, 1896.4310706787908, 1940.474238788616, 1977.4364306172672, 1999.3502111813427, 932.379967321737, 938.6996161228478, 943.9008904065112, 944.8866136063579, 992.806402751471, 18423.52812355339, 19942.20231190765, 19954.20183192685, 20070.19719211215, 20341.0, 940.9012053734397, 941.152962333905, 943.9575219115156, 992.3946392700446, 1002.1932344462632, 10274.178065754722, 10920.617778377718, 10959.83560246597, 10960.671179864617, 11057.668269951915, 434458.0, 442442.0, 444260.0, 445136.0, 445319.0, 82669.58665206756, 84465.0, 84592.57703711442, 85227.0, 85746.5712671445, 932.5943214701762, 979.5151400057017, 995.0645595493323, 995.1740055753708, 1000.2198285337448, 16750.664986699954, 17020.829791701923, 17499.21253543619, 17559.1220438975, 17856.107194639957, 40023.0, 40618.1876362477, 40702.59297406988, 40738.0, 41356.58643413648, 54149.0, 56365.436345636015, 56400.0, 56402.0, 56540.43459565516, 8309.320583844672, 8454.281386082252, 8495.108013658477, 8515.74452766418, 8723.476591404537, 10502.894971050191, 12817.935910320388, 13233.536826211037, 13383.39774710121, 13445.0, 10626.574937002433, 11287.266327689002, 11445.427728613702, 11468.770624587629, 11476.770464590494, 11436.256643318158, 11496.195266331277, 11662.650120496399, 11689.824652630388, 11822.881771182178, 11873.643790686294, 11972.820407694066, 12099.75800484003, 12311.076669249664, 12345.197562158432, 7369.299916507923, 8344.040435350013, 8743.12568743146, 8769.605367758339, 9014.684486042957, 10069.949650251701, 11677.941610291895, 11797.17419780607, 12234.388280585757, 12322.507099715911], "value": 8953.22939048515, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.6375098502756, 1474.7640377539597, 1508.8868334874883, 1668.6662667466503, 1811.4927820210346, 7754.8836767448465, 8385.664573417063, 8761.080086590911, 9104.13510716481, 9106.225970792473, 9050.411723237985, 9122.179003889649, 9129.634814607425, 9133.0, 9139.497327646977, 2254.830887683426, 2262.886855657219, 2275.8862056897174, 2275.8975846086964, 2280.407094155515, 2193.8683678979232, 2225.121077174515, 2231.107556977206, 2232.531168454618, 2239.0595949701083, 2178.7603363629987, 2200.9449763755956, 2208.558288342338, 2212.3694746997107, 2248.6964259824877, 2117.3542069668747, 2140.753813311466, 2144.2280778919653, 2147.6671115977047, 2155.665871789875, 2156.277646988261, 2158.816500597451, 2162.9891850540803, 2172.3374370816896, 2172.750133734625, 8973.730788076367, 9112.225460835836, 9147.268218542567, 9165.17513423795, 9181.265498760149, 5173.405058418292, 5336.039512887679, 5352.304200453955, 5357.973210133924, 5361.544268737162, 3221.951670724941, 3433.2790114076074, 3445.5176275321473, 3481.704055155315, 3506.50908872758, 947.7630592351912, 1007.4056306779036, 1009.5204777730593, 1020.5611587017579, 1020.5764607687801, 12182.573609923698, 12305.938470307681, 12334.81497777534, 12335.876641233652, 12345.13584049117, 4182.121754431603, 4300.37644541546, 4373.343998400202, 4415.712978656377, 4429.180601588717, 9684.757881052888, 9691.854622180674, 9696.903030969741, 9697.612095516242, 9706.90293097074, 5069.290299358093, 5100.336956195671, 5114.105031619526, 5115.462876397924, 5141.948580514222, 4059.3505039193587, 4128.938065929014, 4778.37881075458, 4801.975990120027, 4946.851594452172, 3520.2783429396914, 3611.3680105981875, 3680.815959202083, 3714.4428335749312, 3720.0, 1039.153090231459, 1047.2983101322131, 1049.6850944716555, 1053.9420331881668, 1065.6962765611918, 774.2412435812935, 911.7355966769562, 972.9270304727174, 981.7202097402206, 990.9108180263811, 6031.909521357183, 6041.667708276087, 6156.384361563808, 6164.4143806338325, 6193.975531204174, 419.2223425545569, 424.757888003841, 425.94888613366595, 429.09675133843433, 431.2044278306519, 4198.85304014358, 4344.500382455994, 4352.107817897323, 4357.237483440385, 4357.978210108992, 11145.72135696614, 11441.0, 11474.368909710047, 11476.655700329004, 11506.827397589042, 11398.0, 11413.144014198968, 11425.200235983568, 11425.771484570261, 11440.599579014695, 8054.154313797084, 8401.495910245405, 8414.495130292202, 8630.352723545759, 8633.91366086331, 6041.395860413923, 6206.131141640264, 6237.126802247598, 6266.373362663697, 6516.120323756422, 10166.440845753259, 10491.580336786748, 10515.421651809223, 10535.789284214427, 10656.413897235727, 10775.6228532001, 10785.946070269598, 10788.730281743019, 10797.190210734068, 10939.179561532757, 7804.570748608881, 7942.245486678757, 7990.84018319642, 8006.719764808204, 8069.354451643737, 8648.78378040554, 8681.739547813575, 8700.521471319138, 8731.476111433334, 8784.385093043426, 7765.339946104645, 7864.5281283123195, 7911.0, 8018.278354947849, 8067.193280671886, 7480.663370148248, 7525.736599219001, 7585.886211706939, 7660.195679453577, 7711.768646940601, 6973.3375329343635, 7071.964640176766, 7104.218535960937, 7116.359527642537, 7121.323474269936, 5337.759800808895, 5351.785928562814, 5433.565314774887, 5435.945640543544, 5578.497935185853, 5455.099908515051, 5477.698726569917, 5494.423085575957, 5560.221568980265, 5703.20155178267], "value": 4508.474566275312, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.46002485811397, 325.0, 335.3193018173109, 337.8006975884228, 338.4770529531873, 5280.1551751719735, 5288.629795914278, 5289.5503882170015, 5293.735313234342, 5333.280007199027, 5128.5640720538795, 5162.418790604697, 5233.0, 5234.162533994561, 5252.52727254547, 3853.7880416577077, 4083.4074710862715, 4090.734102283357, 4096.9795151024355, 4101.835926562934, 4013.257547353749, 4041.696872734542, 4058.3100872851537, 4075.6535694466006, 4093.8302699569126, 3972.1857019311115, 3976.6818654507715, 3988.501437320335, 4011.5787842276577, 4022.979885100585, 3747.1381582235967, 3869.3228684980018, 3888.591697871711, 3975.5030621172355, 3976.602339766029, 3503.91240218994, 3513.9106876868254, 3518.7712798668263, 3519.6128425873135, 3525.629808870083, 5007.349044624212, 5014.323066386028, 5014.373203349582, 5024.522670346311, 5064.873378165538, 4328.870133895988, 4334.45819272591, 4590.977045114753, 4616.8153273869, 4622.468416132154, 5326.0, 5368.489993450616, 5390.218418329359, 5392.514673679349, 5463.890722185534, 3944.6055394460614, 3950.4864367632313, 3951.5258169019903, 3954.4266081418323, 3959.089409435846, 5379.623426360156, 5556.194351818964, 5630.746616402272, 5645.774169033234, 5658.830235092953, 3964.345882929342, 3975.900602484961, 3983.601639836051, 3989.8204580793936, 4003.3994900764537, 4047.838086476567, 4050.1292222172374, 4050.9797451012555, 4053.777042262645, 4056.229316429869, 4527.615152712056, 4596.448426188878, 4638.628909687284, 4643.326717625925, 4655.255159174516, 5420.349558053059, 5424.050791111618, 5425.864353391118, 5429.83710488678, 5434.83695489136, 1379.1518216296904, 1386.8821150202143, 1392.004716627616, 1397.6226418867052, 1397.9585209019347, 854.7734850264685, 906.2297047509564, 909.481595490564, 922.8246633139682, 927.7541451515353, 4662.673612847136, 4695.178343789823, 4701.519021508282, 4708.86987123088, 4716.834910778106, 4871.249138163595, 4903.828366007173, 4918.778654960535, 4961.3798275215595, 4967.900641987212, 4433.490148632948, 4687.273472611751, 4698.919248572847, 4727.645426592951, 4753.35829662998, 2632.9868350658126, 2855.328997685542, 2893.594896714462, 2896.493113705093, 2944.2492164497917, 5757.971210144006, 5760.337561180518, 5780.826575202751, 5795.304563452329, 5820.417958204146, 5520.66875987442, 5600.991821472093, 5631.662100273915, 5692.459216374521, 5723.570732195102, 5647.463490968352, 5732.3407808101765, 5764.685305949012, 5778.3643799182055, 5785.681787501728, 5586.38549759518, 5607.719614019201, 5629.943700563106, 5675.035244008446, 5677.403872593318, 5370.462953704755, 5501.202325662836, 5531.3362396512675, 5532.778688852401, 5534.861628459321, 5733.369329373849, 5773.826785196451, 5786.594938354275, 5790.392008839011, 5800.883982320414, 4059.208454351491, 4063.674906007453, 4097.85657501998, 4098.262312783728, 4102.425660407485, 5400.864978375572, 5457.799284157479, 5487.368952570346, 5492.945070549403, 5528.917066243929, 5358.732063396893, 5369.54358879484, 5387.191921211849, 5405.594580406407, 5435.701036443033, 5168.952325778923, 5240.371155461369, 5413.431589683027, 5425.728713564385, 5471.261379713687, 5272.762725677277, 5281.524662780368, 5315.601329900195, 5330.866728331823, 5334.226537152013, 5365.731713414236, 5371.409144994126, 5377.435369286325, 5440.374356949002, 5470.288862447856, 5040.891003979119, 5284.788608455772, 5303.416624171261, 5303.912697896999, 5312.150055991023], "value": 4096.546991278188, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.7647876200854, 753.9849203015937, 787.7400457848911, 792.3027735592677, 862.2627653356382, 14986.175760333192, 16319.673606527862, 16412.09733464659, 16453.0, 16524.917375413122, 15878.84121158788, 16362.181890905467, 16446.75329870053, 16448.67102657946, 16475.83524164758, 808.3412019204329, 829.7718127514921, 832.3507664022072, 832.4755404095441, 833.3874602167402, 672.8721542906832, 705.1291654806311, 793.6428607126816, 826.1325608111489, 831.1688311688312, 865.074370423647, 867.6746220167437, 868.6438560190323, 874.2918236228675, 874.623911717961, 869.0049892872657, 869.4696235296464, 869.8434281829268, 870.0386073388878, 870.3907264914585, 511.4144304771053, 529.6292595183348, 606.9136246119441, 635.240887139868, 639.2009987515605, 14797.704045919021, 14882.479113231093, 14884.553463396116, 14917.552473425814, 14953.551393458214, 13624.795628065587, 13884.0, 14111.929440352835, 14343.0, 14391.280435978158, 12649.936750316281, 12726.0, 12777.488900444065, 12927.15973461722, 12975.1566148201, 4408.4709834819705, 4422.469303683579, 4422.889427764299, 4539.046800171968, 4697.224957881946, 75432.99999999945, 75493.24506754972, 75785.17933386021, 78085.60957195234, 78303.0, 11321.603743868925, 11343.886561134448, 11397.487113079931, 11448.885511144948, 11656.30062196271, 20660.690089648666, 20723.896380518, 20780.376588702362, 20831.687524687142, 20843.0, 8180.877286840702, 8231.300339471092, 8387.83224335522, 8500.319974402033, 8666.826663466696, 4487.5288094749585, 4521.89499365186, 4575.336576196433, 4639.025804581008, 4707.78814953321, 3352.8491217895253, 3436.415809312423, 3458.688718015391, 3458.913527161841, 3470.444728843373, 609.2110716621985, 612.574260888678, 618.2735286038976, 634.5875181132301, 637.4422380417135, 581.9243498345188, 626.8276224038426, 670.7892254480612, 689.9896501552481, 690.8652812701575, 8684.6526138955, 8954.641814327484, 9077.973395737165, 9085.318601104944, 9222.799478971803, 594.3343455330058, 594.3610618585038, 599.6012651586733, 605.1618508365945, 620.6431302001367, 4152.960731560037, 4316.762578058174, 4373.562643735601, 4427.690061695715, 4480.215962206666, 117535.0, 117609.0, 119279.0, 121338.0, 122428.38785806014, 66542.66728666326, 80481.59759201166, 80940.19059809444, 103691.4815425918, 104867.4756626212, 76612.0, 79083.20916790873, 80109.0, 81649.0, 84660.0, 9069.183773460156, 9298.209652179641, 9405.247580193705, 9423.953502259212, 9439.339246252972, 44617.55382446134, 47040.0, 47052.53000964903, 47625.28562071641, 48451.75774121107, 63030.36969630428, 63474.0, 68478.0, 70657.64671176611, 71227.64386178037, 11756.470958807045, 11813.527458901548, 12220.633380998584, 12422.937885310515, 12577.748445031231, 13544.525941591997, 14255.429782808571, 14403.927980360031, 14696.338664759898, 15111.924440377728, 12863.163894347212, 13058.477660893457, 13177.604671859859, 13270.805627493572, 13782.793258100935, 13150.276734779296, 13952.511662091778, 13963.0, 14305.141691498544, 14359.138451692932, 13954.58136255914, 14246.928765356108, 14383.928080359532, 14561.0, 15097.452098756563, 11349.659510214708, 11652.417379131179, 11675.474603642686, 11831.52673893069, 12617.43221555014, 10719.732006699895, 11773.470193841127, 11940.880591193976, 12087.153899226969, 12368.319742413894], "value": 7459.500589912286, "unit": "score"}], "name": "dromaeo_css", "value": 7101.545737723065, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 109.0, 109.0, 109.0, 110.0, 110.0, 111.0, 111.0, 110.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 126.0, 160.0, 132.0, 129.0, 126.0, 123.0, 157.0, 126.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 162.0, 164.0, 162.0, 161.0, 161.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 74.0, 114.0, 76.0, 77.0, 76.0, 76.0, 99.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 120.0, 83.0, 86.0, 83.0, 105.0, 84.0, 83.0, 115.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 148.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 56.0, 56.0, 54.0, 55.0, 55.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 59.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 89.0, 83.0, 79.0, 86.0, 79.0, 79.0, 80.0, 78.0, 88.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 135.0, 139.0, 130.0, 140.0, 146.0, 130.0, 139.0, 174.0, 130.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 173.0, 166.0, 169.0, 164.0, 169.0, 169.0, 172.0, 165.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 68.0, 65.0, 67.0, 64.0, 69.0, 64.0, 65.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1499.5, "alertThreshold": 2.0}]} 06:45:50 INFO - Return code: 0 06:45:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:45:51 INFO - # TBPL SUCCESS # 06:45:51 INFO - Running post-action listener: _resource_record_post_action 06:45:51 INFO - [mozharness: 2016-10-15 13:45:51.013005Z] Finished run-tests step (success) 06:45:51 INFO - Running post-run listener: _resource_record_post_run 06:45:51 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 393334784; Read time: 0; Write time: 282544 06:45:51 INFO - TinderboxPrint: CPU usage
13.1% 06:45:51 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:45:51 INFO - TinderboxPrint: I/O write bytes / time
393,334,784 / 282,544 06:45:51 INFO - TinderboxPrint: CPU idle
8,300.9 (86.9%) 06:45:51 INFO - TinderboxPrint: CPU user
1,201.9 (12.6%) 06:45:51 INFO - TinderboxPrint: Swap in / out
0 / 0 06:45:51 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 102924288; Read time: 0; Write time: 68564 06:45:51 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 289443840; Read time: 0; Write time: 213956 06:45:51 INFO - Running post-run listener: _upload_blobber_files 06:45:51 INFO - Blob upload gear active. 06:45:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:45:51 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 06:45:51 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:45:51 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:45:52 INFO - (blobuploader) - INFO - Open directory for files ... 06:45:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:45:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:45:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:45:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:45:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:45:52 INFO - (blobuploader) - INFO - Done attempting. 06:45:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:45:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:45:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:45:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:45:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:45:56 INFO - (blobuploader) - INFO - Done attempting. 06:45:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:45:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:45:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:45:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:45:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:45:57 INFO - (blobuploader) - INFO - Done attempting. 06:45:57 INFO - (blobuploader) - INFO - Iteration through files over. 06:45:57 INFO - Return code: 0 06:45:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:45:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:45:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92147109e0ad7b38943d6eab5608ded970da4679732487dd82c9620e7a36f6333b4c4ef1a251509bba3e5a3395fde5031b6a473bbdf30d8fd2d38b9f570cfa17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1032f522276aa1b5346b427669e3dcea16fcc6ecf5e3f2fa98f4728b30a29e75c4a0beccb891e0fc645ab75eabdf9b64aef77b65352d81df4fac794485b3bac3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/827b241288db4601c4a64796f1f42d3b2278af849d82c656b23ee1708c67c90b83e7903ad9351dc5617dc5cbd66e59e0b2009d714d230b59888a8ed7a5df1044"} 06:45:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:45:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:45:57 INFO - Contents: 06:45:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92147109e0ad7b38943d6eab5608ded970da4679732487dd82c9620e7a36f6333b4c4ef1a251509bba3e5a3395fde5031b6a473bbdf30d8fd2d38b9f570cfa17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1032f522276aa1b5346b427669e3dcea16fcc6ecf5e3f2fa98f4728b30a29e75c4a0beccb891e0fc645ab75eabdf9b64aef77b65352d81df4fac794485b3bac3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/827b241288db4601c4a64796f1f42d3b2278af849d82c656b23ee1708c67c90b83e7903ad9351dc5617dc5cbd66e59e0b2009d714d230b59888a8ed7a5df1044"} 06:45:57 INFO - Running post-run listener: copy_logs_to_upload_dir 06:45:57 INFO - Copying logs to upload dir... 06:45:57 INFO - mkdir: /builds/slave/test/build/upload/logs 06:45:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.090748 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-15 06:45:56.243133) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-15 06:45:56.247092) ========= 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=826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92147109e0ad7b38943d6eab5608ded970da4679732487dd82c9620e7a36f6333b4c4ef1a251509bba3e5a3395fde5031b6a473bbdf30d8fd2d38b9f570cfa17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1032f522276aa1b5346b427669e3dcea16fcc6ecf5e3f2fa98f4728b30a29e75c4a0beccb891e0fc645ab75eabdf9b64aef77b65352d81df4fac794485b3bac3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/827b241288db4601c4a64796f1f42d3b2278af849d82c656b23ee1708c67c90b83e7903ad9351dc5617dc5cbd66e59e0b2009d714d230b59888a8ed7a5df1044"} build_url:https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/Dez96PRuQEudh8RF-yZxrQ/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/Fx-Team/sha512/92147109e0ad7b38943d6eab5608ded970da4679732487dd82c9620e7a36f6333b4c4ef1a251509bba3e5a3395fde5031b6a473bbdf30d8fd2d38b9f570cfa17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1032f522276aa1b5346b427669e3dcea16fcc6ecf5e3f2fa98f4728b30a29e75c4a0beccb891e0fc645ab75eabdf9b64aef77b65352d81df4fac794485b3bac3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/827b241288db4601c4a64796f1f42d3b2278af849d82c656b23ee1708c67c90b83e7903ad9351dc5617dc5cbd66e59e0b2009d714d230b59888a8ed7a5df1044"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-15 06:45:56.272212) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 06:45:56.272552) ========= 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=826874ccc97bd7bf541b4875000001d5-1476533579.90029-62806642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 06:45:56.355647) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-15 06:45:56.356003) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-15 06:45:56.356320) ========= ========= Total master_lag: 0.16 =========