builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1476321755.93 results: success (0) buildid: 20161012153001 builduid: 1d32d4d026744474bb8423209f5c0d4a revision: d68def1644c1849141ceaa31bc1b811becfbb8da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 18:22:35.931968) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 18:22:35.932454) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 18:22:35.932757) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 18:22:35.947211) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 18:22:35.947469) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-12 18:22:37-- 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% 20.3M=0.001s 2016-10-12 18:22:37 (20.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126938 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 18:22:36.087745) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 18:22:36.088052) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014794 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 18:22:36.137472) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 18:22:36.137897) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d68def1644c1849141ceaa31bc1b811becfbb8da --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 d68def1644c1849141ceaa31bc1b811becfbb8da --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=a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-12 18:22:37,364 truncating revision to first 12 chars 2016-10-12 18:22:37,364 Setting DEBUG logging. 2016-10-12 18:22:37,364 attempt 1/10 2016-10-12 18:22:37,364 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d68def1644c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 18:22:37,753 unpacking tar archive at: fx-team-d68def1644c1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.699156 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 18:22:36.850244) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 18:22:36.850561) ========= script_repo_revision: d68def1644c1849141ceaa31bc1b811becfbb8da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 18:22:36.850970) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 18:22:36.851231) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 18:22:36.861066) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-12 18:22:36.861349) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:22:38 INFO - MultiFileLogger online at 20161012 18:22:38 in /builds/slave/test 18:22:38 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 18:22:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:22:38 INFO - {'append_to_log': False, 18:22:38 INFO - 'base_work_dir': '/builds/slave/test', 18:22:38 INFO - 'blob_upload_branch': 'Fx-Team', 18:22:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:22:38 INFO - 'branch': 'Fx-Team', 18:22:38 INFO - 'buildbot_json_path': 'buildprops.json', 18:22:38 INFO - 'config_files': ('talos/linux_config.py',), 18:22:38 INFO - 'default_actions': ('clobber', 18:22:38 INFO - 'read-buildbot-config', 18:22:38 INFO - 'download-and-extract', 18:22:38 INFO - 'populate-webroot', 18:22:38 INFO - 'create-virtualenv', 18:22:38 INFO - 'install', 18:22:38 INFO - 'run-tests'), 18:22:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:22:38 INFO - 'download_minidump_stackwalk': True, 18:22:38 INFO - 'download_symbols': 'ondemand', 18:22:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:22:38 INFO - 'tooltool.py': '/tools/tooltool.py', 18:22:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:22:38 INFO - '/tools/misc-python/virtualenv.py')}, 18:22:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:22:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:22:38 INFO - 'installer_path': 'installer.exe', 18:22:38 INFO - 'log_level': 'info', 18:22:38 INFO - 'log_name': 'talos', 18:22:38 INFO - 'log_to_console': True, 18:22:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:22:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:22:38 INFO - 'opt_config_files': (), 18:22:38 INFO - 'pip_index': False, 18:22:38 INFO - 'sps_profile': False, 18:22:38 INFO - 'sps_profile_interval': 0, 18:22:38 INFO - 'suite': 'dromaeojs', 18:22:38 INFO - 'system_bits': '32', 18:22:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:22:38 INFO - 'title': 'talos-linux64-ix-064', 18:22:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:22:38 INFO - 'use_talos_json': True, 18:22:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:22:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:22:38 INFO - 'work_dir': 'build'} 18:22:38 INFO - [mozharness: 2016-10-13 01:22:38.186219Z] Running clobber step. 18:22:38 INFO - Running pre-action listener: _resource_record_pre_action 18:22:38 INFO - Running main action method: clobber 18:22:38 INFO - rmtree: /builds/slave/test/build 18:22:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:22:38 INFO - Running post-action listener: _resource_record_post_action 18:22:38 INFO - [mozharness: 2016-10-13 01:22:38.692543Z] Finished clobber step (success) 18:22:38 INFO - [mozharness: 2016-10-13 01:22:38.692671Z] Running read-buildbot-config step. 18:22:38 INFO - Running pre-action listener: _resource_record_pre_action 18:22:38 INFO - Running main action method: read_buildbot_config 18:22:38 INFO - Using buildbot properties: 18:22:38 INFO - { 18:22:38 INFO - "project": "", 18:22:38 INFO - "product": "firefox", 18:22:38 INFO - "script_repo_revision": "production", 18:22:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:22:38 INFO - "repository": "", 18:22:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 18:22:38 INFO - "buildid": "20161012153001", 18:22:38 INFO - "pgo_build": "True", 18:22:38 INFO - "basedir": "/builds/slave/test", 18:22:38 INFO - "buildnumber": 1120, 18:22:38 INFO - "slavename": "talos-linux64-ix-064", 18:22:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:22:38 INFO - "platform": "ubuntu64_hw", 18:22:38 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 18:22:38 INFO - "branch": "fx-team", 18:22:38 INFO - "repo_path": "integration/fx-team", 18:22:38 INFO - "revision": "d68def1644c1849141ceaa31bc1b811becfbb8da", 18:22:38 INFO - "stage_platform": "linux64-pgo", 18:22:38 INFO - "builduid": "1d32d4d026744474bb8423209f5c0d4a", 18:22:38 INFO - "slavebuilddir": "test" 18:22:38 INFO - } 18:22:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/O6TL_WIhQJ--VoVKqCkPew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:22:38 INFO - Running post-action listener: _resource_record_post_action 18:22:38 INFO - [mozharness: 2016-10-13 01:22:38.695203Z] Finished read-buildbot-config step (success) 18:22:38 INFO - [mozharness: 2016-10-13 01:22:38.695291Z] Running download-and-extract step. 18:22:38 INFO - Running pre-action listener: _resource_record_pre_action 18:22:38 INFO - Running main action method: download_and_extract 18:22:38 INFO - mkdir: /builds/slave/test/build/tests 18:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:38 INFO - trying https://queue.taskcluster.net/v1/task/O6TL_WIhQJ--VoVKqCkPew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:22:38 INFO - Downloading https://queue.taskcluster.net/v1/task/O6TL_WIhQJ--VoVKqCkPew/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 18:22:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O6TL_WIhQJ--VoVKqCkPew/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 18:22:39 INFO - Downloaded 1361 bytes. 18:22:39 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:22:39 INFO - Using the following test package requirements: 18:22:39 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:22:39 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:22:39 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:22:39 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:39 INFO - u'jsshell-linux-x86_64.zip'], 18:22:39 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:22:39 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:22:39 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:22:39 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:22:39 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:22:39 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:22:39 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:22:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O6TL_WIhQJ--VoVKqCkPew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:22:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O6TL_WIhQJ--VoVKqCkPew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:22:39 INFO - Fetch https://queue.taskcluster.net/v1/task/O6TL_WIhQJ--VoVKqCkPew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:22:39 INFO - Http code: 200 18:22:39 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 18:22:39 INFO - x-amz-cf-id: UL1Nmb0q_edTtOOzrJS5qmPR2uIMipOw1ZbRlULpuaL9YJctwqJiXg== 18:22:39 INFO - x-amz-version-id: bIN5s3M6uGYQG.S4EGb81op8Xrv06d_N 18:22:40 INFO - Expected file size: 22117649 18:22:40 INFO - Obtained file size: 22117649 18:22:44 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 18:22:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O6TL_WIhQJ--VoVKqCkPew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:22:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O6TL_WIhQJ--VoVKqCkPew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:22:44 INFO - Fetch https://queue.taskcluster.net/v1/task/O6TL_WIhQJ--VoVKqCkPew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:22:44 INFO - Http code: 200 18:22:44 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 18:22:44 INFO - x-amz-cf-id: tkCVTRKEY8yAZSljiU-ZMLswpbum45Kl_8p-ppCjARXn7SizS5E5yQ== 18:22:44 INFO - x-amz-version-id: bIN5s3M6uGYQG.S4EGb81op8Xrv06d_N 18:22:45 INFO - Expected file size: 22117649 18:22:45 INFO - Obtained file size: 22117649 18:22:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O6TL_WIhQJ--VoVKqCkPew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:22:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O6TL_WIhQJ--VoVKqCkPew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:22:49 INFO - Fetch https://queue.taskcluster.net/v1/task/O6TL_WIhQJ--VoVKqCkPew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:22:50 INFO - Http code: 200 18:22:50 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 18:22:50 INFO - x-amz-cf-id: xdwGiJIvhvK3RfCTsH86H_hxbCBVY4gC1FLlecMjgK3PNWMMLY4DUg== 18:22:50 INFO - x-amz-version-id: uVyQQJdIS6CBgXn6kRb7j5tT6y6hL_eg 18:22:50 INFO - Expected file size: 14409006 18:22:50 INFO - Obtained file size: 14409006 18:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:50 INFO - trying https://queue.taskcluster.net/v1/task/O6TL_WIhQJ--VoVKqCkPew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:22:50 INFO - Downloading https://queue.taskcluster.net/v1/task/O6TL_WIhQJ--VoVKqCkPew/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 18:22:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O6TL_WIhQJ--VoVKqCkPew/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 18:22:51 INFO - Downloaded 59805831 bytes. 18:22:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O6TL_WIhQJ--VoVKqCkPew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:22:51 INFO - mkdir: /builds/slave/test/properties 18:22:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:22:51 INFO - Writing to file /builds/slave/test/properties/build_url 18:22:51 INFO - Contents: 18:22:51 INFO - build_url:https://queue.taskcluster.net/v1/task/O6TL_WIhQJ--VoVKqCkPew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:22:52 INFO - Running post-action listener: _resource_record_post_action 18:22:52 INFO - Running post-action listener: set_extra_try_arguments 18:22:52 INFO - [mozharness: 2016-10-13 01:22:52.323608Z] Finished download-and-extract step (success) 18:22:52 INFO - [mozharness: 2016-10-13 01:22:52.323835Z] Running populate-webroot step. 18:22:52 INFO - Running pre-action listener: _resource_record_pre_action 18:22:52 INFO - Running main action method: populate_webroot 18:22:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:22:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:22:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:22:52 INFO - '--tppagecycles', 18:22:52 INFO - '7'], 18:22:52 INFO - 'tests': ['tsvgm']}}, 18:22:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:22:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:22:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:22:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:22:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:22:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:22:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:52 INFO - 'talos_options': ['--disable-e10s'], 18:22:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:22:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:22:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:52 INFO - 'talos_options': ['--disable-e10s'], 18:22:52 INFO - 'tests': ['damp', 'tps']}, 18:22:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:52 INFO - 'tests': ['damp', 'tps']}, 18:22:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:22:52 INFO - 'tests': ['dromaeo_dom']}, 18:22:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:22:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:22:52 INFO - 'tests': ['basic_compositor_video']}, 18:22:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:22:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:22:52 INFO - 'tests': ['a11yr', 18:22:52 INFO - 'ts_paint', 18:22:52 INFO - 'tpaint', 18:22:52 INFO - 'sessionrestore', 18:22:52 INFO - 'sessionrestore_no_auto_restore', 18:22:52 INFO - 'tabpaint']}, 18:22:52 INFO - 'other-e10s': {'tests': ['a11yr', 18:22:52 INFO - 'ts_paint', 18:22:52 INFO - 'tpaint', 18:22:52 INFO - 'sessionrestore', 18:22:52 INFO - 'sessionrestore_no_auto_restore', 18:22:52 INFO - 'tabpaint']}, 18:22:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:22:52 INFO - 'ts_paint', 18:22:52 INFO - 'tpaint', 18:22:52 INFO - 'sessionrestore', 18:22:52 INFO - 'sessionrestore_no_auto_restore', 18:22:52 INFO - 'tabpaint']}, 18:22:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:22:52 INFO - 'ts_paint', 18:22:52 INFO - 'tpaint', 18:22:52 INFO - 'sessionrestore', 18:22:52 INFO - 'sessionrestore_no_auto_restore', 18:22:52 INFO - 'tabpaint']}, 18:22:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:22:52 INFO - 'tests': ['a11yr', 18:22:52 INFO - 'ts_paint', 18:22:52 INFO - 'tpaint', 18:22:52 INFO - 'sessionrestore', 18:22:52 INFO - 'sessionrestore_no_auto_restore', 18:22:52 INFO - 'tabpaint']}, 18:22:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:22:52 INFO - 'tests': ['a11yr', 18:22:52 INFO - 'ts_paint', 18:22:52 INFO - 'tpaint', 18:22:52 INFO - 'sessionrestore', 18:22:52 INFO - 'sessionrestore_no_auto_restore', 18:22:52 INFO - 'tabpaint']}, 18:22:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:22:52 INFO - 'tests': ['tsvgx', 18:22:52 INFO - 'tsvgr_opacity', 18:22:52 INFO - 'tart', 18:22:52 INFO - 'tscrollx', 18:22:52 INFO - 'cart']}, 18:22:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:22:52 INFO - 'tsvgr_opacity', 18:22:52 INFO - 'tart', 18:22:52 INFO - 'tscrollx', 18:22:52 INFO - 'cart']}, 18:22:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:52 INFO - 'talos_options': ['--disable-e10s'], 18:22:52 INFO - 'tests': ['tp5o']}, 18:22:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:52 INFO - 'tests': ['tp5o']}, 18:22:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:52 INFO - 'talos_options': ['--disable-e10s', 18:22:52 INFO - '--xperf_path', 18:22:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:22:52 INFO - 'tests': ['tp5n']}, 18:22:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:52 INFO - 'talos_options': ['--xperf_path', 18:22:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:22:52 INFO - 'tests': ['tp5n']}}, 18:22:52 INFO - 'talos.zip': {'path': '', 18:22:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:22:52 INFO - Running post-action listener: _resource_record_post_action 18:22:52 INFO - [mozharness: 2016-10-13 01:22:52.341190Z] Finished populate-webroot step (success) 18:22:52 INFO - [mozharness: 2016-10-13 01:22:52.341279Z] Running create-virtualenv step. 18:22:52 INFO - Running pre-action listener: _resource_record_pre_action 18:22:52 INFO - Running main action method: create_virtualenv 18:22:52 INFO - Creating virtualenv /builds/slave/test/build/venv 18:22:52 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 18:22:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:22:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:22:52 INFO - Using real prefix '/usr' 18:22:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:22:52 INFO - Installing distribute.............................................................................................................................................................................................done. 18:22:54 INFO - Installing pip.................done. 18:22:54 INFO - Return code: 0 18:22:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:22:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:22:55 INFO - Reading from file tmpfile_stdout 18:22:55 INFO - Output received: 18:22:55 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) 18:22:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:22:55 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')]} 18:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:55 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')]} 18:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:55 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 0x7fdf57738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd6e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6b930>, '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 0xd6c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6ccc0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', '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 18:22:55 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 18:22:55 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 18:22:55 INFO - Using env: {'DISPLAY': ':0', 18:22:55 INFO - 'HOME': '/home/cltbld', 18:22:55 INFO - 'LANG': 'en_US.UTF-8', 18:22:55 INFO - 'LANGUAGE': 'en_US:en', 18:22:55 INFO - 'LOGNAME': 'cltbld', 18:22:55 INFO - 'MAIL': '/var/mail/cltbld', 18:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:55 INFO - 'MOZ_NO_REMOTE': '1', 18:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:55 INFO - 'NO_EM_RESTART': '1', 18:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:55 INFO - 'PWD': '/builds/slave/test', 18:22:55 INFO - 'SHELL': '/bin/bash', 18:22:55 INFO - 'SHLVL': '1', 18:22:55 INFO - 'TERM': 'linux', 18:22:55 INFO - 'TMOUT': '86400', 18:22:55 INFO - 'USER': 'cltbld', 18:22:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', 18:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:55 INFO - '_': '/tools/buildbot/bin/python'} 18:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:55 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 18:22:55 INFO - Cleaning up... 18:22:55 INFO - Return code: 0 18:22:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:22:55 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')]} 18:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:55 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')]} 18:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:55 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 0x7fdf57738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd6e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6b930>, '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 0xd6c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6ccc0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', '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 18:22:55 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 18:22:55 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 18:22:55 INFO - Using env: {'DISPLAY': ':0', 18:22:55 INFO - 'HOME': '/home/cltbld', 18:22:55 INFO - 'LANG': 'en_US.UTF-8', 18:22:55 INFO - 'LANGUAGE': 'en_US:en', 18:22:55 INFO - 'LOGNAME': 'cltbld', 18:22:55 INFO - 'MAIL': '/var/mail/cltbld', 18:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:55 INFO - 'MOZ_NO_REMOTE': '1', 18:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:55 INFO - 'NO_EM_RESTART': '1', 18:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:55 INFO - 'PWD': '/builds/slave/test', 18:22:55 INFO - 'SHELL': '/bin/bash', 18:22:55 INFO - 'SHLVL': '1', 18:22:55 INFO - 'TERM': 'linux', 18:22:55 INFO - 'TMOUT': '86400', 18:22:55 INFO - 'USER': 'cltbld', 18:22:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', 18:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:55 INFO - '_': '/tools/buildbot/bin/python'} 18:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:55 INFO - Downloading/unpacking psutil>=3.1.1 18:22:55 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 18:22:55 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 18:22:55 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 18:22:55 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 18:22:55 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 18:22:55 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 18:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:22:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:22:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:22:57 INFO - Installing collected packages: psutil 18:22:57 INFO - Running setup.py install for psutil 18:22:57 INFO - building 'psutil._psutil_linux' extension 18:22:57 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 18:22:57 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 18:22:57 INFO - building 'psutil._psutil_posix' extension 18:22:57 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 18:22:58 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 18:22:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:22:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:22:58 INFO - Successfully installed psutil 18:22:58 INFO - Cleaning up... 18:22:58 INFO - Return code: 0 18:22:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:22:58 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')]} 18:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:58 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')]} 18:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:58 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 0x7fdf57738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd6e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6b930>, '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 0xd6c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6ccc0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', '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 18:22:58 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 18:22:58 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 18:22:58 INFO - Using env: {'DISPLAY': ':0', 18:22:58 INFO - 'HOME': '/home/cltbld', 18:22:58 INFO - 'LANG': 'en_US.UTF-8', 18:22:58 INFO - 'LANGUAGE': 'en_US:en', 18:22:58 INFO - 'LOGNAME': 'cltbld', 18:22:58 INFO - 'MAIL': '/var/mail/cltbld', 18:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:58 INFO - 'MOZ_NO_REMOTE': '1', 18:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:58 INFO - 'NO_EM_RESTART': '1', 18:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:58 INFO - 'PWD': '/builds/slave/test', 18:22:58 INFO - 'SHELL': '/bin/bash', 18:22:58 INFO - 'SHLVL': '1', 18:22:58 INFO - 'TERM': 'linux', 18:22:58 INFO - 'TMOUT': '86400', 18:22:58 INFO - 'USER': 'cltbld', 18:22:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', 18:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:58 INFO - '_': '/tools/buildbot/bin/python'} 18:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:22:58 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 18:22:58 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 18:22:58 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 18:22:58 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 18:22:58 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 18:22:58 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 18:23:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:23:00 INFO - Installing collected packages: mozsystemmonitor 18:23:00 INFO - Running setup.py install for mozsystemmonitor 18:23:00 INFO - Successfully installed mozsystemmonitor 18:23:00 INFO - Cleaning up... 18:23:00 INFO - Return code: 0 18:23:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:23:00 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')]} 18:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:00 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')]} 18:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:00 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 0x7fdf57738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd6e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6b930>, '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 0xd6c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6ccc0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', '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 18:23:00 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 18:23:00 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 18:23:00 INFO - Using env: {'DISPLAY': ':0', 18:23:00 INFO - 'HOME': '/home/cltbld', 18:23:00 INFO - 'LANG': 'en_US.UTF-8', 18:23:00 INFO - 'LANGUAGE': 'en_US:en', 18:23:00 INFO - 'LOGNAME': 'cltbld', 18:23:00 INFO - 'MAIL': '/var/mail/cltbld', 18:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:00 INFO - 'MOZ_NO_REMOTE': '1', 18:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:00 INFO - 'NO_EM_RESTART': '1', 18:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:00 INFO - 'PWD': '/builds/slave/test', 18:23:00 INFO - 'SHELL': '/bin/bash', 18:23:00 INFO - 'SHLVL': '1', 18:23:00 INFO - 'TERM': 'linux', 18:23:00 INFO - 'TMOUT': '86400', 18:23:00 INFO - 'USER': 'cltbld', 18:23:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', 18:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:00 INFO - '_': '/tools/buildbot/bin/python'} 18:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:00 INFO - Downloading/unpacking jsonschema==2.5.1 18:23:00 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 18:23:00 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 18:23:00 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 18:23:00 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 18:23:00 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 18:23:00 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 18:23:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:23:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:02 INFO - Downloading functools32-3.2.3-2.tar.gz 18:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:23:02 INFO - warning: no files found matching '*.txt' 18:23:02 INFO - no previously-included directories found matching 'build' 18:23:02 INFO - no previously-included directories found matching 'dist' 18:23:02 INFO - no previously-included directories found matching '.git*' 18:23:02 INFO - Installing collected packages: jsonschema, functools32 18:23:02 INFO - Running setup.py install for functools32 18:23:03 INFO - warning: no files found matching '*.txt' 18:23:03 INFO - no previously-included directories found matching 'build' 18:23:03 INFO - no previously-included directories found matching 'dist' 18:23:03 INFO - no previously-included directories found matching '.git*' 18:23:03 INFO - Successfully installed jsonschema functools32 18:23:03 INFO - Cleaning up... 18:23:03 INFO - Return code: 0 18:23:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:23:03 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')]} 18:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:03 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')]} 18:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:03 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 0x7fdf57738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd6e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6b930>, '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 0xd6c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6ccc0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', '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 18:23:03 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 18:23:03 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 18:23:03 INFO - Using env: {'DISPLAY': ':0', 18:23:03 INFO - 'HOME': '/home/cltbld', 18:23:03 INFO - 'LANG': 'en_US.UTF-8', 18:23:03 INFO - 'LANGUAGE': 'en_US:en', 18:23:03 INFO - 'LOGNAME': 'cltbld', 18:23:03 INFO - 'MAIL': '/var/mail/cltbld', 18:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:03 INFO - 'MOZ_NO_REMOTE': '1', 18:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:03 INFO - 'NO_EM_RESTART': '1', 18:23:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:03 INFO - 'PWD': '/builds/slave/test', 18:23:03 INFO - 'SHELL': '/bin/bash', 18:23:03 INFO - 'SHLVL': '1', 18:23:03 INFO - 'TERM': 'linux', 18:23:03 INFO - 'TMOUT': '86400', 18:23:03 INFO - 'USER': 'cltbld', 18:23:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', 18:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:03 INFO - '_': '/tools/buildbot/bin/python'} 18:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:23:03 INFO - Cleaning up... 18:23:03 INFO - Return code: 0 18:23:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:23:03 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')]} 18:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:03 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')]} 18:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:03 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 0x7fdf57738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd6e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6b930>, '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 0xd6c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6ccc0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', '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 18:23:03 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 18:23:03 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 18:23:03 INFO - Using env: {'DISPLAY': ':0', 18:23:03 INFO - 'HOME': '/home/cltbld', 18:23:03 INFO - 'LANG': 'en_US.UTF-8', 18:23:03 INFO - 'LANGUAGE': 'en_US:en', 18:23:03 INFO - 'LOGNAME': 'cltbld', 18:23:03 INFO - 'MAIL': '/var/mail/cltbld', 18:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:03 INFO - 'MOZ_NO_REMOTE': '1', 18:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:03 INFO - 'NO_EM_RESTART': '1', 18:23:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:03 INFO - 'PWD': '/builds/slave/test', 18:23:03 INFO - 'SHELL': '/bin/bash', 18:23:03 INFO - 'SHLVL': '1', 18:23:03 INFO - 'TERM': 'linux', 18:23:03 INFO - 'TMOUT': '86400', 18:23:03 INFO - 'USER': 'cltbld', 18:23:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', 18:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:03 INFO - '_': '/tools/buildbot/bin/python'} 18:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:03 INFO - Downloading/unpacking blobuploader==1.2.4 18:23:03 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 18:23:03 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 18:23:03 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 18:23:03 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 18:23:03 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 18:23:03 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 18:23:05 INFO - Downloading blobuploader-1.2.4.tar.gz 18:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:23:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:23:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:23:06 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 18:23:06 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 18:23:06 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 18:23:06 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 18:23:06 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 18:23:06 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 18:23:06 INFO - Downloading docopt-0.6.1.tar.gz 18:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:23:06 INFO - Installing collected packages: blobuploader, requests, docopt 18:23:06 INFO - Running setup.py install for blobuploader 18:23:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:23:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:23:06 INFO - Running setup.py install for requests 18:23:06 INFO - Running setup.py install for docopt 18:23:06 INFO - Successfully installed blobuploader requests docopt 18:23:06 INFO - Cleaning up... 18:23:06 INFO - Return code: 0 18:23:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:06 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 0x7fdf57738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd6e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6b930>, '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 0xd6c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6ccc0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', '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 18:23:06 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 18:23:06 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 18:23:06 INFO - Using env: {'DISPLAY': ':0', 18:23:06 INFO - 'HOME': '/home/cltbld', 18:23:06 INFO - 'LANG': 'en_US.UTF-8', 18:23:06 INFO - 'LANGUAGE': 'en_US:en', 18:23:06 INFO - 'LOGNAME': 'cltbld', 18:23:06 INFO - 'MAIL': '/var/mail/cltbld', 18:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:06 INFO - 'MOZ_NO_REMOTE': '1', 18:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:06 INFO - 'NO_EM_RESTART': '1', 18:23:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:06 INFO - 'PWD': '/builds/slave/test', 18:23:06 INFO - 'SHELL': '/bin/bash', 18:23:06 INFO - 'SHLVL': '1', 18:23:06 INFO - 'TERM': 'linux', 18:23:06 INFO - 'TMOUT': '86400', 18:23:06 INFO - 'USER': 'cltbld', 18:23:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', 18:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:06 INFO - '_': '/tools/buildbot/bin/python'} 18:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:23:07 INFO - Running setup.py (path:/tmp/pip-UR0M4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:23:07 INFO - Running setup.py (path:/tmp/pip-Na4Axy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:23:07 INFO - Running setup.py (path:/tmp/pip-pgWJoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:23:07 INFO - Running setup.py (path:/tmp/pip-JXkOfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:23:07 INFO - Running setup.py (path:/tmp/pip-glmSTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:23:07 INFO - Running setup.py (path:/tmp/pip-9Pek6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:23:07 INFO - Running setup.py (path:/tmp/pip-hhRe7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:23:07 INFO - Running setup.py (path:/tmp/pip-GrCD9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:23:07 INFO - Running setup.py (path:/tmp/pip-HAMtvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:23:07 INFO - Running setup.py (path:/tmp/pip-isbmkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:23:07 INFO - Running setup.py (path:/tmp/pip-oGje4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:23:07 INFO - Running setup.py (path:/tmp/pip-1ARcED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:23:08 INFO - Running setup.py (path:/tmp/pip-huxeSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:23:08 INFO - Running setup.py (path:/tmp/pip-A3WGHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:08 INFO - Running setup.py (path:/tmp/pip-YlHeB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:23:08 INFO - Running setup.py (path:/tmp/pip-Jm2nRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:23:08 INFO - Running setup.py (path:/tmp/pip-jik2R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:23:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:23:08 INFO - Running setup.py install for manifestparser 18:23:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:23:08 INFO - Running setup.py install for mozcrash 18:23:08 INFO - Running setup.py install for mozdebug 18:23:08 INFO - Running setup.py install for mozdevice 18:23:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:23:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:23:08 INFO - Running setup.py install for mozfile 18:23:08 INFO - Running setup.py install for mozhttpd 18:23:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:23:08 INFO - Running setup.py install for mozinfo 18:23:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:23:09 INFO - Running setup.py install for mozInstall 18:23:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:23:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:23:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:23:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:23:09 INFO - Running setup.py install for mozleak 18:23:09 INFO - Running setup.py install for mozlog 18:23:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:23:09 INFO - Running setup.py install for moznetwork 18:23:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:23:09 INFO - Running setup.py install for mozprocess 18:23:09 INFO - Running setup.py install for mozprofile 18:23:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:23:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:23:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:23:09 INFO - Running setup.py install for mozrunner 18:23:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:23:09 INFO - Running setup.py install for mozscreenshot 18:23:09 INFO - Running setup.py install for moztest 18:23:10 INFO - Running setup.py install for mozversion 18:23:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:23:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:23:10 INFO - Cleaning up... 18:23:10 INFO - Return code: 0 18:23:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23:10 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')]} 18:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:10 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')]} 18:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:10 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 0x7fdf57738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd6e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6b930>, '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 0xd6c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6ccc0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', '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 18:23:10 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 18:23:10 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 18:23:10 INFO - Using env: {'DISPLAY': ':0', 18:23:10 INFO - 'HOME': '/home/cltbld', 18:23:10 INFO - 'LANG': 'en_US.UTF-8', 18:23:10 INFO - 'LANGUAGE': 'en_US:en', 18:23:10 INFO - 'LOGNAME': 'cltbld', 18:23:10 INFO - 'MAIL': '/var/mail/cltbld', 18:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:10 INFO - 'MOZ_NO_REMOTE': '1', 18:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:10 INFO - 'NO_EM_RESTART': '1', 18:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:10 INFO - 'PWD': '/builds/slave/test', 18:23:10 INFO - 'SHELL': '/bin/bash', 18:23:10 INFO - 'SHLVL': '1', 18:23:10 INFO - 'TERM': 'linux', 18:23:10 INFO - 'TMOUT': '86400', 18:23:10 INFO - 'USER': 'cltbld', 18:23:10 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', 18:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:10 INFO - '_': '/tools/buildbot/bin/python'} 18:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:23:10 INFO - Running setup.py (path:/tmp/pip-e26_FQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:23:10 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)) 18:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:23:10 INFO - Running setup.py (path:/tmp/pip-c_oiDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:23:10 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)) 18:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:23:10 INFO - Running setup.py (path:/tmp/pip-Mfcpzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:23:10 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)) 18:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:23:10 INFO - Running setup.py (path:/tmp/pip-jjdaFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:23:10 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)) 18:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:23:10 INFO - Running setup.py (path:/tmp/pip-2yKZ02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:23:10 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)) 18:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:23:10 INFO - Running setup.py (path:/tmp/pip-DCwHfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:23:10 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)) 18:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:23:10 INFO - Running setup.py (path:/tmp/pip-h3Y3ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:23:10 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)) 18:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:23:10 INFO - Running setup.py (path:/tmp/pip-8MveRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:23:10 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)) 18:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:23:10 INFO - Running setup.py (path:/tmp/pip-sqTZO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:23:11 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)) 18:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:23:11 INFO - Running setup.py (path:/tmp/pip-mnyYOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:23:11 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)) 18:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:23:11 INFO - Running setup.py (path:/tmp/pip-KAmEoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:23:11 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)) 18:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:23:11 INFO - Running setup.py (path:/tmp/pip-eo5gdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:23:11 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)) 18:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:23:11 INFO - Running setup.py (path:/tmp/pip-bDI7cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:23:11 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)) 18:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:23:11 INFO - Running setup.py (path:/tmp/pip-hD7iVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:23:11 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)) 18:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:11 INFO - Running setup.py (path:/tmp/pip-5Lbzz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:11 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)) 18:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:23:11 INFO - Running setup.py (path:/tmp/pip-d4jx1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:23:11 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)) 18:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:23:11 INFO - Running setup.py (path:/tmp/pip-7LyoOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:23:11 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)) 18:23:11 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)) 18:23:11 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)) 18:23:11 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)) 18:23:11 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)) 18:23:11 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)) 18:23:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:23:11 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 18:23:11 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 18:23:11 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 18:23:11 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 18:23:11 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 18:23:11 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 18:23:13 INFO - Downloading blessings-1.6.tar.gz 18:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:23:13 INFO - Installing collected packages: blessings 18:23:13 INFO - Running setup.py install for blessings 18:23:13 INFO - Successfully installed blessings 18:23:13 INFO - Cleaning up... 18:23:13 INFO - Return code: 0 18:23:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:23:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:23:14 INFO - Reading from file tmpfile_stdout 18:23:14 INFO - Current package versions: 18:23:14 INFO - argparse == 1.2.1 18:23:14 INFO - blessings == 1.6 18:23:14 INFO - blobuploader == 1.2.4 18:23:14 INFO - docopt == 0.6.1 18:23:14 INFO - functools32 == 3.2.3-2 18:23:14 INFO - jsonschema == 2.5.1 18:23:14 INFO - manifestparser == 1.1 18:23:14 INFO - mozInstall == 1.12 18:23:14 INFO - mozcrash == 0.17 18:23:14 INFO - mozdebug == 0.1 18:23:14 INFO - mozdevice == 0.48 18:23:14 INFO - mozfile == 1.2 18:23:14 INFO - mozhttpd == 0.7 18:23:14 INFO - mozinfo == 0.9 18:23:14 INFO - mozleak == 0.1 18:23:14 INFO - mozlog == 3.4 18:23:14 INFO - moznetwork == 0.27 18:23:14 INFO - mozprocess == 0.23 18:23:14 INFO - mozprofile == 0.28 18:23:14 INFO - mozrunner == 6.12 18:23:14 INFO - mozscreenshot == 0.1 18:23:14 INFO - mozsystemmonitor == 0.3 18:23:14 INFO - moztest == 0.7 18:23:14 INFO - mozversion == 1.4 18:23:14 INFO - psutil == 3.1.1 18:23:14 INFO - requests == 1.2.3 18:23:14 INFO - wsgiref == 0.1.2 18:23:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23:14 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')]} 18:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:14 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')]} 18:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:14 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 0x7fdf57738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd6e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6b930>, '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 0xd6c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6ccc0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', '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 18:23:14 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 18:23:14 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 18:23:14 INFO - Using env: {'DISPLAY': ':0', 18:23:14 INFO - 'HOME': '/home/cltbld', 18:23:14 INFO - 'LANG': 'en_US.UTF-8', 18:23:14 INFO - 'LANGUAGE': 'en_US:en', 18:23:14 INFO - 'LOGNAME': 'cltbld', 18:23:14 INFO - 'MAIL': '/var/mail/cltbld', 18:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:14 INFO - 'MOZ_NO_REMOTE': '1', 18:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:14 INFO - 'NO_EM_RESTART': '1', 18:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:14 INFO - 'PWD': '/builds/slave/test', 18:23:14 INFO - 'SHELL': '/bin/bash', 18:23:14 INFO - 'SHLVL': '1', 18:23:14 INFO - 'TERM': 'linux', 18:23:14 INFO - 'TMOUT': '86400', 18:23:14 INFO - 'USER': 'cltbld', 18:23:14 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', 18:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:14 INFO - '_': '/tools/buildbot/bin/python'} 18:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:14 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)) 18:23:14 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)) 18:23:14 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)) 18:23:14 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)) 18:23:14 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)) 18:23:14 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)) 18:23:14 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)) 18:23:14 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)) 18:23:14 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)) 18:23:14 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)) 18:23:14 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)) 18:23:14 INFO - Cleaning up... 18:23:14 INFO - Return code: 0 18:23:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:23:14 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')]} 18:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:14 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')]} 18:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:14 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 0x7fdf57738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd6e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6b930>, '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 0xd6c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6ccc0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', '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 18:23:14 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 18:23:14 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 18:23:14 INFO - Using env: {'DISPLAY': ':0', 18:23:14 INFO - 'HOME': '/home/cltbld', 18:23:14 INFO - 'LANG': 'en_US.UTF-8', 18:23:14 INFO - 'LANGUAGE': 'en_US:en', 18:23:14 INFO - 'LOGNAME': 'cltbld', 18:23:14 INFO - 'MAIL': '/var/mail/cltbld', 18:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:14 INFO - 'MOZ_NO_REMOTE': '1', 18:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:14 INFO - 'NO_EM_RESTART': '1', 18:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:14 INFO - 'PWD': '/builds/slave/test', 18:23:14 INFO - 'SHELL': '/bin/bash', 18:23:14 INFO - 'SHLVL': '1', 18:23:14 INFO - 'TERM': 'linux', 18:23:14 INFO - 'TMOUT': '86400', 18:23:14 INFO - 'USER': 'cltbld', 18:23:14 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', 18:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:14 INFO - '_': '/tools/buildbot/bin/python'} 18:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:23:14 INFO - Cleaning up... 18:23:14 INFO - Return code: 0 18:23:14 INFO - Running post-action listener: _resource_record_post_action 18:23:14 INFO - Running post-action listener: _start_resource_monitoring 18:23:14 INFO - Starting resource monitoring. 18:23:14 INFO - [mozharness: 2016-10-13 01:23:14.686168Z] Finished create-virtualenv step (success) 18:23:14 INFO - [mozharness: 2016-10-13 01:23:14.686705Z] Running install step. 18:23:14 INFO - Running pre-action listener: _resource_record_pre_action 18:23:14 INFO - Running main action method: install 18:23:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:23:14 INFO - Reading from file tmpfile_stdout 18:23:14 INFO - Detecting whether we're running mozinstall >=1.0... 18:23:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:23:14 INFO - Reading from file tmpfile_stdout 18:23:14 INFO - Output received: 18:23:14 INFO - Usage: mozinstall [options] installer 18:23:14 INFO - Options: 18:23:14 INFO - -h, --help show this help message and exit 18:23:14 INFO - -d DEST, --destination=DEST 18:23:14 INFO - Directory to install application into. [default: 18:23:14 INFO - "/builds/slave/test"] 18:23:14 INFO - --app=APP Application being installed. [default: firefox] 18:23:14 INFO - mkdir: /builds/slave/test/build/application 18:23:14 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'] 18:23:14 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 18:23:32 INFO - Reading from file tmpfile_stdout 18:23:32 INFO - Output received: 18:23:32 INFO - /builds/slave/test/build/application/firefox/firefox 18:23:32 INFO - Running post-action listener: _resource_record_post_action 18:23:32 INFO - [mozharness: 2016-10-13 01:23:32.043526Z] Finished install step (success) 18:23:32 INFO - [mozharness: 2016-10-13 01:23:32.043773Z] Running run-tests step. 18:23:32 INFO - Running pre-action listener: _resource_record_pre_action 18:23:32 INFO - Running main action method: run_tests 18:23:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:23:32 INFO - Python 2.7.3 18:23:32 INFO - Return code: 0 18:23:32 INFO - grabbing minidump binary from tooltool 18:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:32 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 0xd6b930>, '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 0xd6c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6ccc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:23:32 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 18:23:32 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 18:23:32 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 18:23:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:23:32 INFO - Return code: 0 18:23:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:23:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:23:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:23:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:23:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:23:32 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/O6TL_WIhQJ--VoVKqCkPew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 18:23:32 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/O6TL_WIhQJ--VoVKqCkPew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 18:23:32 INFO - Using env: {'DISPLAY': ':0', 18:23:32 INFO - 'HOME': '/home/cltbld', 18:23:32 INFO - 'LANG': 'en_US.UTF-8', 18:23:32 INFO - 'LANGUAGE': 'en_US:en', 18:23:32 INFO - 'LOGNAME': 'cltbld', 18:23:32 INFO - 'MAIL': '/var/mail/cltbld', 18:23:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:23:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:32 INFO - 'MOZ_NO_REMOTE': '1', 18:23:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:32 INFO - 'NO_EM_RESTART': '1', 18:23:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:32 INFO - 'PWD': '/builds/slave/test', 18:23:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:23:32 INFO - 'SHELL': '/bin/bash', 18:23:32 INFO - 'SHLVL': '1', 18:23:32 INFO - 'TERM': 'linux', 18:23:32 INFO - 'TMOUT': '86400', 18:23:32 INFO - 'USER': 'cltbld', 18:23:32 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765', 18:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:32 INFO - '_': '/tools/buildbot/bin/python'} 18:23:32 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/O6TL_WIhQJ--VoVKqCkPew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 18:23:32 INFO - mozversion application_buildid: 20161012153001 18:23:32 INFO - mozversion application_changeset: d68def1644c1849141ceaa31bc1b811becfbb8da 18:23:32 INFO - mozversion application_display_name: Nightly 18:23:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:23:32 INFO - mozversion application_name: Firefox 18:23:32 INFO - mozversion application_remotingname: firefox 18:23:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:23:32 INFO - mozversion application_vendor: Mozilla 18:23:32 INFO - mozversion application_version: 52.0a1 18:23:32 INFO - mozversion platform_buildid: 20161012153001 18:23:32 INFO - mozversion platform_changeset: d68def1644c1849141ceaa31bc1b811becfbb8da 18:23:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:23:32 INFO - mozversion platform_version: 52.0a1 18:23:32 INFO - using testdate: 1476321812 18:23:32 INFO - actual date: 1476321812 18:23:32 INFO - starting webserver on 'localhost:43872' 18:23:32 INFO - SUITE-START | Running 2 tests 18:23:32 INFO - TEST-START | dromaeo_css 18:23:32 INFO - operating with platform_type : linux_ 18:23:32 INFO - Initialising browser for dromaeo_css test... 18:23:32 INFO - TEST-INFO | started process 10805 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4yJVub/profile http://localhost:43872/getInfo.html) 18:23:36 INFO - PROCESS | 10805 | __metrics Screen width/height:1600/1200 18:23:36 INFO - PROCESS | 10805 | colorDepth:24 18:23:36 INFO - PROCESS | 10805 | Browser inner width/height: 1024/697 18:23:36 INFO - PROCESS | 10805 | __metrics 18:23:37 INFO - PROCESS | 10805 | 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" 18:23:37 INFO - PROCESS | 10805 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:23:38 INFO - PROCESS | 10805 | console.error: PushService: 18:23:38 INFO - PROCESS | 10805 | stateChangeProcessEnqueue: Error transitioning state 18:23:38 INFO - PROCESS | 10805 | UnknownError 18:23:38 INFO - TEST-INFO | 10805: exit 0 18:23:38 INFO - Browser initialized. 18:23:38 INFO - Running cycle 1/1 for dromaeo_css test... 18:23:38 INFO - TEST-INFO | started process 10888 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4yJVub/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:23:50 INFO - PROCESS | 10888 | RSS: Main: 173260800 18:23:50 INFO - PROCESS | 10888 | 18:24:42 INFO - PROCESS | 10888 | 1476321882038 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] 18:26:52 INFO - PROCESS | 10888 | Cycle 1(1): loaded http://localhost:43872/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43872/tests/dromaeo/cssquery-ext.html) 18:26:54 INFO - PROCESS | 10888 | RSS: Main: 366137344 18:26:54 INFO - PROCESS | 10888 | 18:29:57 INFO - PROCESS | 10888 | Cycle 1(1): loaded http://localhost:43872/tests/dromaeo/cssquery-ext.html (next: http://localhost:43872/tests/dromaeo/cssquery-jquery.html) 18:29:58 INFO - PROCESS | 10888 | RSS: Main: 277897216 18:29:58 INFO - PROCESS | 10888 | 18:33:00 INFO - PROCESS | 10888 | Cycle 1(1): loaded http://localhost:43872/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43872/tests/dromaeo/cssquery-mootools.html) 18:33:00 INFO - PROCESS | 10888 | RSS: Main: 253943808 18:33:00 INFO - PROCESS | 10888 | 18:36:02 INFO - PROCESS | 10888 | Cycle 1(1): loaded http://localhost:43872/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43872/tests/dromaeo/cssquery-prototype.html) 18:36:03 INFO - PROCESS | 10888 | RSS: Main: 252645376 18:36:03 INFO - PROCESS | 10888 | 18:39:05 INFO - PROCESS | 10888 | Cycle 1(1): loaded http://localhost:43872/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43872/tests/dromaeo/cssquery-yui.html) 18:39:06 INFO - PROCESS | 10888 | RSS: Main: 215339008 18:39:06 INFO - PROCESS | 10888 | 18:42:09 INFO - PROCESS | 10888 | Cycle 1(1): loaded http://localhost:43872/tests/dromaeo/cssquery-yui.html (next: http://localhost:43872/tests/dromaeo/cssquery-dojo.html) 18:42:09 INFO - PROCESS | 10888 | RSS: Main: 307859456 18:42:09 INFO - PROCESS | 10888 | 18:42:09 INFO - PROCESS | 10888 | __start_tp_report 18:42:09 INFO - PROCESS | 10888 | _x_x_mozilla_page_load 18:42:09 INFO - PROCESS | 10888 | _x_x_mozilla_page_load_details 18:42:09 INFO - PROCESS | 10888 | |i|pagename|runs| 18:42:09 INFO - PROCESS | 10888 | |0;dojo.html;2939.514980028295;2979.4339075575645;2981.1652737233567;3004.6094007778984;3031.348260124073;5109.131447653898;5146.6140039497;5194.402643695976;5198.558122559582;5219.086659834523;5212.322398088243;5232.110541207994;5244.082285600024;5245.947540524594;5259.710715910624;4757.999999999991;4777.80888764449;4801.975990120044;4826.831060912868;4836.637252206081;4764.2615394613895;4798.4961579034225;4833.564979151875;4858.052679727437;4904.75476226189;4744.810207591692;4774.68964517307;4779.761011949406;4782.354382158399;4875.658703890729;4786.569208771228;4822.903541929177;4824.421069471651;4826.565609095163;4867.050925069595;4587.747673877935;4622.12179685862;4721.834735784266;4731.976340118312;4784.832530861403;5242.266082748418;5245.659032162897;5255.632105752599;5257;5336.119540275849;5550.555955523549;5612.494875461187;5613.494785469286;5616.157576363537;5616.646929453587;5447.1829225616075;5555.916661250085;5581;5650.971745141289;5700.6579605223405;5237.083510385705;5240.895182096337;5244.370675518886;5295.576353891718;5301.469853014668;5705.942940570541;5713.171590119493;5721.170430287585;5728.255326807488;5729.9713501432225;5357.116075847442;5479.397266300703;5492.340919089735;5496.1755736639025;5499.395066542677;5621.409751976065;5656.85857853557;5661.065924122556;5719.027765279912;5724.169995350734;5592.872376472474;5631.042722737145;5638.35158956717;5647.0964645656495;5647.407022262603;5444.183372494158;5499.175123731472;5603.915941260884;5653.717314134276;5712.057510510802;4294.141171765659;4295.548967358445;4328.913421731548;4331.45856767904;4368.716033457815;3849.9615003850163;3852.3836186210074;3862.3240932836643;3896.5129358830145;3910.6284902934176;5375.247465354853;5388.757505912244;5388.838334849961;5398.028354896156;5407.83776486706;5470.53500452466;5481.397046324901;5580.051391263495;5635.098384258499;5694.886102277931;5346.1713434417725;5392.245085688007;5395.62230643859;5396.892062158813;5446.101393270145;4875.098106850244;4883.633727470454;4888.340074089952;4900.313956046157;4903.681260718042;5596.664200148004;5633.915491267716;5637.548996080303;5641.40765219646;5689.487946084872;5491.945080549303;5492.697901615449;5493.148561972901;5511.58663100261;5558.305211848519;5603.467670571289;5642.210090587403;5650.660960342392;5654.067078932095;5659.292588426447;5372;5374.274472946102;5382.30030096085;5417.8103766367985;5462.20797984298;5545.805896793593;5548.944510554843;5549.278593782782;5603.131514615241;5613.494785469327;5372.167314066326;5421.83734487966;5423.511883930308;5425.159100339453;5426.728663566727;5256.816011439581;5291.973540132275;5293.497117773805;5424.538914192338;5482.205080263419;5231.712255825966;5293.338332708411;5298.523132918056;5300.70846103468;5302.734863256899;5385.703786291791;5392.433794451683;5396.541293990055;5402.35171779389;5403.216533602685;5280.841574752763;5290.444503327095;5305.681659100466;5336.9466305338;5343.145096784496 18:42:09 INFO - PROCESS | 10888 | |1;ext.html;534.3970740812682;590.1560768101616;606.5147881694643;610.9022556390977;620.230913667053;31319.99999999997;31820.840895795518;34099.7835140716;42580;42688.35967460483;43226.13547729044;43823.78088109563;43847.34228986568;43878.78060609692;43882.341764873556;8659.783505412368;8811.471311721285;8814.206721395074;8816.338774591899;8822.73531794044;8007.639656215484;8125.75622731319;8718.476891386505;10349.534270957825;10532.157427405828;10600.204984626145;10670;10687.78624427511;10690.412027338492;10694.839577406345;10516.842247366296;10568;10575.788484230272;10576.471176441186;10576.682699519026;10382.3251488653;10421.843672344921;10436.530356133992;10440.530176142092;10447.231483656837;41305.58694413077;41314.586854131376;41436;41452.79273603613;41482.585174148175;3362.680545348188;3429.66210372491;3586.4261718125235;3802.7528210666496;4069.450624165759;30911.536326955113;31840.522392164137;31956.360872782647;32111.357772844647;32132;4237.957620423787;4382.189294980407;4389.253826849444;4430.379746835446;4530.904694421597;336540;336738;337789;338040;339251;57263.42736572581;57389.13916291259;57550.424495755346;57607.423925761046;57608;60858;61169.69415152896;61236.693816530635;61262.38737612656;61313.38686613166;16565.503034908972;16717.58206044834;16775.328986840635;16783;16800;11454.599089031844;13262.204267743966;13358.799618005738;13359;13360.265185414895;14496.927515362355;16803.663926721398;16877.746833797504;17093.401730939357;17578.824211757717;6110.327863934964;6118.357572454917;6252.27952895561;6294.9685251574365;6375.57728063333;895.2927187521915;917.9036201198911;1018.1142406106735;1028.7376718936623;1054.1461416252707;30391;30567.847160764053;30627.69372306293;30628;31047.223819404695;1028.2545154762886;1048.2452634103433;1048.758785479344;1096.331237944853;1168.976620467603;15232.771508427382;16214.75677864833;16317.510474685778;16369.345226190819;16607;501350;502307;503382;505990;510426;57021;57176;57240.42759572351;57296.42703572911;57379.71310143422;1124.3254047571554;1136.108155098244;1152.2280072351546;1296.1574976265315;1296.2611311552325;28349.180639291782;31240.37519249557;31458.370832583678;33562.496562551096;34182;53651.0491922948;54704;54824.725876370365;54837;55308.170377445174;439133;441039;441117;441313;442554;23892;27511.449771004067;28079.71920280771;28368.290792730346;40047.799761001006;36933.63066369302;44586.77706611446;46422;46669.76665116653;50584.78225241717;38251.95871160304;39803.40294895637;39900;40790.79604601958;41270.1745965073;39138.02154946149;40085;40207.396889047275;40258.39612405757;41137.38293925534;39474.60525394824;40189.1962160761;40985.97535061647;41066;41325.79337103295;31954.36091278208;33895.49156762601;34485.310293794486;34567.827160864035;35117.64882351144;25966.61050084288;26681.33296667599;26695.866520667274;26783.598246025937;26961.46077078408 18:42:09 INFO - PROCESS | 10888 | |2;jquery.html;384.11913602742004;387.83323171036443;387.8855737557422;392.3017029687157;408.92843752343333;13825;14136.151830890154;18168.818311816878;18911.148998295077;18929.62140757184;14469.276536173176;17473.388431404903;17819.821801781978;18033.27866885326;18332.450026499195;5442.1292593185;5682.232898558704;5683.772649094031;5685.005124103286;5690.06113991191;5320.920186197211;5560.972195139018;5607.719614019303;5612.214289999403;5619.943800562003;5591.888162236753;5598.916016259759;5603.859903502404;5605.7197140143035;5607.775688972436;5586.664800111986;5842.912356314659;5874.353821079678;5926.140709597127;5929.436703513203;5555.638883472561;5699.715014249271;5731.283589551306;5748.396418376094;5749.626274292157;13423.798643020362;13552.59342219735;13726;13799.103058301178;13813.033087683867;2268.739095004079;2296.9655455168186;2337.18198630478;2496.7752902238885;2865.785066120049;9792.706218813448;9951;10003.199744020461;10541.894581054168;10546.789064218672;1837.9356722514647;1954.482062253504;1956.833669138125;1962.2151139544153;2003.8096380843797;75763;76429.61785191094;77247;79667.20332796656;82158;10389.480525973671;10493.370397776158;10801.405922674328;10998.845121262313;11056.613018544473;15200;15215.391384344724;15225.086494810126;15229.695406092038;15239.466618668293;7501.699932002768;7608.543487390774;7807.375409967189;7929.801754956172;7948.602569871483;7229.421646268286;7283.854322913512;7333.266673332624;7515.586642734593;7545.660445279976;4641.187792136363;4654.185517534418;4663.720176789404;4669.556392142741;4743.549362810528;1940.9611807764047;1948.9317873874347;1952.7461430014291;1988.5923385705896;2002.7396438462906;827.7930517370658;851.1233429567556;862.2799962031773;901.6753968571309;955.3885513271512;17278.22247998843;17364.479065628053;18123.45629631113;18328;18353.90823045876;907.841127802632;920.4753290624413;945.5933948402253;965.6716716316346;996.2030375699557;7532;9929.453880036668;10109.595616175271;10226.846597301046;10306.639267625596;439368;442995;443233;443833;446755;52744.20883686748;66723;73866.63066684632;77396.61301693568;87758.12241877627;943.1652987106323;969.8108868770522;996.4107248937933;996.4768496539375;997.586001809241;15457.381704731684;15471.845281547041;15880.841191587937;16240.837591623933;16474.505764827074;38393;38688.03279917912;38997.6100238994;39424.802875985435;40718.59281407267;48438.75780621074;53601.731991339795;54558;56162.438375617356;56230;8282.917170828214;8403.453775504573;8437;8516.148385161434;8600.569971501525;10727.892721072689;12777.8083328752;12830.871691282968;12916.806247906477;13301.401436935555;10871.619493318012;11039.779204416027;11218.83171752408;11334.299855021483;11687;11014.834777478505;11384.658460246206;11463.426828658367;11486.483108259981;11538.59614913474;11045.447727613426;11292.604758833402;11548.249363791327;11660.533578657098;11920.880791191978;8251.587420629065;8450.746477605682;8548.444351117158;8552.486850788973;8711;10024;11273.492692828679;11329.433528323387;11837.099910521632;11950.282983021047 18:42:09 INFO - PROCESS | 10888 | |3;mootools.html;1228.920120192188;1421.950231741889;1496.169625857649;1558.0262336039975;1748.2395158106224;7585.696572137108;8096.514209147448;8445.915540844582;8724.912750872489;8785.077566855469;8646.394752367321;9001.729948101567;9005.504697241666;9008.414453060563;9010.369274150811;2280.144945645387;2327.3367090379247;2329.1149363241943;2336.509333040055;2339.368370539953;2266.9886650566805;2275.4311422144465;2328.3015095471374;2328.662343960125;2329.895154718042;2278.3848360942534;2294.6328587426015;2313.5835549601065;2321.9187328443422;2322.5354929014266;2247.4493749031512;2250.369896428986;2254.4363909022745;2254.864708117518;2256.537409830989;2236.452069243046;2238.1383167480476;2239.4065572623267;2243.652233903731;2247.078697733921;8970.147835955573;9019.188273055457;9024.593893274818;9094.136057074567;9099.681511147079;5154.716490593016;5302.2841916341185;5373.838784836461;5449.83650490482;5467.0705979983495;3323.6842499962463;3463.6363181865795;3478.7912725236565;3530.117470632342;3554.7156227501996;1065.5790962569743;1110.3892858927557;1114.7157474843943;1129.3901293301608;1130.508228920414;12356.938215308955;12395.132340736152;12432.12975091744;12452.439640216213;12469.563565275172;4525.162844873709;4532.297493888453;4699.671023028423;4703.0593881223895;4781.163296423112;10761.30051546647;10776.407297598551;10780.083692886035;10789.56841726338;10800.081993030522;5327.334083239595;5363.946360536423;5369.27514785499;5372.328458942632;5378.973105134528;4360.716553424018;4491.528389519119;4723.078999595046;4780.402449693788;4895.779689913962;3925.156091440354;3988.2821092203103;4019.256437559061;4053.2906741320153;4142.337226043818;1260.2753416785386;1274.706817431996;1276.8914642255327;1303.6284658872366;1304.9739005219842;852.2755657690913;855.4354126276628;873.0919843362832;877;890.3767362846033;5384.5692344612335;5546;5546.391546451565;5680.801171958961;5698.572607054488;908.14180599333;929.2101713543569;955.1212884146602;960.8366577681811;970.9951450242703;3731.2910546995986;3731.402975523903;3742.5134732484603;3763.7553559018575;3859.150986782903;11272.267302625303;11336.263142895685;11365.488553015135;11418.42907854604;11431.885681143249;11169.44152792357;11239.100871930226;11298.435078246055;11325.716857078474;11341.206115571997;8207.179282071746;8480.618372173267;8591;8596.484210947488;8635.272945410943;5520.972395138159;5557.388687244481;5628.831135065954;5649.491545760901;5702.258706368146;10099.7475063124;10112;10256.846147307946;10301.9484902575;10762.085222756154;10746.08658264025;10756.139508839118;10799.460026998775;10817.18871084656;10911.018008379284;8086.353091752763;8152.673893044449;8164.632591533514;8195.46729462583;8261.13258107914;8626.5255410953;8652.653893844175;8652.870206946774;8659.913400865911;8712.825743485222;7760.68957241704;7823.374130069695;7883.526988380716;8024;8072.677092916218;7718.6140692964;7802.960985195265;7815.25755053269;7854.72508462201;7861.056673199024;6991.860162796817;7030.191527974348;7081.8937715935335;7092.9645351772915;7097.183823860322;4878.463369029333;4892.3884514435695;4912.631552633496;4981.42713587942;5152.458991805956;4844.249141383091;4865.951340486691;4876.536729010881;4939.9259011114145;4977.576905963034 18:42:09 INFO - PROCESS | 10888 | |4;prototype.html;325.23894087834475;334.1195948675241;336.71883976879303;341.82396066026;341.9931601367971;5098.388193416786;5211.5049070338355;5238.5023422774875;5320.866978325539;5324.840254792358;4958.735522441772;5102.285680004793;5122.871928201796;5194.844154675357;5196.480351964801;4087.4890638670167;4126.8968275793195;4146.212219678259;4158.106007208449;4168.166366726652;3996.9800150999204;4096.87709368718;4128.710990230685;4129.442525259096;4142.97928510357;4057.9594204058026;4072.470578824749;4079.5716449772644;4098.590140985907;4104.6921480888905;4041.8181181846594;4061.2689715851134;4081.795910204493;4085.346344584867;4088.0393107619684;3443.862245510202;3546.8364297778335;3575.302815950891;3582.7850328980344;3592.2456284180353;4997.925031124536;5011.198208286693;5014.52362025607;5014.949850501521;5024.371953505812;4591.977040114778;4605.194091034055;4623.953760462386;4625.005623790901;4631.976840115812;5259.842204733826;5327.593696931419;5338.893222135574;5366.382865970424;5386.8383948481605;3898.6491215790716;3900.161465284949;3906.8279516145326;3907.1990242000606;3910.7458015228917;5587.8882422351735;5609.102543593046;5614.242077319591;5622.3253209614695;5630.577706672016;3835.6356146166067;3930.6265904739003;3943.4282029106193;3981.223661386002;3984.521857377133;4004.9199016020098;4006.3790112532606;4009.4386785850006;4015.1768887378016;4019.3673144090667;4589.449266088024;4591.517890621503;4602.309653551994;4605.332226827091;4606.170889239969;5309.33633295838;5405.702631368522;5411.972940135274;5428.619996600279;5462.863428414322;1376.2705765944065;1380.9240491773048;1381.412899517701;1401.2223216115153;1403.6701375176826;872.7861673889811;882.139913584263;893.6238193182426;897.8832751742362;901.4591245252795;4697.95302046982;4710.5760481556135;4718.9854181351175;4722.748471655014;4738.336632871401;4892.51074892515;4910.183232204036;4941.209406494943;4967.776450059756;4967.90064198714;4304.849330273425;4635.745034023161;4647.6281897448125;4659.673822832437;4673.481118636457;2559.3473664215876;2560.270322957985;2593.312772115391;2605.3616863868097;2614.2157352794084;5020.397552293748;5026.89946201074;5032.131684939623;5035;5048.217526283359;4757.265546546014;4840.370751802314;4926.950730492649;4997.775100120503;4997.85006449807;4955.819439446632;4956.330895329156;4970.801167953241;4972.477889821589;4999.625028122832;4852.611791056777;4860.781264843161;4873.902521949471;4899.926501102557;4909.312696222603;4593.356930029865;4811.78346974394;4824.276358546246;4863.781129849236;4875.099315907029;4943.604511638989;4951.801927922843;4985.6510044298;4987.975060124676;5020.673656212334;3623.9490547741916;3756.154865155318;3847.2882516734494;3874.108954940323;3967.9206415870945;5470.74172940218;5476.945230547643;5521.751521181637;5544.69504177258;5557.583181261502;5428.91856622143;5432.755526001419;5434.891302174014;5436.510714035756;5437.429069947599;5187.144121219956;5321.7073060980465;5334.199870019528;5336.319059496246;5344.968911813486;5282.867928301823;5297.205419187153;5340.652857564246;5349.679019258857;5376.247325374373;5158.561522270649;5385.27298814655;5411.918821217763;5439.156930675752;5464;5328.575498148256;5343.866403339947;5356.785728570813;5358.7320633967365;5359.544438722753 18:42:09 INFO - PROCESS | 10888 | |5;yui.html;720.8594324106798;729.8467321862407;744.4156337275236;795.8806179073142;827.8137419080704;15313.464028758995;16315.184240787943;16321.755173672389;16331.83668163318;16867.40964066258;15157.393704251845;15397.769033464507;15524.534263972071;15527.22363881807;15540.611484712888;794.4121350200868;818.1082619944259;820.2084987986592;820.3765138494757;821.3511326052411;647.7052940911898;662.8177251255895;786.2294950948045;799.2247519905711;810.8743144812534;849.4393700157897;854.6581367453007;855.6235256487157;856.905740368559;857.0786404615033;845.6532821543137;846.4413487098547;846.724814435308;847.5465625890181;847.6228078505068;499.8029718823434;505.9519345662193;508.22495694066845;508.8498892826625;600.2047287344286;13642.045056846026;14087.788683169658;14112.435502579885;14114;14242.07426517273;13180.934095329558;13456.79814802769;13660.043796934218;13884.166949983033;13956.371963261678;11521.251118677343;11966.162368634199;12216.328101954388;12243.449044792917;12395.814062789066;3730.8694195703292;3810.733248672594;3838.5201849768778;3889.1638297766117;3937.4093885917055;83222.58388708078;86049.13950860474;86702;86720.56639716824;86730;10794.676159715222;11000.064994475399;11023.944880275707;11088.722781930517;11332.830007549894;21394.465138371666;21597.67603485949;21601.567968640855;21616.135354585957;21622.675659865115;8120.553369564731;8145.226203510657;8213.91139347404;8415.915840841513;8600.096989816104;4296.978515107405;4330.870073897788;4360.062586543908;4400.515943246241;4497.595216430537;3307.570015897918;3420.281740834403;3778.8677396290996;3936.6063393660406;3938.547067087264;664.8138521214067;677.9423748981392;678.816719485736;685.8319711670673;693.5076095971916;579.826052184343;643.1799455693935;659.22541014308;705.9576425414491;714.9642517874086;8826.212860486328;8906.73279801607;9096.909030909606;9206.861897071549;9234.1689247968;597.5070566782422;638.7668500997103;644.8033349828254;645.2031740800109;681.2880539835884;4189.874303770892;4354.107407981356;4451.977740111279;4537.342085397599;4561.959496714175;73676.26323736693;74252;114235;123774;124077.37961310135;99245;100023.49988250012;100338;100699;102029;58038.129428058615;60804;67537;82191;93951;8385.874211886705;8524.829503410021;8525.531095789544;8701.52141632191;8814.955925220333;53214;53841.730791347356;54258.7287063578;54829.04978778135;55436.72281638566;73341.26658733345;75849.62075189588;78933;79182;79490;12044.457999390224;12145.332006739714;12395.938020310201;12624.621261362174;13304.13523120994;14169.858301416854;14504.782428263374;14561.854381456473;14690.63273418173;14899.702005960036;13535.79696304576;13736.910282905881;13751.656208594864;14145;14353.425862965365;12580.87419125797;12668.429920653776;13567.321633918067;13868.375923083284;14617.92691036538;12937.417816198482;13109.147905386119;13564;13575;13997.44010239579;10812.729681758019;11266.549338026714;11439.14206434504;11620.186586939171;11640.76718465609;9736.610535578497;10881.401522916;11398.772393831896;12013.579524716593;12110.273383597012 18:42:09 INFO - PROCESS | 10888 | __end_tp_report 18:42:09 INFO - PROCESS | 10888 | __start_cc_report 18:42:09 INFO - PROCESS | 10888 | _x_x_mozilla_cycle_collect,1880 18:42:09 INFO - PROCESS | 10888 | __end_cc_report 18:42:09 INFO - PROCESS | 10888 | __startTimestamp1476322929762__endTimestamp 18:42:09 INFO - PROCESS | 10888 | 18:42:09 INFO - PROCESS | 10888 | ------- Summary: start ------- 18:42:09 INFO - PROCESS | 10888 | Number of tests: 6 18:42:09 INFO - PROCESS | 10888 | 18:42:09 INFO - PROCESS | 10888 | [#0] dojo.html Cycles:165 Average:5184.95 Median:5374.27 stddev:570.11 (10.6%) stddev-sans-first:543.97 18:42:09 INFO - PROCESS | 10888 | Values: 2939.5 2979.4 2981.2 3004.6 3031.3 5109.1 5146.6 5194.4 5198.6 5219.1 5212.3 5232.1 5244.1 5245.9 5259.7 4758.0 4777.8 4802.0 4826.8 4836.6 4764.3 4798.5 4833.6 4858.1 4904.8 4744.8 4774.7 4779.8 4782.4 4875.7 4786.6 4822.9 4824.4 4826.6 4867.1 4587.7 4622.1 4721.8 4732.0 4784.8 5242.3 5245.7 5255.6 5257.0 5336.1 5550.6 5612.5 5613.5 5616.2 5616.6 5447.2 5555.9 5581.0 5651.0 5700.7 5237.1 5240.9 5244.4 5295.6 5301.5 5705.9 5713.2 5721.2 5728.3 5730.0 5357.1 5479.4 5492.3 5496.2 5499.4 5621.4 5656.9 5661.1 5719.0 5724.2 5592.9 5631.0 5638.4 5647.1 5647.4 5444.2 5499.2 5603.9 5653.7 5712.1 4294.1 4295.5 4328.9 4331.5 4368.7 3850.0 3852.4 3862.3 3896.5 3910.6 5375.2 5388.8 5388.8 5398.0 5407.8 5470.5 5481.4 5580.1 5635.1 5694.9 5346.2 5392.2 5395.6 5396.9 5446.1 4875.1 4883.6 4888.3 4900.3 4903.7 5596.7 5633.9 5637.5 5641.4 5689.5 5491.9 5492.7 5493.1 5511.6 5558.3 5603.5 5642.2 5650.7 5654.1 5659.3 5372.0 5374.3 5382.3 5417.8 5462.2 5545.8 5548.9 5549.3 5603.1 5613.5 5372.2 5421.8 5423.5 5425.2 5426.7 5256.8 5292.0 5293.5 5424.5 5482.2 5231.7 5293.3 5298.5 5300.7 5302.7 5385.7 5392.4 5396.5 5402.4 5403.2 5280.8 5290.4 5305.7 5336.9 5343.1 18:42:09 INFO - PROCESS | 10888 | 18:42:09 INFO - PROCESS | 10888 | [#1] ext.html Cycles:180 Average:58775.21 Median:20368.19 stddev:114749.10 (563.4%) stddev-sans-first:114987.69 18:42:09 INFO - PROCESS | 10888 | Values: 534.4 590.2 606.5 610.9 620.2 31320.0 31820.8 34099.8 42580.0 42688.4 43226.1 43823.8 43847.3 43878.8 43882.3 8659.8 8811.5 8814.2 8816.3 8822.7 8007.6 8125.8 8718.5 10349.5 10532.2 10600.2 10670.0 10687.8 10690.4 10694.8 10516.8 10568.0 10575.8 10576.5 10576.7 10382.3 10421.8 10436.5 10440.5 10447.2 41305.6 41314.6 41436.0 41452.8 41482.6 3362.7 3429.7 3586.4 3802.8 4069.5 30911.5 31840.5 31956.4 32111.4 32132.0 4238.0 4382.2 4389.3 4430.4 4530.9 336540.0 336738.0 337789.0 338040.0 339251.0 57263.4 57389.1 57550.4 57607.4 57608.0 60858.0 61169.7 61236.7 61262.4 61313.4 16565.5 16717.6 16775.3 16783.0 16800.0 11454.6 13262.2 13358.8 13359.0 13360.3 14496.9 16803.7 16877.7 17093.4 17578.8 6110.3 6118.4 6252.3 6295.0 6375.6 895.3 917.9 1018.1 1028.7 1054.1 30391.0 30567.8 30627.7 30628.0 31047.2 1028.3 1048.2 1048.8 1096.3 1169.0 15232.8 16214.8 16317.5 16369.3 16607.0 501350.0 502307.0 503382.0 505990.0 510426.0 57021.0 57176.0 57240.4 57296.4 57379.7 1124.3 1136.1 1152.2 1296.2 1296.3 28349.2 31240.4 31458.4 33562.5 34182.0 53651.0 54704.0 54824.7 54837.0 55308.2 439133.0 441039.0 441117.0 441313.0 442554.0 23892.0 27511.4 28079.7 28368.3 40047.8 36933.6 44586.8 46422.0 46669.8 50584.8 38252.0 39803.4 39900.0 40790.8 41270.2 39138.0 40085.0 40207.4 40258.4 41137.4 39474.6 40189.2 40986.0 41066.0 41325.8 31954.4 33895.5 34485.3 34567.8 35117.6 25966.6 26681.3 26695.9 26783.6 26961.5 18:42:09 INFO - PROCESS | 10888 | 18:42:09 INFO - PROCESS | 10888 | [#2] jquery.html Cycles:180 Average:26277.80 Median:219888.46 stddev:72941.98 (33.2%) stddev-sans-first:73120.69 18:42:09 INFO - PROCESS | 10888 | Values: 384.1 387.8 387.9 392.3 408.9 13825.0 14136.2 18168.8 18911.1 18929.6 14469.3 17473.4 17819.8 18033.3 18332.5 5442.1 5682.2 5683.8 5685.0 5690.1 5320.9 5561.0 5607.7 5612.2 5619.9 5591.9 5598.9 5603.9 5605.7 5607.8 5586.7 5842.9 5874.4 5926.1 5929.4 5555.6 5699.7 5731.3 5748.4 5749.6 13423.8 13552.6 13726.0 13799.1 13813.0 2268.7 2297.0 2337.2 2496.8 2865.8 9792.7 9951.0 10003.2 10541.9 10546.8 1837.9 1954.5 1956.8 1962.2 2003.8 75763.0 76429.6 77247.0 79667.2 82158.0 10389.5 10493.4 10801.4 10998.8 11056.6 15200.0 15215.4 15225.1 15229.7 15239.5 7501.7 7608.5 7807.4 7929.8 7948.6 7229.4 7283.9 7333.3 7515.6 7545.7 4641.2 4654.2 4663.7 4669.6 4743.5 1941.0 1948.9 1952.7 1988.6 2002.7 827.8 851.1 862.3 901.7 955.4 17278.2 17364.5 18123.5 18328.0 18353.9 907.8 920.5 945.6 965.7 996.2 7532.0 9929.5 10109.6 10226.8 10306.6 439368.0 442995.0 443233.0 443833.0 446755.0 52744.2 66723.0 73866.6 77396.6 87758.1 943.2 969.8 996.4 996.5 997.6 15457.4 15471.8 15880.8 16240.8 16474.5 38393.0 38688.0 38997.6 39424.8 40718.6 48438.8 53601.7 54558.0 56162.4 56230.0 8282.9 8403.5 8437.0 8516.1 8600.6 10727.9 12777.8 12830.9 12916.8 13301.4 10871.6 11039.8 11218.8 11334.3 11687.0 11014.8 11384.7 11463.4 11486.5 11538.6 11045.4 11292.6 11548.2 11660.5 11920.9 8251.6 8450.7 8548.4 8552.5 8711.0 10024.0 11273.5 11329.4 11837.1 11950.3 18:42:09 INFO - PROCESS | 10888 | 18:42:09 INFO - PROCESS | 10888 | [#3] mootools.html Cycles:180 Average:5856.19 Median:4713.07 stddev:3430.09 (72.8%) stddev-sans-first:3422.08 18:42:09 INFO - PROCESS | 10888 | Values: 1228.9 1422.0 1496.2 1558.0 1748.2 7585.7 8096.5 8445.9 8724.9 8785.1 8646.4 9001.7 9005.5 9008.4 9010.4 2280.1 2327.3 2329.1 2336.5 2339.4 2267.0 2275.4 2328.3 2328.7 2329.9 2278.4 2294.6 2313.6 2321.9 2322.5 2247.4 2250.4 2254.4 2254.9 2256.5 2236.5 2238.1 2239.4 2243.7 2247.1 8970.1 9019.2 9024.6 9094.1 9099.7 5154.7 5302.3 5373.8 5449.8 5467.1 3323.7 3463.6 3478.8 3530.1 3554.7 1065.6 1110.4 1114.7 1129.4 1130.5 12356.9 12395.1 12432.1 12452.4 12469.6 4525.2 4532.3 4699.7 4703.1 4781.2 10761.3 10776.4 10780.1 10789.6 10800.1 5327.3 5363.9 5369.3 5372.3 5379.0 4360.7 4491.5 4723.1 4780.4 4895.8 3925.2 3988.3 4019.3 4053.3 4142.3 1260.3 1274.7 1276.9 1303.6 1305.0 852.3 855.4 873.1 877.0 890.4 5384.6 5546.0 5546.4 5680.8 5698.6 908.1 929.2 955.1 960.8 971.0 3731.3 3731.4 3742.5 3763.8 3859.2 11272.3 11336.3 11365.5 11418.4 11431.9 11169.4 11239.1 11298.4 11325.7 11341.2 8207.2 8480.6 8591.0 8596.5 8635.3 5521.0 5557.4 5628.8 5649.5 5702.3 10099.7 10112.0 10256.8 10301.9 10762.1 10746.1 10756.1 10799.5 10817.2 10911.0 8086.4 8152.7 8164.6 8195.5 8261.1 8626.5 8652.7 8652.9 8659.9 8712.8 7760.7 7823.4 7883.5 8024.0 8072.7 7718.6 7803.0 7815.3 7854.7 7861.1 6991.9 7030.2 7081.9 7093.0 7097.2 4878.5 4892.4 4912.6 4981.4 5152.5 4844.2 4866.0 4876.5 4939.9 4977.6 18:42:09 INFO - PROCESS | 10888 | 18:42:09 INFO - PROCESS | 10888 | [#4] prototype.html Cycles:180 Average:4384.39 Median:4896.22 stddev:1254.40 (25.6%) stddev-sans-first:1220.36 18:42:09 INFO - PROCESS | 10888 | Values: 325.2 334.1 336.7 341.8 342.0 5098.4 5211.5 5238.5 5320.9 5324.8 4958.7 5102.3 5122.9 5194.8 5196.5 4087.5 4126.9 4146.2 4158.1 4168.2 3997.0 4096.9 4128.7 4129.4 4143.0 4058.0 4072.5 4079.6 4098.6 4104.7 4041.8 4061.3 4081.8 4085.3 4088.0 3443.9 3546.8 3575.3 3582.8 3592.2 4997.9 5011.2 5014.5 5014.9 5024.4 4592.0 4605.2 4624.0 4625.0 4632.0 5259.8 5327.6 5338.9 5366.4 5386.8 3898.6 3900.2 3906.8 3907.2 3910.7 5587.9 5609.1 5614.2 5622.3 5630.6 3835.6 3930.6 3943.4 3981.2 3984.5 4004.9 4006.4 4009.4 4015.2 4019.4 4589.4 4591.5 4602.3 4605.3 4606.2 5309.3 5405.7 5412.0 5428.6 5462.9 1376.3 1380.9 1381.4 1401.2 1403.7 872.8 882.1 893.6 897.9 901.5 4698.0 4710.6 4719.0 4722.7 4738.3 4892.5 4910.2 4941.2 4967.8 4967.9 4304.8 4635.7 4647.6 4659.7 4673.5 2559.3 2560.3 2593.3 2605.4 2614.2 5020.4 5026.9 5032.1 5035.0 5048.2 4757.3 4840.4 4927.0 4997.8 4997.9 4955.8 4956.3 4970.8 4972.5 4999.6 4852.6 4860.8 4873.9 4899.9 4909.3 4593.4 4811.8 4824.3 4863.8 4875.1 4943.6 4951.8 4985.7 4988.0 5020.7 3623.9 3756.2 3847.3 3874.1 3967.9 5470.7 5476.9 5521.8 5544.7 5557.6 5428.9 5432.8 5434.9 5436.5 5437.4 5187.1 5321.7 5334.2 5336.3 5345.0 5282.9 5297.2 5340.7 5349.7 5376.2 5158.6 5385.3 5411.9 5439.2 5464.0 5328.6 5343.9 5356.8 5358.7 5359.5 18:42:09 INFO - PROCESS | 10888 | 18:42:09 INFO - PROCESS | 10888 | [#5] yui.html Cycles:180 Average:20438.46 Median:4380.29 stddev:29356.72 (670.2%) stddev-sans-first:29401.74 18:42:09 INFO - PROCESS | 10888 | Values: 720.9 729.8 744.4 795.9 827.8 15313.5 16315.2 16321.8 16331.8 16867.4 15157.4 15397.8 15524.5 15527.2 15540.6 794.4 818.1 820.2 820.4 821.4 647.7 662.8 786.2 799.2 810.9 849.4 854.7 855.6 856.9 857.1 845.7 846.4 846.7 847.5 847.6 499.8 506.0 508.2 508.8 600.2 13642.0 14087.8 14112.4 14114.0 14242.1 13180.9 13456.8 13660.0 13884.2 13956.4 11521.3 11966.2 12216.3 12243.4 12395.8 3730.9 3810.7 3838.5 3889.2 3937.4 83222.6 86049.1 86702.0 86720.6 86730.0 10794.7 11000.1 11023.9 11088.7 11332.8 21394.5 21597.7 21601.6 21616.1 21622.7 8120.6 8145.2 8213.9 8415.9 8600.1 4297.0 4330.9 4360.1 4400.5 4497.6 3307.6 3420.3 3778.9 3936.6 3938.5 664.8 677.9 678.8 685.8 693.5 579.8 643.2 659.2 706.0 715.0 8826.2 8906.7 9096.9 9206.9 9234.2 597.5 638.8 644.8 645.2 681.3 4189.9 4354.1 4452.0 4537.3 4562.0 73676.3 74252.0 114235.0 123774.0 124077.4 99245.0 100023.5 100338.0 100699.0 102029.0 58038.1 60804.0 67537.0 82191.0 93951.0 8385.9 8524.8 8525.5 8701.5 8815.0 53214.0 53841.7 54258.7 54829.0 55436.7 73341.3 75849.6 78933.0 79182.0 79490.0 12044.5 12145.3 12395.9 12624.6 13304.1 14169.9 14504.8 14561.9 14690.6 14899.7 13535.8 13736.9 13751.7 14145.0 14353.4 12580.9 12668.4 13567.3 13868.4 14617.9 12937.4 13109.1 13564.0 13575.0 13997.4 10812.7 11266.5 11439.1 11620.2 11640.8 9736.6 10881.4 11398.8 12013.6 12110.3 18:42:09 INFO - PROCESS | 10888 | -------- Summary: end -------- 18:42:09 INFO - PROCESS | 10888 | 18:42:10 INFO - TEST-INFO | 10888: exit 0 18:42:10 INFO - TEST-OK | dromaeo_css | took 1118467ms 18:42:10 INFO - TEST-START | kraken 18:42:10 INFO - operating with platform_type : linux_ 18:42:10 INFO - Initialising browser for kraken test... 18:42:10 INFO - TEST-INFO | started process 11194 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp09sm7Y/profile http://localhost:43872/getInfo.html) 18:42:14 INFO - PROCESS | 11194 | __metrics Screen width/height:1600/1200 18:42:14 INFO - PROCESS | 11194 | colorDepth:24 18:42:14 INFO - PROCESS | 11194 | Browser inner width/height: 1024/697 18:42:14 INFO - PROCESS | 11194 | __metrics 18:42:15 INFO - PROCESS | 11194 | 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" 18:42:15 INFO - PROCESS | 11194 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:42:16 INFO - PROCESS | 11194 | console.error: PushService: 18:42:16 INFO - PROCESS | 11194 | stateChangeProcessEnqueue: Error transitioning state 18:42:16 INFO - PROCESS | 11194 | UnknownError 18:42:17 INFO - TEST-INFO | 11194: exit 0 18:42:17 INFO - Browser initialized. 18:42:17 INFO - Running cycle 1/1 for kraken test... 18:42:17 INFO - TEST-INFO | started process 11275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp09sm7Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:42:29 INFO - PROCESS | 11275 | RSS: Main: 172326912 18:42:29 INFO - PROCESS | 11275 | 18:42:31 INFO - PROCESS | 11275 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43872/tests/kraken/driver.html?testName=audio-beat-detection) 18:42:32 INFO - PROCESS | 11275 | RSS: Main: 232103936 18:42:32 INFO - PROCESS | 11275 | 18:42:35 INFO - PROCESS | 11275 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43872/tests/kraken/driver.html?testName=audio-dft) 18:42:35 INFO - PROCESS | 11275 | RSS: Main: 216301568 18:42:35 INFO - PROCESS | 11275 | 18:42:39 INFO - PROCESS | 11275 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43872/tests/kraken/driver.html?testName=audio-fft) 18:42:39 INFO - PROCESS | 11275 | RSS: Main: 298532864 18:42:39 INFO - PROCESS | 11275 | 18:42:41 INFO - PROCESS | 11275 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43872/tests/kraken/driver.html?testName=audio-oscillator) 18:42:42 INFO - PROCESS | 11275 | RSS: Main: 207028224 18:42:42 INFO - PROCESS | 11275 | 18:42:44 INFO - PROCESS | 11275 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43872/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:42:45 INFO - PROCESS | 11275 | RSS: Main: 212025344 18:42:45 INFO - PROCESS | 11275 | 18:42:48 INFO - PROCESS | 11275 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43872/tests/kraken/driver.html?testName=imaging-darkroom) 18:42:48 INFO - PROCESS | 11275 | RSS: Main: 248434688 18:42:48 INFO - PROCESS | 11275 | 18:42:52 INFO - PROCESS | 11275 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43872/tests/kraken/driver.html?testName=imaging-desaturate) 18:42:52 INFO - PROCESS | 11275 | RSS: Main: 247427072 18:42:52 INFO - PROCESS | 11275 | 18:42:55 INFO - PROCESS | 11275 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43872/tests/kraken/driver.html?testName=json-parse-financial) 18:42:56 INFO - PROCESS | 11275 | RSS: Main: 247062528 18:42:56 INFO - PROCESS | 11275 | 18:42:57 INFO - PROCESS | 11275 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43872/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:42:58 INFO - PROCESS | 11275 | RSS: Main: 209203200 18:42:58 INFO - PROCESS | 11275 | 18:42:59 INFO - PROCESS | 11275 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:43:00 INFO - PROCESS | 11275 | RSS: Main: 216588288 18:43:00 INFO - PROCESS | 11275 | 18:43:02 INFO - PROCESS | 11275 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:43:03 INFO - PROCESS | 11275 | RSS: Main: 225619968 18:43:03 INFO - PROCESS | 11275 | 18:43:05 INFO - PROCESS | 11275 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:43:06 INFO - PROCESS | 11275 | RSS: Main: 235196416 18:43:06 INFO - PROCESS | 11275 | 18:43:09 INFO - PROCESS | 11275 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:43:09 INFO - PROCESS | 11275 | RSS: Main: 231915520 18:43:09 INFO - PROCESS | 11275 | 18:43:11 INFO - PROCESS | 11275 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43872/tests/kraken/driver.html?testName=ai-astar) 18:43:11 INFO - PROCESS | 11275 | RSS: Main: 282312704 18:43:11 INFO - PROCESS | 11275 | 18:43:11 INFO - PROCESS | 11275 | __start_tp_report 18:43:11 INFO - PROCESS | 11275 | _x_x_mozilla_page_load 18:43:11 INFO - PROCESS | 11275 | _x_x_mozilla_page_load_details 18:43:11 INFO - PROCESS | 11275 | |i|pagename|runs| 18:43:11 INFO - PROCESS | 11275 | |0;ai-astar;110;110;112;111;112;111;111;112;112;112 18:43:11 INFO - PROCESS | 11275 | |1;audio-beat-detection;148;119;123;173;123;125;121;123;170;124 18:43:11 INFO - PROCESS | 11275 | |2;audio-dft;159;161;161;160;166;161;160;160;159;163 18:43:11 INFO - PROCESS | 11275 | |3;audio-fft;75;75;77;115;76;76;76;75;97;77 18:43:11 INFO - PROCESS | 11275 | |4;audio-oscillator;82;83;114;83;82;82;102;82;81;111 18:43:11 INFO - PROCESS | 11275 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 18:43:11 INFO - PROCESS | 11275 | |6;imaging-darkroom;145;146;146;145;145;146;146;146;146;146 18:43:11 INFO - PROCESS | 11275 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;94 18:43:11 INFO - PROCESS | 11275 | |8;json-parse-financial;53;53;52;52;52;53;52;54;52;53 18:43:11 INFO - PROCESS | 11275 | |9;json-stringify-tinderbox;61;62;61;62;62;61;61;61;61;61 18:43:11 INFO - PROCESS | 11275 | |10;stanford-crypto-aes;80;79;79;79;79;79;80;79;79;78 18:43:11 INFO - PROCESS | 11275 | |11;stanford-crypto-ccm;140;134;131;141;130;129;138;133;171;135 18:43:11 INFO - PROCESS | 11275 | |12;stanford-crypto-pbkdf2;164;163;167;164;178;165;163;162;166;166 18:43:11 INFO - PROCESS | 11275 | |13;stanford-crypto-sha256-iterative;67;68;66;66;65;66;69;70;65;64 18:43:11 INFO - PROCESS | 11275 | __end_tp_report 18:43:11 INFO - PROCESS | 11275 | __start_cc_report 18:43:11 INFO - PROCESS | 11275 | _x_x_mozilla_cycle_collect,1690 18:43:11 INFO - PROCESS | 11275 | __end_cc_report 18:43:11 INFO - PROCESS | 11275 | __startTimestamp1476322991849__endTimestamp 18:43:11 INFO - PROCESS | 11275 | 18:43:11 INFO - PROCESS | 11275 | ------- Summary: start ------- 18:43:11 INFO - PROCESS | 11275 | Number of tests: 14 18:43:11 INFO - PROCESS | 11275 | 18:43:11 INFO - PROCESS | 11275 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 18:43:11 INFO - PROCESS | 11275 | Values: 110.0 110.0 112.0 111.0 112.0 111.0 111.0 112.0 112.0 112.0 18:43:11 INFO - PROCESS | 11275 | 18:43:11 INFO - PROCESS | 11275 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:124.50 stddev:20.93 (16.8%) stddev-sans-first:21.66 18:43:11 INFO - PROCESS | 11275 | Values: 148.0 119.0 123.0 173.0 123.0 125.0 121.0 123.0 170.0 124.0 18:43:11 INFO - PROCESS | 11275 | 18:43:11 INFO - PROCESS | 11275 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:2.11 (1.3%) stddev-sans-first:2.11 18:43:11 INFO - PROCESS | 11275 | Values: 159.0 161.0 161.0 160.0 166.0 161.0 160.0 160.0 159.0 163.0 18:43:11 INFO - PROCESS | 11275 | 18:43:11 INFO - PROCESS | 11275 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:13.41 (17.6%) stddev-sans-first:13.99 18:43:11 INFO - PROCESS | 11275 | Values: 75.0 75.0 77.0 115.0 76.0 76.0 76.0 75.0 97.0 77.0 18:43:11 INFO - PROCESS | 11275 | 18:43:11 INFO - PROCESS | 11275 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:82.00 stddev:13.31 (16.2%) stddev-sans-first:13.79 18:43:11 INFO - PROCESS | 11275 | Values: 82.0 83.0 114.0 83.0 82.0 82.0 102.0 82.0 81.0 111.0 18:43:11 INFO - PROCESS | 11275 | 18:43:11 INFO - PROCESS | 11275 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 18:43:11 INFO - PROCESS | 11275 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 18:43:11 INFO - PROCESS | 11275 | 18:43:11 INFO - PROCESS | 11275 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 18:43:11 INFO - PROCESS | 11275 | Values: 145.0 146.0 146.0 145.0 145.0 146.0 146.0 146.0 146.0 146.0 18:43:11 INFO - PROCESS | 11275 | 18:43:11 INFO - PROCESS | 11275 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 18:43:11 INFO - PROCESS | 11275 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 18:43:11 INFO - PROCESS | 11275 | 18:43:11 INFO - PROCESS | 11275 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 18:43:11 INFO - PROCESS | 11275 | Values: 53.0 53.0 52.0 52.0 52.0 53.0 52.0 54.0 52.0 53.0 18:43:11 INFO - PROCESS | 11275 | 18:43:11 INFO - PROCESS | 11275 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 18:43:11 INFO - PROCESS | 11275 | Values: 61.0 62.0 61.0 62.0 62.0 61.0 61.0 61.0 61.0 61.0 18:43:11 INFO - PROCESS | 11275 | 18:43:11 INFO - PROCESS | 11275 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:0.57 (0.7%) stddev-sans-first:0.50 18:43:11 INFO - PROCESS | 11275 | Values: 80.0 79.0 79.0 79.0 79.0 79.0 80.0 79.0 79.0 78.0 18:43:11 INFO - PROCESS | 11275 | 18:43:11 INFO - PROCESS | 11275 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:136.50 stddev:12.23 (9.0%) stddev-sans-first:12.95 18:43:11 INFO - PROCESS | 11275 | Values: 140.0 134.0 131.0 141.0 130.0 129.0 138.0 133.0 171.0 135.0 18:43:11 INFO - PROCESS | 11275 | 18:43:11 INFO - PROCESS | 11275 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:165.50 stddev:4.57 (2.8%) stddev-sans-first:4.80 18:43:11 INFO - PROCESS | 11275 | Values: 164.0 163.0 167.0 164.0 178.0 165.0 163.0 162.0 166.0 166.0 18:43:11 INFO - PROCESS | 11275 | 18:43:11 INFO - PROCESS | 11275 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:1.90 (2.9%) stddev-sans-first:2.01 18:43:11 INFO - PROCESS | 11275 | Values: 67.0 68.0 66.0 66.0 65.0 66.0 69.0 70.0 65.0 64.0 18:43:11 INFO - PROCESS | 11275 | -------- Summary: end -------- 18:43:11 INFO - PROCESS | 11275 | 18:43:13 INFO - TEST-INFO | 11275: exit 0 18:43:13 INFO - TEST-OK | kraken | took 62331ms 18:43:13 INFO - SUITE-END | took 1180s 18:43:13 INFO - Completed test suite (00:19:41) 18:43:13 INFO - javascript benchmark 18:43:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2939.514980028295, 2979.4339075575645, 2981.1652737233567, 3004.6094007778984, 3031.348260124073, 5109.131447653898, 5146.6140039497, 5194.402643695976, 5198.558122559582, 5219.086659834523, 5212.322398088243, 5232.110541207994, 5244.082285600024, 5245.947540524594, 5259.710715910624, 4757.999999999991, 4777.80888764449, 4801.975990120044, 4826.831060912868, 4836.637252206081, 4764.2615394613895, 4798.4961579034225, 4833.564979151875, 4858.052679727437, 4904.75476226189, 4744.810207591692, 4774.68964517307, 4779.761011949406, 4782.354382158399, 4875.658703890729, 4786.569208771228, 4822.903541929177, 4824.421069471651, 4826.565609095163, 4867.050925069595, 4587.747673877935, 4622.12179685862, 4721.834735784266, 4731.976340118312, 4784.832530861403, 5242.266082748418, 5245.659032162897, 5255.632105752599, 5257.0, 5336.119540275849, 5550.555955523549, 5612.494875461187, 5613.494785469286, 5616.157576363537, 5616.646929453587, 5447.1829225616075, 5555.916661250085, 5581.0, 5650.971745141289, 5700.6579605223405, 5237.083510385705, 5240.895182096337, 5244.370675518886, 5295.576353891718, 5301.469853014668, 5705.942940570541, 5713.171590119493, 5721.170430287585, 5728.255326807488, 5729.9713501432225, 5357.116075847442, 5479.397266300703, 5492.340919089735, 5496.1755736639025, 5499.395066542677, 5621.409751976065, 5656.85857853557, 5661.065924122556, 5719.027765279912, 5724.169995350734, 5592.872376472474, 5631.042722737145, 5638.35158956717, 5647.0964645656495, 5647.407022262603, 5444.183372494158, 5499.175123731472, 5603.915941260884, 5653.717314134276, 5712.057510510802, 4294.141171765659, 4295.548967358445, 4328.913421731548, 4331.45856767904, 4368.716033457815, 3849.9615003850163, 3852.3836186210074, 3862.3240932836643, 3896.5129358830145, 3910.6284902934176, 5375.247465354853, 5388.757505912244, 5388.838334849961, 5398.028354896156, 5407.83776486706, 5470.53500452466, 5481.397046324901, 5580.051391263495, 5635.098384258499, 5694.886102277931, 5346.1713434417725, 5392.245085688007, 5395.62230643859, 5396.892062158813, 5446.101393270145, 4875.098106850244, 4883.633727470454, 4888.340074089952, 4900.313956046157, 4903.681260718042, 5596.664200148004, 5633.915491267716, 5637.548996080303, 5641.40765219646, 5689.487946084872, 5491.945080549303, 5492.697901615449, 5493.148561972901, 5511.58663100261, 5558.305211848519, 5603.467670571289, 5642.210090587403, 5650.660960342392, 5654.067078932095, 5659.292588426447, 5372.0, 5374.274472946102, 5382.30030096085, 5417.8103766367985, 5462.20797984298, 5545.805896793593, 5548.944510554843, 5549.278593782782, 5603.131514615241, 5613.494785469327, 5372.167314066326, 5421.83734487966, 5423.511883930308, 5425.159100339453, 5426.728663566727, 5256.816011439581, 5291.973540132275, 5293.497117773805, 5424.538914192338, 5482.205080263419, 5231.712255825966, 5293.338332708411, 5298.523132918056, 5300.70846103468, 5302.734863256899, 5385.703786291791, 5392.433794451683, 5396.541293990055, 5402.35171779389, 5403.216533602685, 5280.841574752763, 5290.444503327095, 5305.681659100466, 5336.9466305338, 5343.145096784496], "value": 5147.079184408261, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.3970740812682, 590.1560768101616, 606.5147881694643, 610.9022556390977, 620.230913667053, 31319.99999999997, 31820.840895795518, 34099.7835140716, 42580.0, 42688.35967460483, 43226.13547729044, 43823.78088109563, 43847.34228986568, 43878.78060609692, 43882.341764873556, 8659.783505412368, 8811.471311721285, 8814.206721395074, 8816.338774591899, 8822.73531794044, 8007.639656215484, 8125.75622731319, 8718.476891386505, 10349.534270957825, 10532.157427405828, 10600.204984626145, 10670.0, 10687.78624427511, 10690.412027338492, 10694.839577406345, 10516.842247366296, 10568.0, 10575.788484230272, 10576.471176441186, 10576.682699519026, 10382.3251488653, 10421.843672344921, 10436.530356133992, 10440.530176142092, 10447.231483656837, 41305.58694413077, 41314.586854131376, 41436.0, 41452.79273603613, 41482.585174148175, 3362.680545348188, 3429.66210372491, 3586.4261718125235, 3802.7528210666496, 4069.450624165759, 30911.536326955113, 31840.522392164137, 31956.360872782647, 32111.357772844647, 32132.0, 4237.957620423787, 4382.189294980407, 4389.253826849444, 4430.379746835446, 4530.904694421597, 336540.0, 336738.0, 337789.0, 338040.0, 339251.0, 57263.42736572581, 57389.13916291259, 57550.424495755346, 57607.423925761046, 57608.0, 60858.0, 61169.69415152896, 61236.693816530635, 61262.38737612656, 61313.38686613166, 16565.503034908972, 16717.58206044834, 16775.328986840635, 16783.0, 16800.0, 11454.599089031844, 13262.204267743966, 13358.799618005738, 13359.0, 13360.265185414895, 14496.927515362355, 16803.663926721398, 16877.746833797504, 17093.401730939357, 17578.824211757717, 6110.327863934964, 6118.357572454917, 6252.27952895561, 6294.9685251574365, 6375.57728063333, 895.2927187521915, 917.9036201198911, 1018.1142406106735, 1028.7376718936623, 1054.1461416252707, 30391.0, 30567.847160764053, 30627.69372306293, 30628.0, 31047.223819404695, 1028.2545154762886, 1048.2452634103433, 1048.758785479344, 1096.331237944853, 1168.976620467603, 15232.771508427382, 16214.75677864833, 16317.510474685778, 16369.345226190819, 16607.0, 501350.0, 502307.0, 503382.0, 505990.0, 510426.0, 57021.0, 57176.0, 57240.42759572351, 57296.42703572911, 57379.71310143422, 1124.3254047571554, 1136.108155098244, 1152.2280072351546, 1296.1574976265315, 1296.2611311552325, 28349.180639291782, 31240.37519249557, 31458.370832583678, 33562.496562551096, 34182.0, 53651.0491922948, 54704.0, 54824.725876370365, 54837.0, 55308.170377445174, 439133.0, 441039.0, 441117.0, 441313.0, 442554.0, 23892.0, 27511.449771004067, 28079.71920280771, 28368.290792730346, 40047.799761001006, 36933.63066369302, 44586.77706611446, 46422.0, 46669.76665116653, 50584.78225241717, 38251.95871160304, 39803.40294895637, 39900.0, 40790.79604601958, 41270.1745965073, 39138.02154946149, 40085.0, 40207.396889047275, 40258.39612405757, 41137.38293925534, 39474.60525394824, 40189.1962160761, 40985.97535061647, 41066.0, 41325.79337103295, 31954.36091278208, 33895.49156762601, 34485.310293794486, 34567.827160864035, 35117.64882351144, 25966.61050084288, 26681.33296667599, 26695.866520667274, 26783.598246025937, 26961.46077078408], "value": 19877.94327092238, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.11913602742004, 387.83323171036443, 387.8855737557422, 392.3017029687157, 408.92843752343333, 13825.0, 14136.151830890154, 18168.818311816878, 18911.148998295077, 18929.62140757184, 14469.276536173176, 17473.388431404903, 17819.821801781978, 18033.27866885326, 18332.450026499195, 5442.1292593185, 5682.232898558704, 5683.772649094031, 5685.005124103286, 5690.06113991191, 5320.920186197211, 5560.972195139018, 5607.719614019303, 5612.214289999403, 5619.943800562003, 5591.888162236753, 5598.916016259759, 5603.859903502404, 5605.7197140143035, 5607.775688972436, 5586.664800111986, 5842.912356314659, 5874.353821079678, 5926.140709597127, 5929.436703513203, 5555.638883472561, 5699.715014249271, 5731.283589551306, 5748.396418376094, 5749.626274292157, 13423.798643020362, 13552.59342219735, 13726.0, 13799.103058301178, 13813.033087683867, 2268.739095004079, 2296.9655455168186, 2337.18198630478, 2496.7752902238885, 2865.785066120049, 9792.706218813448, 9951.0, 10003.199744020461, 10541.894581054168, 10546.789064218672, 1837.9356722514647, 1954.482062253504, 1956.833669138125, 1962.2151139544153, 2003.8096380843797, 75763.0, 76429.61785191094, 77247.0, 79667.20332796656, 82158.0, 10389.480525973671, 10493.370397776158, 10801.405922674328, 10998.845121262313, 11056.613018544473, 15200.0, 15215.391384344724, 15225.086494810126, 15229.695406092038, 15239.466618668293, 7501.699932002768, 7608.543487390774, 7807.375409967189, 7929.801754956172, 7948.602569871483, 7229.421646268286, 7283.854322913512, 7333.266673332624, 7515.586642734593, 7545.660445279976, 4641.187792136363, 4654.185517534418, 4663.720176789404, 4669.556392142741, 4743.549362810528, 1940.9611807764047, 1948.9317873874347, 1952.7461430014291, 1988.5923385705896, 2002.7396438462906, 827.7930517370658, 851.1233429567556, 862.2799962031773, 901.6753968571309, 955.3885513271512, 17278.22247998843, 17364.479065628053, 18123.45629631113, 18328.0, 18353.90823045876, 907.841127802632, 920.4753290624413, 945.5933948402253, 965.6716716316346, 996.2030375699557, 7532.0, 9929.453880036668, 10109.595616175271, 10226.846597301046, 10306.639267625596, 439368.0, 442995.0, 443233.0, 443833.0, 446755.0, 52744.20883686748, 66723.0, 73866.63066684632, 77396.61301693568, 87758.12241877627, 943.1652987106323, 969.8108868770522, 996.4107248937933, 996.4768496539375, 997.586001809241, 15457.381704731684, 15471.845281547041, 15880.841191587937, 16240.837591623933, 16474.505764827074, 38393.0, 38688.03279917912, 38997.6100238994, 39424.802875985435, 40718.59281407267, 48438.75780621074, 53601.731991339795, 54558.0, 56162.438375617356, 56230.0, 8282.917170828214, 8403.453775504573, 8437.0, 8516.148385161434, 8600.569971501525, 10727.892721072689, 12777.8083328752, 12830.871691282968, 12916.806247906477, 13301.401436935555, 10871.619493318012, 11039.779204416027, 11218.83171752408, 11334.299855021483, 11687.0, 11014.834777478505, 11384.658460246206, 11463.426828658367, 11486.483108259981, 11538.59614913474, 11045.447727613426, 11292.604758833402, 11548.249363791327, 11660.533578657098, 11920.880791191978, 8251.587420629065, 8450.746477605682, 8548.444351117158, 8552.486850788973, 8711.0, 10024.0, 11273.492692828679, 11329.433528323387, 11837.099910521632, 11950.282983021047], "value": 8699.024751802983, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1228.920120192188, 1421.950231741889, 1496.169625857649, 1558.0262336039975, 1748.2395158106224, 7585.696572137108, 8096.514209147448, 8445.915540844582, 8724.912750872489, 8785.077566855469, 8646.394752367321, 9001.729948101567, 9005.504697241666, 9008.414453060563, 9010.369274150811, 2280.144945645387, 2327.3367090379247, 2329.1149363241943, 2336.509333040055, 2339.368370539953, 2266.9886650566805, 2275.4311422144465, 2328.3015095471374, 2328.662343960125, 2329.895154718042, 2278.3848360942534, 2294.6328587426015, 2313.5835549601065, 2321.9187328443422, 2322.5354929014266, 2247.4493749031512, 2250.369896428986, 2254.4363909022745, 2254.864708117518, 2256.537409830989, 2236.452069243046, 2238.1383167480476, 2239.4065572623267, 2243.652233903731, 2247.078697733921, 8970.147835955573, 9019.188273055457, 9024.593893274818, 9094.136057074567, 9099.681511147079, 5154.716490593016, 5302.2841916341185, 5373.838784836461, 5449.83650490482, 5467.0705979983495, 3323.6842499962463, 3463.6363181865795, 3478.7912725236565, 3530.117470632342, 3554.7156227501996, 1065.5790962569743, 1110.3892858927557, 1114.7157474843943, 1129.3901293301608, 1130.508228920414, 12356.938215308955, 12395.132340736152, 12432.12975091744, 12452.439640216213, 12469.563565275172, 4525.162844873709, 4532.297493888453, 4699.671023028423, 4703.0593881223895, 4781.163296423112, 10761.30051546647, 10776.407297598551, 10780.083692886035, 10789.56841726338, 10800.081993030522, 5327.334083239595, 5363.946360536423, 5369.27514785499, 5372.328458942632, 5378.973105134528, 4360.716553424018, 4491.528389519119, 4723.078999595046, 4780.402449693788, 4895.779689913962, 3925.156091440354, 3988.2821092203103, 4019.256437559061, 4053.2906741320153, 4142.337226043818, 1260.2753416785386, 1274.706817431996, 1276.8914642255327, 1303.6284658872366, 1304.9739005219842, 852.2755657690913, 855.4354126276628, 873.0919843362832, 877.0, 890.3767362846033, 5384.5692344612335, 5546.0, 5546.391546451565, 5680.801171958961, 5698.572607054488, 908.14180599333, 929.2101713543569, 955.1212884146602, 960.8366577681811, 970.9951450242703, 3731.2910546995986, 3731.402975523903, 3742.5134732484603, 3763.7553559018575, 3859.150986782903, 11272.267302625303, 11336.263142895685, 11365.488553015135, 11418.42907854604, 11431.885681143249, 11169.44152792357, 11239.100871930226, 11298.435078246055, 11325.716857078474, 11341.206115571997, 8207.179282071746, 8480.618372173267, 8591.0, 8596.484210947488, 8635.272945410943, 5520.972395138159, 5557.388687244481, 5628.831135065954, 5649.491545760901, 5702.258706368146, 10099.7475063124, 10112.0, 10256.846147307946, 10301.9484902575, 10762.085222756154, 10746.08658264025, 10756.139508839118, 10799.460026998775, 10817.18871084656, 10911.018008379284, 8086.353091752763, 8152.673893044449, 8164.632591533514, 8195.46729462583, 8261.13258107914, 8626.5255410953, 8652.653893844175, 8652.870206946774, 8659.913400865911, 8712.825743485222, 7760.68957241704, 7823.374130069695, 7883.526988380716, 8024.0, 8072.677092916218, 7718.6140692964, 7802.960985195265, 7815.25755053269, 7854.72508462201, 7861.056673199024, 6991.860162796817, 7030.191527974348, 7081.8937715935335, 7092.9645351772915, 7097.183823860322, 4878.463369029333, 4892.3884514435695, 4912.631552633496, 4981.42713587942, 5152.458991805956, 4844.249141383091, 4865.951340486691, 4876.536729010881, 4939.9259011114145, 4977.576905963034], "value": 4630.039404285589, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.23894087834475, 334.1195948675241, 336.71883976879303, 341.82396066026, 341.9931601367971, 5098.388193416786, 5211.5049070338355, 5238.5023422774875, 5320.866978325539, 5324.840254792358, 4958.735522441772, 5102.285680004793, 5122.871928201796, 5194.844154675357, 5196.480351964801, 4087.4890638670167, 4126.8968275793195, 4146.212219678259, 4158.106007208449, 4168.166366726652, 3996.9800150999204, 4096.87709368718, 4128.710990230685, 4129.442525259096, 4142.97928510357, 4057.9594204058026, 4072.470578824749, 4079.5716449772644, 4098.590140985907, 4104.6921480888905, 4041.8181181846594, 4061.2689715851134, 4081.795910204493, 4085.346344584867, 4088.0393107619684, 3443.862245510202, 3546.8364297778335, 3575.302815950891, 3582.7850328980344, 3592.2456284180353, 4997.925031124536, 5011.198208286693, 5014.52362025607, 5014.949850501521, 5024.371953505812, 4591.977040114778, 4605.194091034055, 4623.953760462386, 4625.005623790901, 4631.976840115812, 5259.842204733826, 5327.593696931419, 5338.893222135574, 5366.382865970424, 5386.8383948481605, 3898.6491215790716, 3900.161465284949, 3906.8279516145326, 3907.1990242000606, 3910.7458015228917, 5587.8882422351735, 5609.102543593046, 5614.242077319591, 5622.3253209614695, 5630.577706672016, 3835.6356146166067, 3930.6265904739003, 3943.4282029106193, 3981.223661386002, 3984.521857377133, 4004.9199016020098, 4006.3790112532606, 4009.4386785850006, 4015.1768887378016, 4019.3673144090667, 4589.449266088024, 4591.517890621503, 4602.309653551994, 4605.332226827091, 4606.170889239969, 5309.33633295838, 5405.702631368522, 5411.972940135274, 5428.619996600279, 5462.863428414322, 1376.2705765944065, 1380.9240491773048, 1381.412899517701, 1401.2223216115153, 1403.6701375176826, 872.7861673889811, 882.139913584263, 893.6238193182426, 897.8832751742362, 901.4591245252795, 4697.95302046982, 4710.5760481556135, 4718.9854181351175, 4722.748471655014, 4738.336632871401, 4892.51074892515, 4910.183232204036, 4941.209406494943, 4967.776450059756, 4967.90064198714, 4304.849330273425, 4635.745034023161, 4647.6281897448125, 4659.673822832437, 4673.481118636457, 2559.3473664215876, 2560.270322957985, 2593.312772115391, 2605.3616863868097, 2614.2157352794084, 5020.397552293748, 5026.89946201074, 5032.131684939623, 5035.0, 5048.217526283359, 4757.265546546014, 4840.370751802314, 4926.950730492649, 4997.775100120503, 4997.85006449807, 4955.819439446632, 4956.330895329156, 4970.801167953241, 4972.477889821589, 4999.625028122832, 4852.611791056777, 4860.781264843161, 4873.902521949471, 4899.926501102557, 4909.312696222603, 4593.356930029865, 4811.78346974394, 4824.276358546246, 4863.781129849236, 4875.099315907029, 4943.604511638989, 4951.801927922843, 4985.6510044298, 4987.975060124676, 5020.673656212334, 3623.9490547741916, 3756.154865155318, 3847.2882516734494, 3874.108954940323, 3967.9206415870945, 5470.74172940218, 5476.945230547643, 5521.751521181637, 5544.69504177258, 5557.583181261502, 5428.91856622143, 5432.755526001419, 5434.891302174014, 5436.510714035756, 5437.429069947599, 5187.144121219956, 5321.7073060980465, 5334.199870019528, 5336.319059496246, 5344.968911813486, 5282.867928301823, 5297.205419187153, 5340.652857564246, 5349.679019258857, 5376.247325374373, 5158.561522270649, 5385.27298814655, 5411.918821217763, 5439.156930675752, 5464.0, 5328.575498148256, 5343.866403339947, 5356.785728570813, 5358.7320633967365, 5359.544438722753], "value": 3990.545513125834, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.8594324106798, 729.8467321862407, 744.4156337275236, 795.8806179073142, 827.8137419080704, 15313.464028758995, 16315.184240787943, 16321.755173672389, 16331.83668163318, 16867.40964066258, 15157.393704251845, 15397.769033464507, 15524.534263972071, 15527.22363881807, 15540.611484712888, 794.4121350200868, 818.1082619944259, 820.2084987986592, 820.3765138494757, 821.3511326052411, 647.7052940911898, 662.8177251255895, 786.2294950948045, 799.2247519905711, 810.8743144812534, 849.4393700157897, 854.6581367453007, 855.6235256487157, 856.905740368559, 857.0786404615033, 845.6532821543137, 846.4413487098547, 846.724814435308, 847.5465625890181, 847.6228078505068, 499.8029718823434, 505.9519345662193, 508.22495694066845, 508.8498892826625, 600.2047287344286, 13642.045056846026, 14087.788683169658, 14112.435502579885, 14114.0, 14242.07426517273, 13180.934095329558, 13456.79814802769, 13660.043796934218, 13884.166949983033, 13956.371963261678, 11521.251118677343, 11966.162368634199, 12216.328101954388, 12243.449044792917, 12395.814062789066, 3730.8694195703292, 3810.733248672594, 3838.5201849768778, 3889.1638297766117, 3937.4093885917055, 83222.58388708078, 86049.13950860474, 86702.0, 86720.56639716824, 86730.0, 10794.676159715222, 11000.064994475399, 11023.944880275707, 11088.722781930517, 11332.830007549894, 21394.465138371666, 21597.67603485949, 21601.567968640855, 21616.135354585957, 21622.675659865115, 8120.553369564731, 8145.226203510657, 8213.91139347404, 8415.915840841513, 8600.096989816104, 4296.978515107405, 4330.870073897788, 4360.062586543908, 4400.515943246241, 4497.595216430537, 3307.570015897918, 3420.281740834403, 3778.8677396290996, 3936.6063393660406, 3938.547067087264, 664.8138521214067, 677.9423748981392, 678.816719485736, 685.8319711670673, 693.5076095971916, 579.826052184343, 643.1799455693935, 659.22541014308, 705.9576425414491, 714.9642517874086, 8826.212860486328, 8906.73279801607, 9096.909030909606, 9206.861897071549, 9234.1689247968, 597.5070566782422, 638.7668500997103, 644.8033349828254, 645.2031740800109, 681.2880539835884, 4189.874303770892, 4354.107407981356, 4451.977740111279, 4537.342085397599, 4561.959496714175, 73676.26323736693, 74252.0, 114235.0, 123774.0, 124077.37961310135, 99245.0, 100023.49988250012, 100338.0, 100699.0, 102029.0, 58038.129428058615, 60804.0, 67537.0, 82191.0, 93951.0, 8385.874211886705, 8524.829503410021, 8525.531095789544, 8701.52141632191, 8814.955925220333, 53214.0, 53841.730791347356, 54258.7287063578, 54829.04978778135, 55436.72281638566, 73341.26658733345, 75849.62075189588, 78933.0, 79182.0, 79490.0, 12044.457999390224, 12145.332006739714, 12395.938020310201, 12624.621261362174, 13304.13523120994, 14169.858301416854, 14504.782428263374, 14561.854381456473, 14690.63273418173, 14899.702005960036, 13535.79696304576, 13736.910282905881, 13751.656208594864, 14145.0, 14353.425862965365, 12580.87419125797, 12668.429920653776, 13567.321633918067, 13868.375923083284, 14617.92691036538, 12937.417816198482, 13109.147905386119, 13564.0, 13575.0, 13997.44010239579, 10812.729681758019, 11266.549338026714, 11439.14206434504, 11620.186586939171, 11640.76718465609, 9736.610535578497, 10881.401522916, 11398.772393831896, 12013.579524716593, 12110.273383597012], "value": 7397.95153652618, "unit": "score"}], "name": "dromaeo_css", "value": 7039.304733044487, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 112.0, 111.0, 112.0, 111.0, 111.0, 112.0, 112.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 119.0, 123.0, 173.0, 123.0, 125.0, 121.0, 123.0, 170.0, 124.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 161.0, 160.0, 166.0, 161.0, 160.0, 160.0, 159.0, 163.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 115.0, 76.0, 76.0, 76.0, 75.0, 97.0, 77.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 114.0, 83.0, 82.0, 82.0, 102.0, 82.0, 81.0, 111.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 52.0, 52.0, 53.0, 52.0, 54.0, 52.0, 53.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 79.0, 79.0, 80.0, 79.0, 79.0, 78.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 134.0, 131.0, 141.0, 130.0, 129.0, 138.0, 133.0, 171.0, 135.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 167.0, 164.0, 178.0, 165.0, 163.0, 162.0, 166.0, 166.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 66.0, 65.0, 66.0, 69.0, 70.0, 65.0, 64.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1500.6, "alertThreshold": 2.0}]} 18:43:13 INFO - Return code: 0 18:43:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:43:13 INFO - # TBPL SUCCESS # 18:43:13 INFO - Running post-action listener: _resource_record_post_action 18:43:13 INFO - [mozharness: 2016-10-13 01:43:13.648214Z] Finished run-tests step (success) 18:43:13 INFO - Running post-run listener: _resource_record_post_run 18:43:13 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 393965568; Read time: 0; Write time: 226576 18:43:13 INFO - TinderboxPrint: CPU usage
13.1% 18:43:13 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:43:13 INFO - TinderboxPrint: I/O write bytes / time
393,965,568 / 226,576 18:43:13 INFO - TinderboxPrint: CPU idle
8,308.0 (86.9%) 18:43:13 INFO - TinderboxPrint: CPU user
1,198.1 (12.5%) 18:43:13 INFO - TinderboxPrint: Swap in / out
0 / 0 18:43:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103784448; Read time: 0; Write time: 80192 18:43:13 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 290181120; Read time: 0; Write time: 146384 18:43:14 INFO - Running post-run listener: _upload_blobber_files 18:43:14 INFO - Blob upload gear active. 18:43:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:43:14 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 18:43:14 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'] 18:43:14 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 18:43:14 INFO - (blobuploader) - INFO - Open directory for files ... 18:43:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:43:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:43:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:43:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:43:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:43:15 INFO - (blobuploader) - INFO - Done attempting. 18:43:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:43:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:43:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:43:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:43:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:43:20 INFO - (blobuploader) - INFO - Done attempting. 18:43:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:43:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:43:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:43:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:43:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:43:21 INFO - (blobuploader) - INFO - Done attempting. 18:43:21 INFO - (blobuploader) - INFO - Iteration through files over. 18:43:21 INFO - Return code: 0 18:43:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:43:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:43:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b471f44e7d3c3fba3a1e15d70500a3b711f8e3839a564575c70cfaef359f8363e2f0aa213601a3267117f9bcdecd3eda315b0dac7a5e31c8f1bc8e56ed8e8b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c686c1a6100d3a7bf4ed62389bbc3d552fef7472386b58f0ecedcf1191c40fff21a173d2ba36a05e62382d4564182a07337de6600eba6da40c5365dcf63beef8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4f9a9815efe33194d3f7f4fdcbaa17fea71f8fb9cd432c8b96bf0c4b58563b734013ef42627958d9b1dfcbe3fdcbb2c1366e3db21edba06d498ea0d59a2c230"} 18:43:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:43:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:43:21 INFO - Contents: 18:43:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b471f44e7d3c3fba3a1e15d70500a3b711f8e3839a564575c70cfaef359f8363e2f0aa213601a3267117f9bcdecd3eda315b0dac7a5e31c8f1bc8e56ed8e8b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c686c1a6100d3a7bf4ed62389bbc3d552fef7472386b58f0ecedcf1191c40fff21a173d2ba36a05e62382d4564182a07337de6600eba6da40c5365dcf63beef8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4f9a9815efe33194d3f7f4fdcbaa17fea71f8fb9cd432c8b96bf0c4b58563b734013ef42627958d9b1dfcbe3fdcbb2c1366e3db21edba06d498ea0d59a2c230"} 18:43:21 INFO - Running post-run listener: copy_logs_to_upload_dir 18:43:21 INFO - Copying logs to upload dir... 18:43:21 INFO - mkdir: /builds/slave/test/build/upload/logs 18:43:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.050333 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-12 18:43:19.902556) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 18:43:19.906154) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765 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/3b471f44e7d3c3fba3a1e15d70500a3b711f8e3839a564575c70cfaef359f8363e2f0aa213601a3267117f9bcdecd3eda315b0dac7a5e31c8f1bc8e56ed8e8b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c686c1a6100d3a7bf4ed62389bbc3d552fef7472386b58f0ecedcf1191c40fff21a173d2ba36a05e62382d4564182a07337de6600eba6da40c5365dcf63beef8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4f9a9815efe33194d3f7f4fdcbaa17fea71f8fb9cd432c8b96bf0c4b58563b734013ef42627958d9b1dfcbe3fdcbb2c1366e3db21edba06d498ea0d59a2c230"} build_url:https://queue.taskcluster.net/v1/task/O6TL_WIhQJ--VoVKqCkPew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011594 build_url: 'https://queue.taskcluster.net/v1/task/O6TL_WIhQJ--VoVKqCkPew/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/3b471f44e7d3c3fba3a1e15d70500a3b711f8e3839a564575c70cfaef359f8363e2f0aa213601a3267117f9bcdecd3eda315b0dac7a5e31c8f1bc8e56ed8e8b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c686c1a6100d3a7bf4ed62389bbc3d552fef7472386b58f0ecedcf1191c40fff21a173d2ba36a05e62382d4564182a07337de6600eba6da40c5365dcf63beef8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4f9a9815efe33194d3f7f4fdcbaa17fea71f8fb9cd432c8b96bf0c4b58563b734013ef42627958d9b1dfcbe3fdcbb2c1366e3db21edba06d498ea0d59a2c230"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 18:43:19.931688) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 18:43:19.932008) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1476321756.449233-2119369765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 18:43:20.016506) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 18:43:20.016823) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 18:43:20.017129) ========= ========= Total master_lag: 0.15 =========