builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-069 starttime: 1476443773.23 results: success (0) buildid: 20161014025635 builduid: 465c1b9e8bac4980b536d3941c62ccba revision: a71215ad8ab820b2310f5dd38fcfded38d18768b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 04:16:13.232161) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 04:16:13.232614) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 04:16:13.232985) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 04:16:13.248123) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:16:13.248492) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 04:16:13-- 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% 40.8M=0s 2016-10-14 04:16:13 (40.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.102011 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:16:13.363892) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:16:13.364202) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018162 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:16:13.413798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:16:13.414151) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a71215ad8ab820b2310f5dd38fcfded38d18768b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a71215ad8ab820b2310f5dd38fcfded38d18768b --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=05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 04:16:13,683 truncating revision to first 12 chars 2016-10-14 04:16:13,683 Setting DEBUG logging. 2016-10-14 04:16:13,683 attempt 1/10 2016-10-14 04:16:13,683 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a71215ad8ab8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 04:16:14,011 unpacking tar archive at: mozilla-central-a71215ad8ab8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631462 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:16:14.058777) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 04:16:14.059100) ========= script_repo_revision: a71215ad8ab820b2310f5dd38fcfded38d18768b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 04:16:14.059487) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 04:16:14.059770) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 04:16:14.069012) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-14 04:16:14.069379) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:16:14 INFO - MultiFileLogger online at 20161014 04:16:14 in /builds/slave/test 04:16:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:16:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:16:14 INFO - {'append_to_log': False, 04:16:14 INFO - 'base_work_dir': '/builds/slave/test', 04:16:14 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:16:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:16:14 INFO - 'branch': 'Firefox-Non-PGO', 04:16:14 INFO - 'buildbot_json_path': 'buildprops.json', 04:16:14 INFO - 'config_files': ('talos/linux_config.py',), 04:16:14 INFO - 'default_actions': ('clobber', 04:16:14 INFO - 'read-buildbot-config', 04:16:14 INFO - 'download-and-extract', 04:16:14 INFO - 'populate-webroot', 04:16:14 INFO - 'create-virtualenv', 04:16:14 INFO - 'install', 04:16:14 INFO - 'run-tests'), 04:16:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:16:14 INFO - 'download_minidump_stackwalk': True, 04:16:14 INFO - 'download_symbols': 'ondemand', 04:16:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:16:14 INFO - 'tooltool.py': '/tools/tooltool.py', 04:16:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:16:14 INFO - '/tools/misc-python/virtualenv.py')}, 04:16:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:16:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:16:14 INFO - 'installer_path': 'installer.exe', 04:16:14 INFO - 'log_level': 'info', 04:16:14 INFO - 'log_name': 'talos', 04:16:14 INFO - 'log_to_console': True, 04:16:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:16:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:16:14 INFO - 'opt_config_files': (), 04:16:14 INFO - 'pip_index': False, 04:16:14 INFO - 'sps_profile': False, 04:16:14 INFO - 'sps_profile_interval': 0, 04:16:14 INFO - 'suite': 'dromaeojs', 04:16:14 INFO - 'system_bits': '32', 04:16:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:16:14 INFO - 'title': 'talos-linux64-ix-069', 04:16:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:16:14 INFO - 'use_talos_json': True, 04:16:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:16:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:16:14 INFO - 'work_dir': 'build'} 04:16:14 INFO - [mozharness: 2016-10-14 11:16:14.442172Z] Running clobber step. 04:16:14 INFO - Running pre-action listener: _resource_record_pre_action 04:16:14 INFO - Running main action method: clobber 04:16:14 INFO - rmtree: /builds/slave/test/build 04:16:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:16:14 INFO - Running post-action listener: _resource_record_post_action 04:16:14 INFO - [mozharness: 2016-10-14 11:16:14.939383Z] Finished clobber step (success) 04:16:14 INFO - [mozharness: 2016-10-14 11:16:14.939485Z] Running read-buildbot-config step. 04:16:14 INFO - Running pre-action listener: _resource_record_pre_action 04:16:14 INFO - Running main action method: read_buildbot_config 04:16:14 INFO - Using buildbot properties: 04:16:14 INFO - { 04:16:14 INFO - "project": "", 04:16:14 INFO - "product": "firefox", 04:16:14 INFO - "script_repo_revision": "production", 04:16:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:16:14 INFO - "repository": "", 04:16:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:16:14 INFO - "buildid": "20161014025635", 04:16:14 INFO - "pgo_build": "False", 04:16:14 INFO - "basedir": "/builds/slave/test", 04:16:14 INFO - "buildnumber": 672, 04:16:14 INFO - "slavename": "talos-linux64-ix-069", 04:16:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:16:14 INFO - "platform": "ubuntu64_hw", 04:16:14 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:16:14 INFO - "branch": "mozilla-central", 04:16:14 INFO - "repo_path": "mozilla-central", 04:16:14 INFO - "revision": "a71215ad8ab820b2310f5dd38fcfded38d18768b", 04:16:14 INFO - "stage_platform": "linux64", 04:16:14 INFO - "builduid": "465c1b9e8bac4980b536d3941c62ccba", 04:16:14 INFO - "slavebuilddir": "test" 04:16:14 INFO - } 04:16:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:16:14 INFO - Running post-action listener: _resource_record_post_action 04:16:14 INFO - [mozharness: 2016-10-14 11:16:14.941922Z] Finished read-buildbot-config step (success) 04:16:14 INFO - [mozharness: 2016-10-14 11:16:14.942012Z] Running download-and-extract step. 04:16:14 INFO - Running pre-action listener: _resource_record_pre_action 04:16:14 INFO - Running main action method: download_and_extract 04:16:14 INFO - mkdir: /builds/slave/test/build/tests 04:16: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')]} 04:16:14 INFO - trying https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:16:14 INFO - Downloading https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/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 04:16:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/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 04:16:15 INFO - Downloaded 1361 bytes. 04:16:15 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:16:15 INFO - Using the following test package requirements: 04:16:15 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:15 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:16:15 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:16:15 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:15 INFO - u'jsshell-linux-x86_64.zip'], 04:16:15 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:16:15 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:15 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:16:15 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:16:15 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:16:15 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:16:15 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:16:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:16:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:16:15 INFO - Fetch https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:16:16 INFO - Http code: 200 04:16:16 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 04:16:16 INFO - x-amz-cf-id: P6VmVQ4n03W33_NzvOcVEarLBz9cF0CDiDGNZ3BWqT-uXr2okDf-ng== 04:16:16 INFO - x-amz-version-id: PAdHDTu.gkE68TdKhbev3mZNSjjnEp9J 04:16:16 INFO - Expected file size: 20552292 04:16:16 INFO - Obtained file size: 20552292 04:16:20 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 04:16:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:16:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:16:20 INFO - Fetch https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:16:21 INFO - Http code: 200 04:16:21 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 04:16:21 INFO - x-amz-cf-id: XTkz7QhwvOPR8gu1P0c58lWj5KUAdrjeB70ZpzpT17fLmRK2DMb0KQ== 04:16:21 INFO - x-amz-version-id: PAdHDTu.gkE68TdKhbev3mZNSjjnEp9J 04:16:21 INFO - Expected file size: 20552292 04:16:21 INFO - Obtained file size: 20552292 04:16:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:16:25 INFO - Fetch https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:16:26 INFO - Http code: 200 04:16:26 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 04:16:26 INFO - x-amz-cf-id: A3cAZcyHHuYzoHFmU_YgIO8ZE0fxHUmDb_Ouh_fRHqw1Tfrc1B_ByA== 04:16:26 INFO - x-amz-version-id: w4ls874uZOx2W5_q92EqVcedGPkeJnNY 04:16:26 INFO - Expected file size: 14409006 04:16:26 INFO - Obtained file size: 14409006 04:16:26 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')]} 04:16:26 INFO - trying https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:16:26 INFO - Downloading https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/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 04:16:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/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 04:16:27 INFO - Downloaded 55846193 bytes. 04:16:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:16:27 INFO - mkdir: /builds/slave/test/properties 04:16:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:16:27 INFO - Writing to file /builds/slave/test/properties/build_url 04:16:27 INFO - Contents: 04:16:27 INFO - build_url:https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:16:28 INFO - Running post-action listener: _resource_record_post_action 04:16:28 INFO - Running post-action listener: set_extra_try_arguments 04:16:28 INFO - [mozharness: 2016-10-14 11:16:28.545840Z] Finished download-and-extract step (success) 04:16:28 INFO - [mozharness: 2016-10-14 11:16:28.546068Z] Running populate-webroot step. 04:16:28 INFO - Running pre-action listener: _resource_record_pre_action 04:16:28 INFO - Running main action method: populate_webroot 04:16:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:16:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:16:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:16:28 INFO - '--tppagecycles', 04:16:28 INFO - '7'], 04:16:28 INFO - 'tests': ['tsvgm']}}, 04:16:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:16:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:16:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:16:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:16:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:16:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:16:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:28 INFO - 'talos_options': ['--disable-e10s'], 04:16:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:28 INFO - 'talos_options': ['--disable-e10s'], 04:16:28 INFO - 'tests': ['damp', 'tps']}, 04:16:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:28 INFO - 'tests': ['damp', 'tps']}, 04:16:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:16:28 INFO - 'tests': ['dromaeo_dom']}, 04:16:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:16:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:16:28 INFO - 'tests': ['basic_compositor_video']}, 04:16:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:16:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:16:28 INFO - 'tests': ['a11yr', 04:16:28 INFO - 'ts_paint', 04:16:28 INFO - 'tpaint', 04:16:28 INFO - 'sessionrestore', 04:16:28 INFO - 'sessionrestore_no_auto_restore', 04:16:28 INFO - 'tabpaint']}, 04:16:28 INFO - 'other-e10s': {'tests': ['a11yr', 04:16:28 INFO - 'ts_paint', 04:16:28 INFO - 'tpaint', 04:16:28 INFO - 'sessionrestore', 04:16:28 INFO - 'sessionrestore_no_auto_restore', 04:16:28 INFO - 'tabpaint']}, 04:16:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:16:28 INFO - 'ts_paint', 04:16:28 INFO - 'tpaint', 04:16:28 INFO - 'sessionrestore', 04:16:28 INFO - 'sessionrestore_no_auto_restore', 04:16:28 INFO - 'tabpaint']}, 04:16:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:16:28 INFO - 'ts_paint', 04:16:28 INFO - 'tpaint', 04:16:28 INFO - 'sessionrestore', 04:16:28 INFO - 'sessionrestore_no_auto_restore', 04:16:28 INFO - 'tabpaint']}, 04:16:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:16:28 INFO - 'tests': ['a11yr', 04:16:28 INFO - 'ts_paint', 04:16:28 INFO - 'tpaint', 04:16:28 INFO - 'sessionrestore', 04:16:28 INFO - 'sessionrestore_no_auto_restore', 04:16:28 INFO - 'tabpaint']}, 04:16:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:16:28 INFO - 'tests': ['a11yr', 04:16:28 INFO - 'ts_paint', 04:16:28 INFO - 'tpaint', 04:16:28 INFO - 'sessionrestore', 04:16:28 INFO - 'sessionrestore_no_auto_restore', 04:16:28 INFO - 'tabpaint']}, 04:16:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:16:28 INFO - 'tests': ['tsvgx', 04:16:28 INFO - 'tsvgr_opacity', 04:16:28 INFO - 'tart', 04:16:28 INFO - 'tscrollx', 04:16:28 INFO - 'cart']}, 04:16:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:16:28 INFO - 'tsvgr_opacity', 04:16:28 INFO - 'tart', 04:16:28 INFO - 'tscrollx', 04:16:28 INFO - 'cart']}, 04:16:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:28 INFO - 'talos_options': ['--disable-e10s'], 04:16:28 INFO - 'tests': ['tp5o']}, 04:16:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:28 INFO - 'tests': ['tp5o']}, 04:16:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:28 INFO - 'talos_options': ['--disable-e10s', 04:16:28 INFO - '--xperf_path', 04:16:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:28 INFO - 'tests': ['tp5n']}, 04:16:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:28 INFO - 'talos_options': ['--xperf_path', 04:16:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:28 INFO - 'tests': ['tp5n']}}, 04:16:28 INFO - 'talos.zip': {'path': '', 04:16:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:16:28 INFO - Running post-action listener: _resource_record_post_action 04:16:28 INFO - [mozharness: 2016-10-14 11:16:28.562639Z] Finished populate-webroot step (success) 04:16:28 INFO - [mozharness: 2016-10-14 11:16:28.562728Z] Running create-virtualenv step. 04:16:28 INFO - Running pre-action listener: _resource_record_pre_action 04:16:28 INFO - Running main action method: create_virtualenv 04:16:28 INFO - Creating virtualenv /builds/slave/test/build/venv 04:16:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:16:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:16:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:16:28 INFO - Using real prefix '/usr' 04:16:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:16:29 INFO - Installing distribute.............................................................................................................................................................................................done. 04:16:31 INFO - Installing pip.................done. 04:16:31 INFO - Return code: 0 04:16:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:16:31 INFO - Reading from file tmpfile_stdout 04:16:31 INFO - Output received: 04:16:31 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:16:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0674e94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79f60>, '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 0x2b7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', '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 04:16:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:16:31 INFO - Using env: {'DISPLAY': ':0', 04:16:31 INFO - 'HOME': '/home/cltbld', 04:16:31 INFO - 'LANG': 'en_US.UTF-8', 04:16:31 INFO - 'LANGUAGE': 'en_US:en', 04:16:31 INFO - 'LOGNAME': 'cltbld', 04:16:31 INFO - 'MAIL': '/var/mail/cltbld', 04:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:31 INFO - 'MOZ_NO_REMOTE': '1', 04:16:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:31 INFO - 'NO_EM_RESTART': '1', 04:16:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:31 INFO - 'PWD': '/builds/slave/test', 04:16:31 INFO - 'SHELL': '/bin/bash', 04:16:31 INFO - 'SHLVL': '1', 04:16:31 INFO - 'TERM': 'linux', 04:16:31 INFO - 'TMOUT': '86400', 04:16:31 INFO - 'USER': 'cltbld', 04:16:31 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', 04:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:31 INFO - '_': '/tools/buildbot/bin/python'} 04:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:16:31 INFO - Cleaning up... 04:16:31 INFO - Return code: 0 04:16:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0674e94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79f60>, '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 0x2b7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', '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 04:16:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:16:31 INFO - Using env: {'DISPLAY': ':0', 04:16:31 INFO - 'HOME': '/home/cltbld', 04:16:31 INFO - 'LANG': 'en_US.UTF-8', 04:16:31 INFO - 'LANGUAGE': 'en_US:en', 04:16:31 INFO - 'LOGNAME': 'cltbld', 04:16:31 INFO - 'MAIL': '/var/mail/cltbld', 04:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:31 INFO - 'MOZ_NO_REMOTE': '1', 04:16:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:31 INFO - 'NO_EM_RESTART': '1', 04:16:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:31 INFO - 'PWD': '/builds/slave/test', 04:16:31 INFO - 'SHELL': '/bin/bash', 04:16:31 INFO - 'SHLVL': '1', 04:16:31 INFO - 'TERM': 'linux', 04:16:31 INFO - 'TMOUT': '86400', 04:16:31 INFO - 'USER': 'cltbld', 04:16:31 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', 04:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:31 INFO - '_': '/tools/buildbot/bin/python'} 04:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:31 INFO - Downloading/unpacking psutil>=3.1.1 04:16:31 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 04:16:31 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 04:16:31 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 04:16:31 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 04:16:31 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 04:16:31 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 04:16:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:16:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:33 INFO - Installing collected packages: psutil 04:16:33 INFO - Running setup.py install for psutil 04:16:33 INFO - building 'psutil._psutil_linux' extension 04:16:33 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 04:16:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:16:34 INFO - building 'psutil._psutil_posix' extension 04:16:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:16:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:16:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:34 INFO - Successfully installed psutil 04:16:34 INFO - Cleaning up... 04:16:34 INFO - Return code: 0 04:16:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0674e94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79f60>, '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 0x2b7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', '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 04:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:16:34 INFO - Using env: {'DISPLAY': ':0', 04:16:34 INFO - 'HOME': '/home/cltbld', 04:16:34 INFO - 'LANG': 'en_US.UTF-8', 04:16:34 INFO - 'LANGUAGE': 'en_US:en', 04:16:34 INFO - 'LOGNAME': 'cltbld', 04:16:34 INFO - 'MAIL': '/var/mail/cltbld', 04:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:34 INFO - 'MOZ_NO_REMOTE': '1', 04:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:34 INFO - 'NO_EM_RESTART': '1', 04:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:34 INFO - 'PWD': '/builds/slave/test', 04:16:34 INFO - 'SHELL': '/bin/bash', 04:16:34 INFO - 'SHLVL': '1', 04:16:34 INFO - 'TERM': 'linux', 04:16:34 INFO - 'TMOUT': '86400', 04:16:34 INFO - 'USER': 'cltbld', 04:16:34 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', 04:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:34 INFO - '_': '/tools/buildbot/bin/python'} 04:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:16:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:16:36 INFO - Installing collected packages: mozsystemmonitor 04:16:36 INFO - Running setup.py install for mozsystemmonitor 04:16:36 INFO - Successfully installed mozsystemmonitor 04:16:36 INFO - Cleaning up... 04:16:36 INFO - Return code: 0 04:16:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0674e94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79f60>, '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 0x2b7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', '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 04:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:16:36 INFO - Using env: {'DISPLAY': ':0', 04:16:36 INFO - 'HOME': '/home/cltbld', 04:16:36 INFO - 'LANG': 'en_US.UTF-8', 04:16:36 INFO - 'LANGUAGE': 'en_US:en', 04:16:36 INFO - 'LOGNAME': 'cltbld', 04:16:36 INFO - 'MAIL': '/var/mail/cltbld', 04:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:36 INFO - 'MOZ_NO_REMOTE': '1', 04:16:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:36 INFO - 'NO_EM_RESTART': '1', 04:16:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:36 INFO - 'PWD': '/builds/slave/test', 04:16:36 INFO - 'SHELL': '/bin/bash', 04:16:36 INFO - 'SHLVL': '1', 04:16:36 INFO - 'TERM': 'linux', 04:16:36 INFO - 'TMOUT': '86400', 04:16:36 INFO - 'USER': 'cltbld', 04:16:36 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', 04:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:36 INFO - '_': '/tools/buildbot/bin/python'} 04:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:36 INFO - Downloading/unpacking jsonschema==2.5.1 04:16:36 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 04:16:36 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 04:16:36 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 04:16:36 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 04:16:36 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 04:16:36 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 04:16:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:16:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:16:38 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 04:16:38 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 04:16:38 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 04:16:38 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 04:16:38 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 04:16:38 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 04:16:39 INFO - Downloading functools32-3.2.3-2.tar.gz 04:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:16:39 INFO - warning: no files found matching '*.txt' 04:16:39 INFO - no previously-included directories found matching 'build' 04:16:39 INFO - no previously-included directories found matching 'dist' 04:16:39 INFO - no previously-included directories found matching '.git*' 04:16:39 INFO - Installing collected packages: jsonschema, functools32 04:16:39 INFO - Running setup.py install for functools32 04:16:39 INFO - warning: no files found matching '*.txt' 04:16:39 INFO - no previously-included directories found matching 'build' 04:16:39 INFO - no previously-included directories found matching 'dist' 04:16:39 INFO - no previously-included directories found matching '.git*' 04:16:39 INFO - Successfully installed jsonschema functools32 04:16:39 INFO - Cleaning up... 04:16:39 INFO - Return code: 0 04:16:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0674e94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79f60>, '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 0x2b7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', '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 04:16:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:16:39 INFO - Using env: {'DISPLAY': ':0', 04:16:39 INFO - 'HOME': '/home/cltbld', 04:16:39 INFO - 'LANG': 'en_US.UTF-8', 04:16:39 INFO - 'LANGUAGE': 'en_US:en', 04:16:39 INFO - 'LOGNAME': 'cltbld', 04:16:39 INFO - 'MAIL': '/var/mail/cltbld', 04:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:39 INFO - 'MOZ_NO_REMOTE': '1', 04:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:39 INFO - 'NO_EM_RESTART': '1', 04:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:39 INFO - 'PWD': '/builds/slave/test', 04:16:39 INFO - 'SHELL': '/bin/bash', 04:16:39 INFO - 'SHLVL': '1', 04:16:39 INFO - 'TERM': 'linux', 04:16:39 INFO - 'TMOUT': '86400', 04:16:39 INFO - 'USER': 'cltbld', 04:16:39 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', 04:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:39 INFO - '_': '/tools/buildbot/bin/python'} 04:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:16:39 INFO - Cleaning up... 04:16:39 INFO - Return code: 0 04:16:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0674e94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79f60>, '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 0x2b7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', '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 04:16:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:16:39 INFO - Using env: {'DISPLAY': ':0', 04:16:39 INFO - 'HOME': '/home/cltbld', 04:16:39 INFO - 'LANG': 'en_US.UTF-8', 04:16:39 INFO - 'LANGUAGE': 'en_US:en', 04:16:39 INFO - 'LOGNAME': 'cltbld', 04:16:39 INFO - 'MAIL': '/var/mail/cltbld', 04:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:39 INFO - 'MOZ_NO_REMOTE': '1', 04:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:39 INFO - 'NO_EM_RESTART': '1', 04:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:39 INFO - 'PWD': '/builds/slave/test', 04:16:39 INFO - 'SHELL': '/bin/bash', 04:16:39 INFO - 'SHLVL': '1', 04:16:39 INFO - 'TERM': 'linux', 04:16:39 INFO - 'TMOUT': '86400', 04:16:39 INFO - 'USER': 'cltbld', 04:16:39 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', 04:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:39 INFO - '_': '/tools/buildbot/bin/python'} 04:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:39 INFO - Downloading/unpacking blobuploader==1.2.4 04:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:41 INFO - Downloading blobuploader-1.2.4.tar.gz 04:16:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:16:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:16:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:42 INFO - Downloading docopt-0.6.1.tar.gz 04:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:16:42 INFO - Installing collected packages: blobuploader, requests, docopt 04:16:42 INFO - Running setup.py install for blobuploader 04:16:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:16:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:16:42 INFO - Running setup.py install for requests 04:16:42 INFO - Running setup.py install for docopt 04:16:43 INFO - Successfully installed blobuploader requests docopt 04:16:43 INFO - Cleaning up... 04:16:43 INFO - Return code: 0 04:16:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0674e94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79f60>, '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 0x2b7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', '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 04:16:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:16:43 INFO - Using env: {'DISPLAY': ':0', 04:16:43 INFO - 'HOME': '/home/cltbld', 04:16:43 INFO - 'LANG': 'en_US.UTF-8', 04:16:43 INFO - 'LANGUAGE': 'en_US:en', 04:16:43 INFO - 'LOGNAME': 'cltbld', 04:16:43 INFO - 'MAIL': '/var/mail/cltbld', 04:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:43 INFO - 'MOZ_NO_REMOTE': '1', 04:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:43 INFO - 'NO_EM_RESTART': '1', 04:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:43 INFO - 'PWD': '/builds/slave/test', 04:16:43 INFO - 'SHELL': '/bin/bash', 04:16:43 INFO - 'SHLVL': '1', 04:16:43 INFO - 'TERM': 'linux', 04:16:43 INFO - 'TMOUT': '86400', 04:16:43 INFO - 'USER': 'cltbld', 04:16:43 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', 04:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:43 INFO - '_': '/tools/buildbot/bin/python'} 04:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:16:43 INFO - Running setup.py (path:/tmp/pip-ySM9Bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:16:43 INFO - Running setup.py (path:/tmp/pip-VaFXHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:16:43 INFO - Running setup.py (path:/tmp/pip-dmT0P2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:16:43 INFO - Running setup.py (path:/tmp/pip-5Z7U_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:16:43 INFO - Running setup.py (path:/tmp/pip-crAdTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:16:43 INFO - Running setup.py (path:/tmp/pip-zhgSIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:43 INFO - Running setup.py (path:/tmp/pip-D_pTZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:43 INFO - Running setup.py (path:/tmp/pip-imJQx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:43 INFO - Running setup.py (path:/tmp/pip-KUannp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:43 INFO - Running setup.py (path:/tmp/pip-SbNyvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:44 INFO - Running setup.py (path:/tmp/pip-iByvpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:44 INFO - Running setup.py (path:/tmp/pip-_DzPBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:44 INFO - Running setup.py (path:/tmp/pip-8P0XXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:44 INFO - Running setup.py (path:/tmp/pip-dhBdbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:44 INFO - Running setup.py (path:/tmp/pip-KtZaTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:44 INFO - Running setup.py (path:/tmp/pip-Oqq8xQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:44 INFO - Running setup.py (path:/tmp/pip-JWeVmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:16:44 INFO - Running setup.py install for manifestparser 04:16:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:16:44 INFO - Running setup.py install for mozcrash 04:16:44 INFO - Running setup.py install for mozdebug 04:16:44 INFO - Running setup.py install for mozdevice 04:16:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:16:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:16:44 INFO - Running setup.py install for mozfile 04:16:45 INFO - Running setup.py install for mozhttpd 04:16:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:16:45 INFO - Running setup.py install for mozinfo 04:16:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:16:45 INFO - Running setup.py install for mozInstall 04:16:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:16:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:16:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:16:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:16:45 INFO - Running setup.py install for mozleak 04:16:45 INFO - Running setup.py install for mozlog 04:16:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:16:45 INFO - Running setup.py install for moznetwork 04:16:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:16:45 INFO - Running setup.py install for mozprocess 04:16:45 INFO - Running setup.py install for mozprofile 04:16:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:16:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:16:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:16:45 INFO - Running setup.py install for mozrunner 04:16:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:16:46 INFO - Running setup.py install for mozscreenshot 04:16:46 INFO - Running setup.py install for moztest 04:16:46 INFO - Running setup.py install for mozversion 04:16:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:16:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:16:46 INFO - Cleaning up... 04:16:46 INFO - Return code: 0 04:16:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0674e94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79f60>, '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 0x2b7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', '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 04:16:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:16:46 INFO - Using env: {'DISPLAY': ':0', 04:16:46 INFO - 'HOME': '/home/cltbld', 04:16:46 INFO - 'LANG': 'en_US.UTF-8', 04:16:46 INFO - 'LANGUAGE': 'en_US:en', 04:16:46 INFO - 'LOGNAME': 'cltbld', 04:16:46 INFO - 'MAIL': '/var/mail/cltbld', 04:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:46 INFO - 'MOZ_NO_REMOTE': '1', 04:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:46 INFO - 'NO_EM_RESTART': '1', 04:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:46 INFO - 'PWD': '/builds/slave/test', 04:16:46 INFO - 'SHELL': '/bin/bash', 04:16:46 INFO - 'SHLVL': '1', 04:16:46 INFO - 'TERM': 'linux', 04:16:46 INFO - 'TMOUT': '86400', 04:16:46 INFO - 'USER': 'cltbld', 04:16:46 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', 04:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:46 INFO - '_': '/tools/buildbot/bin/python'} 04:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:16:46 INFO - Running setup.py (path:/tmp/pip-d39afa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:16:46 INFO - Running setup.py (path:/tmp/pip-8NyGz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:16:46 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)) 04:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:16:46 INFO - Running setup.py (path:/tmp/pip-qyh6go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:16:46 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)) 04:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:16:46 INFO - Running setup.py (path:/tmp/pip-FgShAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:16:46 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)) 04:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:16:46 INFO - Running setup.py (path:/tmp/pip-qRalbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:16:46 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)) 04:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:16:46 INFO - Running setup.py (path:/tmp/pip-Xcl_v8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:47 INFO - Running setup.py (path:/tmp/pip-V_iPf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:47 INFO - Running setup.py (path:/tmp/pip-jy1R1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:47 INFO - Running setup.py (path:/tmp/pip-n4w6SY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:47 INFO - Running setup.py (path:/tmp/pip-EuZopy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:47 INFO - Running setup.py (path:/tmp/pip-ttePzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:47 INFO - Running setup.py (path:/tmp/pip-tfR7zr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:47 INFO - Running setup.py (path:/tmp/pip-5V95F6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:47 INFO - Running setup.py (path:/tmp/pip-mBzqTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:47 INFO - Running setup.py (path:/tmp/pip-ykGoeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:47 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)) 04:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:47 INFO - Running setup.py (path:/tmp/pip-MI5N3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:47 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)) 04:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:47 INFO - Running setup.py (path:/tmp/pip-3hvETH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:47 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)) 04:16:47 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)) 04:16:47 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)) 04:16:47 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)) 04:16:47 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)) 04:16:47 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)) 04:16:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:16:47 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 04:16:47 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 04:16:47 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 04:16:47 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 04:16:47 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 04:16:47 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 04:16:49 INFO - Downloading blessings-1.6.tar.gz 04:16:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:16:49 INFO - Installing collected packages: blessings 04:16:49 INFO - Running setup.py install for blessings 04:16:50 INFO - Successfully installed blessings 04:16:50 INFO - Cleaning up... 04:16:50 INFO - Return code: 0 04:16:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:16:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:16:50 INFO - Reading from file tmpfile_stdout 04:16:50 INFO - Current package versions: 04:16:50 INFO - argparse == 1.2.1 04:16:50 INFO - blessings == 1.6 04:16:50 INFO - blobuploader == 1.2.4 04:16:50 INFO - docopt == 0.6.1 04:16:50 INFO - functools32 == 3.2.3-2 04:16:50 INFO - jsonschema == 2.5.1 04:16:50 INFO - manifestparser == 1.1 04:16:50 INFO - mozInstall == 1.12 04:16:50 INFO - mozcrash == 0.17 04:16:50 INFO - mozdebug == 0.1 04:16:50 INFO - mozdevice == 0.48 04:16:50 INFO - mozfile == 1.2 04:16:50 INFO - mozhttpd == 0.7 04:16:50 INFO - mozinfo == 0.9 04:16:50 INFO - mozleak == 0.1 04:16:50 INFO - mozlog == 3.4 04:16:50 INFO - moznetwork == 0.27 04:16:50 INFO - mozprocess == 0.23 04:16:50 INFO - mozprofile == 0.28 04:16:50 INFO - mozrunner == 6.12 04:16:50 INFO - mozscreenshot == 0.1 04:16:50 INFO - mozsystemmonitor == 0.3 04:16:50 INFO - moztest == 0.7 04:16:50 INFO - mozversion == 1.4 04:16:50 INFO - psutil == 3.1.1 04:16:50 INFO - requests == 1.2.3 04:16:50 INFO - wsgiref == 0.1.2 04:16:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16: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')]} 04:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16: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')]} 04:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0674e94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79f60>, '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 0x2b7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', '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 04:16:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:16:50 INFO - Using env: {'DISPLAY': ':0', 04:16:50 INFO - 'HOME': '/home/cltbld', 04:16:50 INFO - 'LANG': 'en_US.UTF-8', 04:16:50 INFO - 'LANGUAGE': 'en_US:en', 04:16:50 INFO - 'LOGNAME': 'cltbld', 04:16:50 INFO - 'MAIL': '/var/mail/cltbld', 04:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:50 INFO - 'MOZ_NO_REMOTE': '1', 04:16:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:50 INFO - 'NO_EM_RESTART': '1', 04:16:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:50 INFO - 'PWD': '/builds/slave/test', 04:16:50 INFO - 'SHELL': '/bin/bash', 04:16:50 INFO - 'SHLVL': '1', 04:16:50 INFO - 'TERM': 'linux', 04:16:50 INFO - 'TMOUT': '86400', 04:16:50 INFO - 'USER': 'cltbld', 04:16:50 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', 04:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:50 INFO - '_': '/tools/buildbot/bin/python'} 04:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:16:50 INFO - Cleaning up... 04:16:50 INFO - Return code: 0 04:16:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:16: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')]} 04:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16: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')]} 04:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0674e94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79f60>, '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 0x2b7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', '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 04:16:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:16:50 INFO - Using env: {'DISPLAY': ':0', 04:16:50 INFO - 'HOME': '/home/cltbld', 04:16:50 INFO - 'LANG': 'en_US.UTF-8', 04:16:50 INFO - 'LANGUAGE': 'en_US:en', 04:16:50 INFO - 'LOGNAME': 'cltbld', 04:16:50 INFO - 'MAIL': '/var/mail/cltbld', 04:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:50 INFO - 'MOZ_NO_REMOTE': '1', 04:16:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:50 INFO - 'NO_EM_RESTART': '1', 04:16:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:50 INFO - 'PWD': '/builds/slave/test', 04:16:50 INFO - 'SHELL': '/bin/bash', 04:16:50 INFO - 'SHLVL': '1', 04:16:50 INFO - 'TERM': 'linux', 04:16:50 INFO - 'TMOUT': '86400', 04:16:50 INFO - 'USER': 'cltbld', 04:16:50 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', 04:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:50 INFO - '_': '/tools/buildbot/bin/python'} 04:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:16:50 INFO - Cleaning up... 04:16:50 INFO - Return code: 0 04:16:50 INFO - Running post-action listener: _resource_record_post_action 04:16:50 INFO - Running post-action listener: _start_resource_monitoring 04:16:50 INFO - Starting resource monitoring. 04:16:50 INFO - [mozharness: 2016-10-14 11:16:50.792819Z] Finished create-virtualenv step (success) 04:16:50 INFO - [mozharness: 2016-10-14 11:16:50.793283Z] Running install step. 04:16:50 INFO - Running pre-action listener: _resource_record_pre_action 04:16:50 INFO - Running main action method: install 04:16:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:16:51 INFO - Reading from file tmpfile_stdout 04:16:51 INFO - Detecting whether we're running mozinstall >=1.0... 04:16:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:16:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:16:51 INFO - Reading from file tmpfile_stdout 04:16:51 INFO - Output received: 04:16:51 INFO - Usage: mozinstall [options] installer 04:16:51 INFO - Options: 04:16:51 INFO - -h, --help show this help message and exit 04:16:51 INFO - -d DEST, --destination=DEST 04:16:51 INFO - Directory to install application into. [default: 04:16:51 INFO - "/builds/slave/test"] 04:16:51 INFO - --app=APP Application being installed. [default: firefox] 04:16:51 INFO - mkdir: /builds/slave/test/build/application 04:16:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:16:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:17:08 INFO - Reading from file tmpfile_stdout 04:17:08 INFO - Output received: 04:17:08 INFO - /builds/slave/test/build/application/firefox/firefox 04:17:08 INFO - Running post-action listener: _resource_record_post_action 04:17:08 INFO - [mozharness: 2016-10-14 11:17:08.206904Z] Finished install step (success) 04:17:08 INFO - [mozharness: 2016-10-14 11:17:08.207216Z] Running run-tests step. 04:17:08 INFO - Running pre-action listener: _resource_record_pre_action 04:17:08 INFO - Running main action method: run_tests 04:17:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:17:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:17:08 INFO - Python 2.7.3 04:17:08 INFO - Return code: 0 04:17:08 INFO - grabbing minidump binary from tooltool 04:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:17:08 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79f60>, '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 0x2b7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:17:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:17:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:17:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:17:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:17:08 INFO - Return code: 0 04:17:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:17:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:17:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:17:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:17:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:17:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 04:17:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 04:17:08 INFO - Using env: {'DISPLAY': ':0', 04:17:08 INFO - 'HOME': '/home/cltbld', 04:17:08 INFO - 'LANG': 'en_US.UTF-8', 04:17:08 INFO - 'LANGUAGE': 'en_US:en', 04:17:08 INFO - 'LOGNAME': 'cltbld', 04:17:08 INFO - 'MAIL': '/var/mail/cltbld', 04:17:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:17:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:08 INFO - 'MOZ_NO_REMOTE': '1', 04:17:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:08 INFO - 'NO_EM_RESTART': '1', 04:17:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:08 INFO - 'PWD': '/builds/slave/test', 04:17:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:17:08 INFO - 'SHELL': '/bin/bash', 04:17:08 INFO - 'SHLVL': '1', 04:17:08 INFO - 'TERM': 'linux', 04:17:08 INFO - 'TMOUT': '86400', 04:17:08 INFO - 'USER': 'cltbld', 04:17:08 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099', 04:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:08 INFO - '_': '/tools/buildbot/bin/python'} 04:17:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 04:17:08 INFO - mozversion application_buildid: 20161014025635 04:17:08 INFO - mozversion application_changeset: a71215ad8ab820b2310f5dd38fcfded38d18768b 04:17:08 INFO - mozversion application_display_name: Nightly 04:17:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:17:08 INFO - mozversion application_name: Firefox 04:17:08 INFO - mozversion application_remotingname: firefox 04:17:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:17:08 INFO - mozversion application_vendor: Mozilla 04:17:08 INFO - mozversion application_version: 52.0a1 04:17:08 INFO - mozversion platform_buildid: 20161014025635 04:17:08 INFO - mozversion platform_changeset: a71215ad8ab820b2310f5dd38fcfded38d18768b 04:17:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:17:08 INFO - mozversion platform_version: 52.0a1 04:17:08 INFO - using testdate: 1476443828 04:17:08 INFO - actual date: 1476443828 04:17:08 INFO - starting webserver on 'localhost:37054' 04:17:08 INFO - SUITE-START | Running 2 tests 04:17:08 INFO - TEST-START | dromaeo_css 04:17:08 INFO - operating with platform_type : linux_ 04:17:08 INFO - Initialising browser for dromaeo_css test... 04:17:08 INFO - TEST-INFO | started process 18416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyLhZP1/profile http://localhost:37054/getInfo.html) 04:17:12 INFO - PROCESS | 18416 | __metrics Screen width/height:1600/1200 04:17:12 INFO - PROCESS | 18416 | colorDepth:24 04:17:12 INFO - PROCESS | 18416 | Browser inner width/height: 1024/697 04:17:12 INFO - PROCESS | 18416 | __metrics 04:17:13 INFO - PROCESS | 18416 | 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" 04:17:13 INFO - PROCESS | 18416 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:17:14 INFO - PROCESS | 18416 | console.error: PushService: 04:17:14 INFO - PROCESS | 18416 | stateChangeProcessEnqueue: Error transitioning state 04:17:14 INFO - PROCESS | 18416 | UnknownError 04:17:14 INFO - TEST-INFO | 18416: exit 0 04:17:14 INFO - Browser initialized. 04:17:14 INFO - Running cycle 1/1 for dromaeo_css test... 04:17:14 INFO - TEST-INFO | started process 18500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyLhZP1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:17:27 INFO - PROCESS | 18500 | RSS: Main: 173916160 04:17:27 INFO - PROCESS | 18500 | 04:18:18 INFO - PROCESS | 18500 | 1476443898028 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] 04:20:31 INFO - PROCESS | 18500 | Cycle 1(1): loaded http://localhost:37054/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37054/tests/dromaeo/cssquery-ext.html) 04:20:33 INFO - PROCESS | 18500 | RSS: Main: 409210880 04:20:33 INFO - PROCESS | 18500 | 04:23:36 INFO - PROCESS | 18500 | Cycle 1(1): loaded http://localhost:37054/tests/dromaeo/cssquery-ext.html (next: http://localhost:37054/tests/dromaeo/cssquery-jquery.html) 04:23:37 INFO - PROCESS | 18500 | RSS: Main: 280920064 04:23:37 INFO - PROCESS | 18500 | 04:26:39 INFO - PROCESS | 18500 | Cycle 1(1): loaded http://localhost:37054/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37054/tests/dromaeo/cssquery-mootools.html) 04:26:39 INFO - PROCESS | 18500 | RSS: Main: 219201536 04:26:39 INFO - PROCESS | 18500 | 04:29:42 INFO - PROCESS | 18500 | Cycle 1(1): loaded http://localhost:37054/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37054/tests/dromaeo/cssquery-prototype.html) 04:29:42 INFO - PROCESS | 18500 | RSS: Main: 219406336 04:29:42 INFO - PROCESS | 18500 | 04:32:45 INFO - PROCESS | 18500 | Cycle 1(1): loaded http://localhost:37054/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37054/tests/dromaeo/cssquery-yui.html) 04:32:46 INFO - PROCESS | 18500 | RSS: Main: 219049984 04:32:46 INFO - PROCESS | 18500 | 04:35:49 INFO - PROCESS | 18500 | Cycle 1(1): loaded http://localhost:37054/tests/dromaeo/cssquery-yui.html (next: http://localhost:37054/tests/dromaeo/cssquery-dojo.html) 04:35:49 INFO - PROCESS | 18500 | RSS: Main: 301490176 04:35:49 INFO - PROCESS | 18500 | 04:35:49 INFO - PROCESS | 18500 | __start_tp_report 04:35:49 INFO - PROCESS | 18500 | _x_x_mozilla_page_load 04:35:49 INFO - PROCESS | 18500 | _x_x_mozilla_page_load_details 04:35:49 INFO - PROCESS | 18500 | |i|pagename|runs| 04:35:49 INFO - PROCESS | 18500 | |0;dojo.html;2527.570313046782;2533.6199570064477;2580.703219129801;2593.144262393409;2605.726398728135;4452.732836029841;4540.863774086774;4624.098300831335;4662.9533704662945;4674.345591617176;4587.724736515803;4591.150637132133;4596.563326483979;4681.063787242548;4731.57415832575;4363.214621368153;4386.495553011397;4408.97795511022;4413.801378937939;4425.070735145623;4309.892252693692;4311.978440107795;4336.48402623638;4343.869683909472;4411.911761764763;4250.766207858566;4345.239583072966;4374.387585737999;4393.692441529094;4442.444694413199;4149.958500414988;4297;4312.956870431287;4317.69776115672;4419.138268037734;4163.958360416387;4215.894602634928;4219.367094935754;4223.429836972031;4226.281532139513;4548.863534093983;4575.725456472589;4578.816847326103;4628.398308219944;4708.552687494683;4859.343988561534;4893.608511319086;4913.508649135094;4918.581920536759;4974.204127339644;4807.567318941312;4872.293517439987;4962.478939711351;4962.503749625044;4999.12515309823;4579.404677391918;4600.700954437951;4629.3518907353;4631.467381251132;4638.350630911675;5053.646244762905;5063.1645778446145;5072.137736584789;5072.51811077947;5121;4614.400127983407;4851.466338702739;4857.271409288564;4866.05112003156;4917;4779.856604301876;4820.084184005028;4880.267959805987;4966.90066198674;4971.825986090542;4927.531884470969;4929.507049295042;4930.654854160246;4975.527324904128;4996.1007018736245;4903.828366007173;4910.582600479;4911.803527858846;4931.728754918442;4984.601231901439;4081.775502347399;4109.753414795062;4114.238865809775;4159.1265834175165;4207.158568286355;3646.9817650911577;3693.1321139532724;3712.2575484903127;3713.6472035156617;3719.5536535615356;4198.307279298881;4204.936925946114;4206.978965105216;4214.873553793391;4233.809478573472;4972.129877271535;5000.574951129195;5003.399592048978;5021.84934451967;5052.72210028452;4254.170436764863;4259.531451540328;4263.062126332202;4312.245357062501;4320.762358070274;4281.293586558183;4331.112122014979;4496.4154659894;4499.257622492318;4499.865004049819;4522.796474158605;4567.725936443758;4596.172688916027;4613.1004454131125;4678.719276843401;4948.950510494849;4955.5044495550155;4956.033573453142;4961.454240033521;5026.572741317029;4599.4020777300075;4617;4618.261078227468;4620.907581848277;4666.953330466652;4620.5148459411275;4717.929231061606;4718.174319494144;4788.61691064721;4790.137775200497;4835.95164048355;4839.056384005085;4847.757612119451;4849.393825771778;4851.514848515261;4675.018246168343;4735.431748190239;4740.288956656529;4740.549647783455;4740.549647783455;4746.145693775154;4758.857234282977;4759.143354196278;4762.833300834454;4767.4994125617695;4651.046535460155;4668.346431499524;4679.789409476513;4692.9530704692515;4700.741459219639;4809.470958194665;4810.374651295309;4810.759462026815;4811.49479304682;4812.8796780080775;4730.597899178609;4731.266653668687;4735.715857048588;4790.4251489821445;4856.878578035577 04:35:49 INFO - PROCESS | 18500 | |1;ext.html;565.2566874559953;569.2457493820688;573.2719446303198;581.584167320366;590.06474737541;27700.307492312702;30214.884958052946;30230.244243893914;30245.24386890329;38211.617883821156;35367.82316088416;39372.40941385881;39390.60609393905;39429.60570394295;39454.60545394545;7618.047744031982;7767.300942915136;7769.494982826126;7773.028371453568;7774.144844067148;7606.201348858373;7685.8078548036465;7688.038995125609;7688.692452301929;7689.077310722721;7659.502132361406;7685.269899359552;7701.152873183945;7704.306612404883;7705.229477052306;7660.119086305062;7687.346575541086;7692.576908270071;7700.382919586894;7707.96146019272;7618.733344332922;7680.423968202407;7685.03937007874;7686.269804368576;7688.961555192244;37422.06444838874;37564.43653345175;37645.81177094097;37882.81058594689;37977.81011094955;2764.972350276512;2784.2343355577377;2844.33158207821;2873.5976963225166;2939.1770304314828;27104.011247134906;27536.17391478259;27740.30649233765;28340;28779.424411511653;3268.8365581721055;3388.254583991518;3394.066631676284;3411.8805841795665;3462.0998540379433;237211.99999999828;237220;237576;237710;239307;49875.25187122196;50157.74921125371;50218.246726299134;50253.49746502561;50261.74869125631;31887.52168717471;32863;33302.50046249308;34557;52760.47239527632;13949.790753138712;14010.229437380838;14011.43954241819;14023;14069.648258793612;10861.1854110942;10894.564217431214;10923.945380273048;10927.071198948019;10929.453527323602;17464;17558.473245802645;17592.648147037242;17605.64788704219;17611.38360157388;6511.869762604816;6646.700898459581;6713.899291510631;6732.831679208059;6927.58434493932;788.4599049651007;890.7773056735816;928.215657769184;935.4761333653177;970.5583959298502;27329.180124595896;27736.167914962585;27906.16281511558;27920.301992449946;28153;921.5898924978454;930.3487558708931;940.47333493244;955.7945041816043;1046.863907691995;13973.860261397256;14636.853631463762;14659.706805863823;14882.776758348633;14934.253287335807;356086;356344;359261;362147;363420;48255.27617085746;48712;48730.75634621804;48802.75598621984;48897.75551122222;1052.600011995437;1100.9064229540418;1139.2480962564669;1157.745296034871;1180.0795379603924;25404.237872863843;27616.309592260353;28642.14073577796;29072.854635727534;29524.852375737984;45787.54212457833;46564.7671761639;46674.76662616665;46786.29820552762;46954.29568556543;334256;335651;336432;336694;336766;29691.257718557208;31159;34466.82766586151;36138.27723445464;36733.04103945933;38999;39668.603313966494;40494.1901161981;40796.79601601973;40990.180196396504;33745.49381759325;33898.83050584731;34034.489482658275;34119.317613647094;34517.48223776595;33384.49923251104;33559.83220083884;34138.65861341454;34480.31039379248;34975.82512087525;33357.83321083379;33946.49080263748;34061.31877362389;34243.14392140217;34572.481412778325;29820;31357.21606959753;31713.365732685677;31773.523397149525;31776.523352149274;23805.523889522457;24496.265112046665;24517.264482065566;24871.253862384157;24883.62674559919 04:35:49 INFO - PROCESS | 18500 | |2;jquery.html;358.8385226648009;363.4892975369605;363.9708823294136;379.99240015199695;381.5478657790517;16035.438759643415;16726.916365418172;16743.16284185792;16979.999999999985;17084.487465376027;15567.688646227069;15710.607234819136;16163.272652730626;16260.918695406506;16313.084859633691;4727.929081063796;4974.900501989958;4976.203807390818;4976.651634385595;4982.476839931809;3575.2313252650674;3791.791451470168;4849.7817598207985;5519.448055194469;5900;5877.118432235156;5987.790427335044;5989.88020239595;5992.131140984555;5993.220881285427;5773;5967.701614919259;5994.1608174855555;6002.249718785152;6004.309504406961;5102.6428150029515;5288.048151332759;5293.7617807198385;5299.5760339172775;5300.840974770725;20565.58868822615;21261.149554017822;21300.25449109274;21325.36023919285;21354.57290854174;1846.8799528030636;1849.3342396737164;1905.5426697592477;1963.6072785442825;2085.904899927535;12728.427220775087;13468.730625387438;13595.932020339935;13950.51173208943;14090.788638170436;1732.5495371203451;1745.3629425259817;1810.2125575374755;1889.1121173048646;1895.2703209264394;80953;81585.59207203986;82540.58729706373;83373.16626833714;84250.57874710648;16209.189540522926;16301.91849040771;16695.833041669426;16705.83294167067;16710.4151354702;28527.857360713064;28651.426971460452;28689.13932582026;28720.42559148847;28794.28014299659;8769.693060742844;8914.598843052077;9121.80736742135;9205.723828285161;9285.257179425766;7459.881017847366;7477.065366829146;7597.734079307198;7669.7315593953945;7742.574158421228;8063.919360806317;8335.493131840683;8463.788405289793;8516.446430981967;8544.719631071157;2566.9871650641626;3118.8908388206305;3153.621565412165;3254.6908043735807;3504.3341765064556;720;806.395203597302;833.2209384225769;857.5155037403847;895.7178488776015;16251.918740406223;16392.180390980404;16982;17028.404005859982;17230.541689776408;821.3839620284787;830.8462934357163;830.8866119399912;844.2275318084007;881.8456770065213;9096.135867092615;9546.474943878015;9558.139767420966;9640.373375730554;9677.225821934227;362354;363752;390993;401147;402093;39126;39761.602383976366;53265.73367133139;78382;79941;886.4016788667624;919.2140719684706;945.2910317262053;945.976350591227;946.6639343033262;15612.531624051297;15732.528024158835;16307.347706091623;16390.836091638932;16616.086115263293;38399.616003839605;39526.12223687805;39614;40027.3995890056;40634.1873162541;47744.7612761934;50919.745401272754;50955.2356714657;51280.23079653733;52057.7397113012;7321.297051973501;7404.444666649915;7486.139094004041;7662.885056724042;7725.227477252454;6383.0744542042075;7158.943459261237;8703.738887833375;9683.903160968583;11590.652280431601;10175.949120254352;10272.178225742073;10412.947935260276;10503.159747220358;10716.249862509549;10252.23108266868;10286.845697314697;10307.278490505892;10324.535395907053;10414.375137491776;10164.542595583365;10214;10501.842472363074;10658;11031.889681103086;7455.776326710207;7557.5465472071855;7645.273698998586;7891.131975482807;8014.078380986261;9722.75693107678;9875.308728388944;10236.744081398025;10274.845877311996;10619.15046796239 04:35:49 INFO - PROCESS | 18500 | |3;mootools.html;1316.3681432912206;1364.6179069860439;1383.7163381506787;1626.625876048508;1636.4027130097518;6436.903446448296;6670.0661907333015;7377.4466914981385;7983.481073730203;7987.161348058457;7400.370968467687;7669.271419215165;7669.731559395423;7838.05943286805;7850.725224617139;2092.6442504774186;2110.3141479019305;2125.9893700531475;2132.1897678882;2140.411386868608;1744.9302027918868;1802.7025540785755;2086.447091520748;2089.268755935426;2132.7120838686733;2139.8288136949086;2166.869987800729;2173.119886445992;2183.5196256823474;2189.321310393775;2094.5077906691913;2108.3976178104676;2123.288698286076;2127.361791462555;2127.7446706395253;2054.075665950328;2065.8760474371584;2066.121898193277;2068.834493240537;2077;7831.6475758591005;7985.800354991114;7987.281144696947;7991.960040199761;7994.440389172761;4424.070945101533;4574.977125114353;4595.540445955411;4605.263157894754;4608.4700259470255;2646.431017331283;2713.036871910463;2740.397112635217;2778.097118436516;2790.4558611070847;902.1474706402453;912.4798864647154;913.945163290198;922.5064590444081;928.9628414863397;10545.314554554006;10581;10592.311499752568;10612.257142000062;10612.363258204456;3887.727859049896;4119.958800412018;4235.682323825664;4240.533541310453;4248.1078973415315;9083.318751093562;9094.681686141086;9114.179723824887;9119.635214591475;9133.634654613874;4533.478649955231;4537.410136682211;4541.977290113528;4546.590806827401;4578.473475550354;4018.4374187613757;4124.8143833527565;4137.731047481904;4149.564295748964;4151.27352713274;3509.842057107436;3633.909152271214;3704.7777133372083;3711.2206436648607;3727.4781530585738;1022.6727447216967;1072.4101744040747;1169.7192673758407;1177.4230626992712;1196.132803717298;601.3145014683265;673.6362364323309;778.4200770426069;805.287320721166;813.2518083363202;4636.79134438951;4762.3808904842845;4824.951750482521;4855.684380515255;4857.417109946829;847.872819077131;848.8498085094608;851.4848516647463;882.0870399136862;884.1777147252988;3185.681431856796;3363.058343663778;3423.0659677282256;3522.242717815631;3609.826806287967;9254.814903702023;9751.317407781387;9836.213102951746;9842.212622990144;9845.704628861145;9667.468289244018;9671.564779584936;9673.322867399354;9679.225661947028;9689.612415503301;6883.27725588816;7163.3552980232025;7221.747238846615;7223.7471688491705;7226.494145409771;4951.480094590016;4976.776045077908;4988.102141614399;5025.899482010266;5098.439171691037;8370.832583348178;8658.740237792876;8738.650453982023;8744.125587441205;8827.955860220658;8864.024957254567;8938.776530586527;8956.641734330815;9025.323100767337;9099.863502047343;6328.208973878265;6492.837679058061;6493.675316234264;6497.415232629086;6498.122753428227;7021.192562855337;7031.542949708252;7108;7110.1112360954885;7134.714611415485;5054.2671312660195;6407.967960160356;6487.870242595216;6502.089707441057;6649.401553860176;6430.48556115519;6457.67711614408;6508.414242717989;6595.4393876521035;6611;5733.741981610754;5835.649861008353;5836.015754643442;5836.620619659709;5847.298324201123;4222.514410842792;4223.5565265646665;4293.592108749664;4333.848315308949;4430.2468580342065;4143.482064741907;4239.152169566038;4309.2674245378985;4359.084592235666;4407.449068866392 04:35:49 INFO - PROCESS | 18500 | |4;prototype.html;291.5844920987592;301.7812086237477;303.14059640918;307.49877699350054;309.6253533224798;4753.168195565775;4778.187708089625;4786.787626888342;4794.089123066615;4870.586000189988;4691.411070531047;4702.200625893598;4703.7177769333775;4715.2455607102875;4718.174319494084;3503.1592417819666;3635.7273204509765;3675.2649470105953;3731.6828069614116;3766.9623303766884;3766;3784.1674831537016;3793.8103094845287;3794.1842503861803;3795.235215624734;3737.289914916171;3741.7567858089274;3745.213505163919;3748.344039793039;3752.3620984432578;3502.2820321833965;3626.34725749365;3630.7640003399692;3736.8505259789576;3750.7374483786148;3299.868005279786;3309.933801323984;3317.104381816896;3327.3345330933666;3332.500124981272;4638.628909687217;4642.907141857144;4646.814127434933;4653.488116307203;4656.883577910546;4186.35111557709;4267.039916018902;4272.2950713132295;4279.229738647043;4288.69979101463;4939.629527785431;4981.708414129468;4986.52628000343;4990.451050384455;4994.475580064077;3620.8775279663387;3626.184108575576;3631.94552081719;3634.4730014148063;3637.927241455156;5076.375559820822;5204.115300398941;5212.947870521284;5215.765290561933;5215.869603259911;3658.926821463609;3694.168812017275;3705.444183372516;3719.9442008369897;3733.6266373362446;3749.4375843623675;3761.0033341164067;3761.4202035145304;3785.3186426443503;3788.2234142001375;4251.213525497793;4264.850730224427;4266.850660226877;4270.893227669271;4287.228298906227;4698.7783176373705;4952.158133117378;4995.775190116454;5015.548600625962;5017.623678224148;1259.5654499197763;1263.6651287408845;1270.4283072617359;1272.1794442584667;1277.757226127033;798.8282519258387;809.720646376999;817.8977627796526;819.1235378145446;823.2341627209602;4191.664666826647;4256.638185754184;4334.934975975363;4366.563343665608;4406.647468202536;5128.769205385766;5130.256112863613;5146.228065790161;5161.896762064737;5162.92255616166;4360.106178233455;4362.672799540047;4368.890777730582;4400.867973960786;4428.335749637516;2606.7653911148086;2698.7031426543062;2714.891404343804;2718.3418114949864;2718.3611851215346;4764.880877978009;4772.067312738346;4775.856724298276;4790.329353890458;4810.773252820578;5238.92141617876;5245.0558899398475;5252.947470525322;5273.736313184402;5275.709835958983;4535.142859998246;4825;4827.141550503082;4841.733704646208;4863.80544778212;5122.8975420492125;5135.486451354835;5155.510226528474;5162.6902385856965;5194.948050519446;4886.2746271932765;5036.6726162799305;5052.924206136838;5062.164742817394;5078.7206703631655;4780.259059845729;4804.06320767447;4804.759762011955;4812.965212479334;4830.734309612864;3620.3483372993114;3641.490191373263;3644.4351125575577;3653.6981701527866;3692.8707495237536;5144.459831717616;5162.122439185423;5165.535101840853;5165.793368265227;5218.452062533531;4820.927686084641;4961.50384961501;4969.900601988013;4972.776225069808;4992.675476094042;4956.851294461172;4966.553010229097;4997.3253610762085;5001.749912504433;5002.849914502571;4919.4834542373965;4936.925946110883;4942.703437793743;4943.802247910044;4961.660351705092;4783.6412269079265;4835.468098509091;4919.729414882216;5016.949830501794;5018.598512118949;4805.663603547718;4930.5069493050405;4937.728424936663;4943.382077240345;4950.183219768698 04:35:49 INFO - PROCESS | 18500 | |5;yui.html;561.8033688209127;583.182439399845;625.8372921908756;700.8843540815766;702.2861444589721;12850.22898626083;13400.731985360288;13558.728825423486;13985.720285594281;13989.370478328474;13843.723125537508;13905.374258158381;13947.790783138262;13973.161610303388;13988.720225595482;610.8442347201458;621.6114928169894;732.6483288021752;757.443279189795;760.6348952502802;734.6804140199031;753.7022875964018;763.606742527596;764.6406189091147;765.311219902087;799.7041094794905;801.2988634944423;801.8757092650649;802.1136644008375;802.1897883138014;630.9085182648536;649.191756263455;792.6353877216487;792.6631181747734;792.7463211772235;481.1795888010933;482.6356101143614;483.87661146407794;561.5507593924843;576.8788554403538;12524.937375313066;12568.685782855411;12573.685657858627;12583.182093164007;12596.307203103826;11880.227785193934;12206.450709717996;12441.564545240873;12501.93749031249;12977.41601627929;11741.767114452945;11746;11789.17475776696;11832;12517.499300027988;3988.78061706606;4034.8904051386103;4199.202151591188;4202.432671589327;4208.705390622657;61537.6923115386;63132.68433657848;63134.36865631331;63294;63777;10139.188864890792;10155.492225388849;10409.323393979366;10474.528646210938;10660.62687805923;17629.7355539667;17690.5577360567;17804.821951780574;17941;18069.54826129331;6076.179715738407;6153.938460615336;6213.751449942042;6240.563160578807;6355.396237357444;3473.94789078164;3515.4199557073307;3532.911677208039;3558.6619271169197;3609.205974685565;2593.740625937391;2635.222609330252;2677.6786785585855;2678.397360593851;2684.8254863433813;439.95820397062226;440.13293811191903;445.24753167148066;486.7858142417325;510.5481648740891;491.16992283041543;568.2555851834111;580.4891695308186;592.0202065581469;598.2282855116938;7021.613811240431;7217.855642887218;7624.771256862303;7650.73222437212;7851.568163751049;471.5096299848188;522.4435975685882;566.6260268222953;593.1695626123461;593.2495393327445;3599.262151258986;3666.5233519642275;3786.3563194257044;3789.1663833956486;3817.3892177251505;73218.6339068312;76380.61809691027;77168.61415692886;86390.42641703067;100805;45261.54738452639;45549.77225113853;45943.31085033727;46088.5391146091;69152.6542367295;42347.15305693869;60266.39733602608;66053.33946660568;66597.66701166656;66708.66645666838;7467.887981680387;7929.127795942326;8000.319972802377;8186.426950113435;8228.21831925966;41532.792336038125;43725.562744372146;43763.56236437722;44247;44876.326855097854;34698;34861.477077843345;58591.70704146452;59312.406875932415;59431.702841485516;9499.477528735986;10086.6469673564;10128.696139115838;10132.746681333025;10251.38491690501;10847;11106;11338.09295256361;11818;11826.408679565815;11201.439928003405;11310;11438.370889601152;11851;11966.102542309187;10832.18758593093;10974.341539507655;11180;11927.10546708983;12303.446344914679;10410.68767936963;10483.274348669249;10873.782524349626;10876.619318323821;10963.177761667748;8362.498250105013;8542.359323050672;8721.65113395457;8934.597943092447;8956.265895377042;8850.73447796567;8951.955240223757;9033.367664263438;9153.679621213225;9206.585703643486 04:35:49 INFO - PROCESS | 18500 | __end_tp_report 04:35:49 INFO - PROCESS | 18500 | __start_cc_report 04:35:49 INFO - PROCESS | 18500 | _x_x_mozilla_cycle_collect,2673 04:35:49 INFO - PROCESS | 18500 | __end_cc_report 04:35:49 INFO - PROCESS | 18500 | __startTimestamp1476444949782__endTimestamp 04:35:49 INFO - PROCESS | 18500 | 04:35:49 INFO - PROCESS | 18500 | ------- Summary: start ------- 04:35:49 INFO - PROCESS | 18500 | Number of tests: 6 04:35:49 INFO - PROCESS | 18500 | 04:35:49 INFO - PROCESS | 18500 | [#0] dojo.html Cycles:165 Average:4557.29 Median:4666.95 stddev:467.27 (10.0%) stddev-sans-first:440.74 04:35:49 INFO - PROCESS | 18500 | Values: 2527.6 2533.6 2580.7 2593.1 2605.7 4452.7 4540.9 4624.1 4663.0 4674.3 4587.7 4591.2 4596.6 4681.1 4731.6 4363.2 4386.5 4409.0 4413.8 4425.1 4309.9 4312.0 4336.5 4343.9 4411.9 4250.8 4345.2 4374.4 4393.7 4442.4 4150.0 4297.0 4313.0 4317.7 4419.1 4164.0 4215.9 4219.4 4223.4 4226.3 4548.9 4575.7 4578.8 4628.4 4708.6 4859.3 4893.6 4913.5 4918.6 4974.2 4807.6 4872.3 4962.5 4962.5 4999.1 4579.4 4600.7 4629.4 4631.5 4638.4 5053.6 5063.2 5072.1 5072.5 5121.0 4614.4 4851.5 4857.3 4866.1 4917.0 4779.9 4820.1 4880.3 4966.9 4971.8 4927.5 4929.5 4930.7 4975.5 4996.1 4903.8 4910.6 4911.8 4931.7 4984.6 4081.8 4109.8 4114.2 4159.1 4207.2 3647.0 3693.1 3712.3 3713.6 3719.6 4198.3 4204.9 4207.0 4214.9 4233.8 4972.1 5000.6 5003.4 5021.8 5052.7 4254.2 4259.5 4263.1 4312.2 4320.8 4281.3 4331.1 4496.4 4499.3 4499.9 4522.8 4567.7 4596.2 4613.1 4678.7 4949.0 4955.5 4956.0 4961.5 5026.6 4599.4 4617.0 4618.3 4620.9 4667.0 4620.5 4717.9 4718.2 4788.6 4790.1 4836.0 4839.1 4847.8 4849.4 4851.5 4675.0 4735.4 4740.3 4740.5 4740.5 4746.1 4758.9 4759.1 4762.8 4767.5 4651.0 4668.3 4679.8 4693.0 4700.7 4809.5 4810.4 4810.8 4811.5 4812.9 4730.6 4731.3 4735.7 4790.4 4856.9 04:35:49 INFO - PROCESS | 18500 | 04:35:49 INFO - PROCESS | 18500 | [#1] ext.html Cycles:180 Average:45860.08 Median:34473.57 stddev:83009.18 (240.8%) stddev-sans-first:83172.38 04:35:49 INFO - PROCESS | 18500 | Values: 565.3 569.2 573.3 581.6 590.1 27700.3 30214.9 30230.2 30245.2 38211.6 35367.8 39372.4 39390.6 39429.6 39454.6 7618.0 7767.3 7769.5 7773.0 7774.1 7606.2 7685.8 7688.0 7688.7 7689.1 7659.5 7685.3 7701.2 7704.3 7705.2 7660.1 7687.3 7692.6 7700.4 7708.0 7618.7 7680.4 7685.0 7686.3 7689.0 37422.1 37564.4 37645.8 37882.8 37977.8 2765.0 2784.2 2844.3 2873.6 2939.2 27104.0 27536.2 27740.3 28340.0 28779.4 3268.8 3388.3 3394.1 3411.9 3462.1 237212.0 237220.0 237576.0 237710.0 239307.0 49875.3 50157.7 50218.2 50253.5 50261.7 31887.5 32863.0 33302.5 34557.0 52760.5 13949.8 14010.2 14011.4 14023.0 14069.6 10861.2 10894.6 10923.9 10927.1 10929.5 17464.0 17558.5 17592.6 17605.6 17611.4 6511.9 6646.7 6713.9 6732.8 6927.6 788.5 890.8 928.2 935.5 970.6 27329.2 27736.2 27906.2 27920.3 28153.0 921.6 930.3 940.5 955.8 1046.9 13973.9 14636.9 14659.7 14882.8 14934.3 356086.0 356344.0 359261.0 362147.0 363420.0 48255.3 48712.0 48730.8 48802.8 48897.8 1052.6 1100.9 1139.2 1157.7 1180.1 25404.2 27616.3 28642.1 29072.9 29524.9 45787.5 46564.8 46674.8 46786.3 46954.3 334256.0 335651.0 336432.0 336694.0 336766.0 29691.3 31159.0 34466.8 36138.3 36733.0 38999.0 39668.6 40494.2 40796.8 40990.2 33745.5 33898.8 34034.5 34119.3 34517.5 33384.5 33559.8 34138.7 34480.3 34975.8 33357.8 33946.5 34061.3 34243.1 34572.5 29820.0 31357.2 31713.4 31773.5 31776.5 23805.5 24496.3 24517.3 24871.3 24883.6 04:35:49 INFO - PROCESS | 18500 | 04:35:49 INFO - PROCESS | 18500 | [#2] jquery.html Cycles:180 Average:24917.04 Median:401620.00 stddev:63423.43 (15.8%) stddev-sans-first:63574.54 04:35:49 INFO - PROCESS | 18500 | Values: 358.8 363.5 364.0 380.0 381.5 16035.4 16726.9 16743.2 16980.0 17084.5 15567.7 15710.6 16163.3 16260.9 16313.1 4727.9 4974.9 4976.2 4976.7 4982.5 3575.2 3791.8 4849.8 5519.4 5900.0 5877.1 5987.8 5989.9 5992.1 5993.2 5773.0 5967.7 5994.2 6002.2 6004.3 5102.6 5288.0 5293.8 5299.6 5300.8 20565.6 21261.1 21300.3 21325.4 21354.6 1846.9 1849.3 1905.5 1963.6 2085.9 12728.4 13468.7 13595.9 13950.5 14090.8 1732.5 1745.4 1810.2 1889.1 1895.3 80953.0 81585.6 82540.6 83373.2 84250.6 16209.2 16301.9 16695.8 16705.8 16710.4 28527.9 28651.4 28689.1 28720.4 28794.3 8769.7 8914.6 9121.8 9205.7 9285.3 7459.9 7477.1 7597.7 7669.7 7742.6 8063.9 8335.5 8463.8 8516.4 8544.7 2567.0 3118.9 3153.6 3254.7 3504.3 720.0 806.4 833.2 857.5 895.7 16251.9 16392.2 16982.0 17028.4 17230.5 821.4 830.8 830.9 844.2 881.8 9096.1 9546.5 9558.1 9640.4 9677.2 362354.0 363752.0 390993.0 401147.0 402093.0 39126.0 39761.6 53265.7 78382.0 79941.0 886.4 919.2 945.3 946.0 946.7 15612.5 15732.5 16307.3 16390.8 16616.1 38399.6 39526.1 39614.0 40027.4 40634.2 47744.8 50919.7 50955.2 51280.2 52057.7 7321.3 7404.4 7486.1 7662.9 7725.2 6383.1 7158.9 8703.7 9683.9 11590.7 10175.9 10272.2 10412.9 10503.2 10716.2 10252.2 10286.8 10307.3 10324.5 10414.4 10164.5 10214.0 10501.8 10658.0 11031.9 7455.8 7557.5 7645.3 7891.1 8014.1 9722.8 9875.3 10236.7 10274.8 10619.2 04:35:49 INFO - PROCESS | 18500 | 04:35:49 INFO - PROCESS | 18500 | [#3] mootools.html Cycles:180 Average:5000.80 Median:4964.13 stddev:2863.00 (57.7%) stddev-sans-first:2857.64 04:35:49 INFO - PROCESS | 18500 | Values: 1316.4 1364.6 1383.7 1626.6 1636.4 6436.9 6670.1 7377.4 7983.5 7987.2 7400.4 7669.3 7669.7 7838.1 7850.7 2092.6 2110.3 2126.0 2132.2 2140.4 1744.9 1802.7 2086.4 2089.3 2132.7 2139.8 2166.9 2173.1 2183.5 2189.3 2094.5 2108.4 2123.3 2127.4 2127.7 2054.1 2065.9 2066.1 2068.8 2077.0 7831.6 7985.8 7987.3 7992.0 7994.4 4424.1 4575.0 4595.5 4605.3 4608.5 2646.4 2713.0 2740.4 2778.1 2790.5 902.1 912.5 913.9 922.5 929.0 10545.3 10581.0 10592.3 10612.3 10612.4 3887.7 4120.0 4235.7 4240.5 4248.1 9083.3 9094.7 9114.2 9119.6 9133.6 4533.5 4537.4 4542.0 4546.6 4578.5 4018.4 4124.8 4137.7 4149.6 4151.3 3509.8 3633.9 3704.8 3711.2 3727.5 1022.7 1072.4 1169.7 1177.4 1196.1 601.3 673.6 778.4 805.3 813.3 4636.8 4762.4 4825.0 4855.7 4857.4 847.9 848.8 851.5 882.1 884.2 3185.7 3363.1 3423.1 3522.2 3609.8 9254.8 9751.3 9836.2 9842.2 9845.7 9667.5 9671.6 9673.3 9679.2 9689.6 6883.3 7163.4 7221.7 7223.7 7226.5 4951.5 4976.8 4988.1 5025.9 5098.4 8370.8 8658.7 8738.7 8744.1 8828.0 8864.0 8938.8 8956.6 9025.3 9099.9 6328.2 6492.8 6493.7 6497.4 6498.1 7021.2 7031.5 7108.0 7110.1 7134.7 5054.3 6408.0 6487.9 6502.1 6649.4 6430.5 6457.7 6508.4 6595.4 6611.0 5733.7 5835.6 5836.0 5836.6 5847.3 4222.5 4223.6 4293.6 4333.8 4430.2 4143.5 4239.2 4309.3 4359.1 4407.4 04:35:49 INFO - PROCESS | 18500 | 04:35:49 INFO - PROCESS | 18500 | [#4] prototype.html Cycles:180 Average:4146.68 Median:4716.71 stddev:1200.87 (25.5%) stddev-sans-first:1168.86 04:35:49 INFO - PROCESS | 18500 | Values: 291.6 301.8 303.1 307.5 309.6 4753.2 4778.2 4786.8 4794.1 4870.6 4691.4 4702.2 4703.7 4715.2 4718.2 3503.2 3635.7 3675.3 3731.7 3767.0 3766.0 3784.2 3793.8 3794.2 3795.2 3737.3 3741.8 3745.2 3748.3 3752.4 3502.3 3626.3 3630.8 3736.9 3750.7 3299.9 3309.9 3317.1 3327.3 3332.5 4638.6 4642.9 4646.8 4653.5 4656.9 4186.4 4267.0 4272.3 4279.2 4288.7 4939.6 4981.7 4986.5 4990.5 4994.5 3620.9 3626.2 3631.9 3634.5 3637.9 5076.4 5204.1 5212.9 5215.8 5215.9 3658.9 3694.2 3705.4 3719.9 3733.6 3749.4 3761.0 3761.4 3785.3 3788.2 4251.2 4264.9 4266.9 4270.9 4287.2 4698.8 4952.2 4995.8 5015.5 5017.6 1259.6 1263.7 1270.4 1272.2 1277.8 798.8 809.7 817.9 819.1 823.2 4191.7 4256.6 4334.9 4366.6 4406.6 5128.8 5130.3 5146.2 5161.9 5162.9 4360.1 4362.7 4368.9 4400.9 4428.3 2606.8 2698.7 2714.9 2718.3 2718.4 4764.9 4772.1 4775.9 4790.3 4810.8 5238.9 5245.1 5252.9 5273.7 5275.7 4535.1 4825.0 4827.1 4841.7 4863.8 5122.9 5135.5 5155.5 5162.7 5194.9 4886.3 5036.7 5052.9 5062.2 5078.7 4780.3 4804.1 4804.8 4813.0 4830.7 3620.3 3641.5 3644.4 3653.7 3692.9 5144.5 5162.1 5165.5 5165.8 5218.5 4820.9 4961.5 4969.9 4972.8 4992.7 4956.9 4966.6 4997.3 5001.7 5002.8 4919.5 4936.9 4942.7 4943.8 4961.7 4783.6 4835.5 4919.7 5016.9 5018.6 4805.7 4930.5 4937.7 4943.4 4950.2 04:35:49 INFO - PROCESS | 18500 | 04:35:49 INFO - PROCESS | 18500 | [#5] yui.html Cycles:180 Average:15456.38 Median:45068.94 stddev:20744.97 (46.0%) stddev-sans-first:20773.01 04:35:49 INFO - PROCESS | 18500 | Values: 561.8 583.2 625.8 700.9 702.3 12850.2 13400.7 13558.7 13985.7 13989.4 13843.7 13905.4 13947.8 13973.2 13988.7 610.8 621.6 732.6 757.4 760.6 734.7 753.7 763.6 764.6 765.3 799.7 801.3 801.9 802.1 802.2 630.9 649.2 792.6 792.7 792.7 481.2 482.6 483.9 561.6 576.9 12524.9 12568.7 12573.7 12583.2 12596.3 11880.2 12206.5 12441.6 12501.9 12977.4 11741.8 11746.0 11789.2 11832.0 12517.5 3988.8 4034.9 4199.2 4202.4 4208.7 61537.7 63132.7 63134.4 63294.0 63777.0 10139.2 10155.5 10409.3 10474.5 10660.6 17629.7 17690.6 17804.8 17941.0 18069.5 6076.2 6153.9 6213.8 6240.6 6355.4 3473.9 3515.4 3532.9 3558.7 3609.2 2593.7 2635.2 2677.7 2678.4 2684.8 440.0 440.1 445.2 486.8 510.5 491.2 568.3 580.5 592.0 598.2 7021.6 7217.9 7624.8 7650.7 7851.6 471.5 522.4 566.6 593.2 593.2 3599.3 3666.5 3786.4 3789.2 3817.4 73218.6 76380.6 77168.6 86390.4 100805.0 45261.5 45549.8 45943.3 46088.5 69152.7 42347.2 60266.4 66053.3 66597.7 66708.7 7467.9 7929.1 8000.3 8186.4 8228.2 41532.8 43725.6 43763.6 44247.0 44876.3 34698.0 34861.5 58591.7 59312.4 59431.7 9499.5 10086.6 10128.7 10132.7 10251.4 10847.0 11106.0 11338.1 11818.0 11826.4 11201.4 11310.0 11438.4 11851.0 11966.1 10832.2 10974.3 11180.0 11927.1 12303.4 10410.7 10483.3 10873.8 10876.6 10963.2 8362.5 8542.4 8721.7 8934.6 8956.3 8850.7 8952.0 9033.4 9153.7 9206.6 04:35:49 INFO - PROCESS | 18500 | -------- Summary: end -------- 04:35:49 INFO - PROCESS | 18500 | 04:35:50 INFO - TEST-INFO | 18500: exit 0 04:35:50 INFO - TEST-OK | dromaeo_css | took 1122275ms 04:35:50 INFO - TEST-START | kraken 04:35:50 INFO - operating with platform_type : linux_ 04:35:50 INFO - Initialising browser for kraken test... 04:35:50 INFO - TEST-INFO | started process 18807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpngdrSd/profile http://localhost:37054/getInfo.html) 04:35:54 INFO - PROCESS | 18807 | __metrics Screen width/height:1600/1200 04:35:54 INFO - PROCESS | 18807 | colorDepth:24 04:35:54 INFO - PROCESS | 18807 | Browser inner width/height: 1024/697 04:35:54 INFO - PROCESS | 18807 | __metrics 04:35:55 INFO - PROCESS | 18807 | 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" 04:35:55 INFO - PROCESS | 18807 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:35:56 INFO - PROCESS | 18807 | console.error: PushService: 04:35:56 INFO - PROCESS | 18807 | stateChangeProcessEnqueue: Error transitioning state 04:35:56 INFO - PROCESS | 18807 | UnknownError 04:35:56 INFO - TEST-INFO | 18807: exit 0 04:35:56 INFO - Browser initialized. 04:35:56 INFO - Running cycle 1/1 for kraken test... 04:35:56 INFO - TEST-INFO | started process 18891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpngdrSd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:36:09 INFO - PROCESS | 18891 | RSS: Main: 174489600 04:36:09 INFO - PROCESS | 18891 | 04:36:11 INFO - PROCESS | 18891 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37054/tests/kraken/driver.html?testName=audio-beat-detection) 04:36:12 INFO - PROCESS | 18891 | RSS: Main: 232947712 04:36:12 INFO - PROCESS | 18891 | 04:36:15 INFO - PROCESS | 18891 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37054/tests/kraken/driver.html?testName=audio-dft) 04:36:16 INFO - PROCESS | 18891 | RSS: Main: 218226688 04:36:16 INFO - PROCESS | 18891 | 04:36:19 INFO - PROCESS | 18891 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37054/tests/kraken/driver.html?testName=audio-fft) 04:36:20 INFO - PROCESS | 18891 | RSS: Main: 299577344 04:36:20 INFO - PROCESS | 18891 | 04:36:22 INFO - PROCESS | 18891 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37054/tests/kraken/driver.html?testName=audio-oscillator) 04:36:23 INFO - PROCESS | 18891 | RSS: Main: 208515072 04:36:23 INFO - PROCESS | 18891 | 04:36:25 INFO - PROCESS | 18891 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37054/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:36:25 INFO - PROCESS | 18891 | RSS: Main: 212828160 04:36:25 INFO - PROCESS | 18891 | 04:36:28 INFO - PROCESS | 18891 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37054/tests/kraken/driver.html?testName=imaging-darkroom) 04:36:29 INFO - PROCESS | 18891 | RSS: Main: 249794560 04:36:29 INFO - PROCESS | 18891 | 04:36:33 INFO - PROCESS | 18891 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37054/tests/kraken/driver.html?testName=imaging-desaturate) 04:36:33 INFO - PROCESS | 18891 | RSS: Main: 243478528 04:36:33 INFO - PROCESS | 18891 | 04:36:36 INFO - PROCESS | 18891 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37054/tests/kraken/driver.html?testName=json-parse-financial) 04:36:37 INFO - PROCESS | 18891 | RSS: Main: 246652928 04:36:37 INFO - PROCESS | 18891 | 04:36:38 INFO - PROCESS | 18891 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37054/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:36:39 INFO - PROCESS | 18891 | RSS: Main: 210255872 04:36:39 INFO - PROCESS | 18891 | 04:36:41 INFO - PROCESS | 18891 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37054/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:36:42 INFO - PROCESS | 18891 | RSS: Main: 217657344 04:36:42 INFO - PROCESS | 18891 | 04:36:44 INFO - PROCESS | 18891 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37054/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:36:44 INFO - PROCESS | 18891 | RSS: Main: 226750464 04:36:44 INFO - PROCESS | 18891 | 04:36:47 INFO - PROCESS | 18891 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37054/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:36:48 INFO - PROCESS | 18891 | RSS: Main: 229965824 04:36:48 INFO - PROCESS | 18891 | 04:36:51 INFO - PROCESS | 18891 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37054/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:36:52 INFO - PROCESS | 18891 | RSS: Main: 231337984 04:36:52 INFO - PROCESS | 18891 | 04:36:53 INFO - PROCESS | 18891 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37054/tests/kraken/driver.html?testName=ai-astar) 04:36:54 INFO - PROCESS | 18891 | RSS: Main: 283557888 04:36:54 INFO - PROCESS | 18891 | 04:36:54 INFO - PROCESS | 18891 | __start_tp_report 04:36:54 INFO - PROCESS | 18891 | _x_x_mozilla_page_load 04:36:54 INFO - PROCESS | 18891 | _x_x_mozilla_page_load_details 04:36:54 INFO - PROCESS | 18891 | |i|pagename|runs| 04:36:54 INFO - PROCESS | 18891 | |0;ai-astar;111;114;113;114;112;113;114;113;113;111 04:36:54 INFO - PROCESS | 18891 | |1;audio-beat-detection;151;126;132;167;133;145;126;125;169;128 04:36:54 INFO - PROCESS | 18891 | |2;audio-dft;162;163;162;161;162;162;163;163;160;160 04:36:54 INFO - PROCESS | 18891 | |3;audio-fft;76;75;76;110;77;77;78;77;100;77 04:36:54 INFO - PROCESS | 18891 | |4;audio-oscillator;83;83;119;84;84;83;107;83;83;111 04:36:54 INFO - PROCESS | 18891 | |5;imaging-gaussian-blur;118;118;117;118;118;117;118;117;119;118 04:36:54 INFO - PROCESS | 18891 | |6;imaging-darkroom;147;148;147;147;147;148;148;148;147;147 04:36:54 INFO - PROCESS | 18891 | |7;imaging-desaturate;96;96;96;96;96;95;95;95;96;96 04:36:54 INFO - PROCESS | 18891 | |8;json-parse-financial;66;66;74;66;66;66;66;67;64;65 04:36:54 INFO - PROCESS | 18891 | |9;json-stringify-tinderbox;66;67;65;66;66;66;66;66;66;66 04:36:54 INFO - PROCESS | 18891 | |10;stanford-crypto-aes;90;84;84;83;83;84;83;83;90;83 04:36:54 INFO - PROCESS | 18891 | |11;stanford-crypto-ccm;141;138;140;149;138;139;138;139;191;137 04:36:54 INFO - PROCESS | 18891 | |12;stanford-crypto-pbkdf2;181;179;179;181;177;174;174;178;172;173 04:36:54 INFO - PROCESS | 18891 | |13;stanford-crypto-sha256-iterative;71;70;70;69;69;70;69;69;68;69 04:36:54 INFO - PROCESS | 18891 | __end_tp_report 04:36:54 INFO - PROCESS | 18891 | __start_cc_report 04:36:54 INFO - PROCESS | 18891 | _x_x_mozilla_cycle_collect,1947 04:36:54 INFO - PROCESS | 18891 | __end_cc_report 04:36:54 INFO - PROCESS | 18891 | __startTimestamp1476445014100__endTimestamp 04:36:54 INFO - PROCESS | 18891 | 04:36:54 INFO - PROCESS | 18891 | ------- Summary: start ------- 04:36:54 INFO - PROCESS | 18891 | Number of tests: 14 04:36:54 INFO - PROCESS | 18891 | 04:36:54 INFO - PROCESS | 18891 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:1.14 (1.0%) stddev-sans-first:1.00 04:36:54 INFO - PROCESS | 18891 | Values: 111.0 114.0 113.0 114.0 112.0 113.0 114.0 113.0 113.0 111.0 04:36:54 INFO - PROCESS | 18891 | 04:36:54 INFO - PROCESS | 18891 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:139.00 stddev:16.96 (12.2%) stddev-sans-first:17.54 04:36:54 INFO - PROCESS | 18891 | Values: 151.0 126.0 132.0 167.0 133.0 145.0 126.0 125.0 169.0 128.0 04:36:54 INFO - PROCESS | 18891 | 04:36:54 INFO - PROCESS | 18891 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 04:36:54 INFO - PROCESS | 18891 | Values: 162.0 163.0 162.0 161.0 162.0 162.0 163.0 163.0 160.0 160.0 04:36:54 INFO - PROCESS | 18891 | 04:36:54 INFO - PROCESS | 18891 | [#3] audio-fft Cycles:10 Average:82.30 Median:77.00 stddev:12.22 (15.9%) stddev-sans-first:12.75 04:36:54 INFO - PROCESS | 18891 | Values: 76.0 75.0 76.0 110.0 77.0 77.0 78.0 77.0 100.0 77.0 04:36:54 INFO - PROCESS | 18891 | 04:36:54 INFO - PROCESS | 18891 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:83.00 stddev:14.33 (17.3%) stddev-sans-first:14.82 04:36:54 INFO - PROCESS | 18891 | Values: 83.0 83.0 119.0 84.0 84.0 83.0 107.0 83.0 83.0 111.0 04:36:54 INFO - PROCESS | 18891 | 04:36:54 INFO - PROCESS | 18891 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 04:36:54 INFO - PROCESS | 18891 | Values: 118.0 118.0 117.0 118.0 118.0 117.0 118.0 117.0 119.0 118.0 04:36:54 INFO - PROCESS | 18891 | 04:36:54 INFO - PROCESS | 18891 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:36:54 INFO - PROCESS | 18891 | Values: 147.0 148.0 147.0 147.0 147.0 148.0 148.0 148.0 147.0 147.0 04:36:54 INFO - PROCESS | 18891 | 04:36:54 INFO - PROCESS | 18891 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:36:54 INFO - PROCESS | 18891 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 04:36:54 INFO - PROCESS | 18891 | 04:36:54 INFO - PROCESS | 18891 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:66.00 stddev:2.72 (4.1%) stddev-sans-first:2.87 04:36:54 INFO - PROCESS | 18891 | Values: 66.0 66.0 74.0 66.0 66.0 66.0 66.0 67.0 64.0 65.0 04:36:54 INFO - PROCESS | 18891 | 04:36:54 INFO - PROCESS | 18891 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 04:36:54 INFO - PROCESS | 18891 | Values: 66.0 67.0 65.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 04:36:54 INFO - PROCESS | 18891 | 04:36:54 INFO - PROCESS | 18891 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:2.83 (3.4%) stddev-sans-first:2.26 04:36:54 INFO - PROCESS | 18891 | Values: 90.0 84.0 84.0 83.0 83.0 84.0 83.0 83.0 90.0 83.0 04:36:54 INFO - PROCESS | 18891 | 04:36:54 INFO - PROCESS | 18891 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:139.50 stddev:16.52 (11.8%) stddev-sans-first:17.46 04:36:54 INFO - PROCESS | 18891 | Values: 141.0 138.0 140.0 149.0 138.0 139.0 138.0 139.0 191.0 137.0 04:36:54 INFO - PROCESS | 18891 | 04:36:54 INFO - PROCESS | 18891 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:178.50 stddev:3.33 (1.9%) stddev-sans-first:3.16 04:36:54 INFO - PROCESS | 18891 | Values: 181.0 179.0 179.0 181.0 177.0 174.0 174.0 178.0 172.0 173.0 04:36:54 INFO - PROCESS | 18891 | 04:36:54 INFO - PROCESS | 18891 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:0.84 (1.2%) stddev-sans-first:0.67 04:36:54 INFO - PROCESS | 18891 | Values: 71.0 70.0 70.0 69.0 69.0 70.0 69.0 69.0 68.0 69.0 04:36:54 INFO - PROCESS | 18891 | -------- Summary: end -------- 04:36:54 INFO - PROCESS | 18891 | 04:36:55 INFO - TEST-INFO | 18891: exit 0 04:36:55 INFO - TEST-OK | kraken | took 64979ms 04:36:55 INFO - SUITE-END | took 1187s 04:36:55 INFO - Completed test suite (00:19:47) 04:36:55 INFO - javascript benchmark 04:36:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2527.570313046782, 2533.6199570064477, 2580.703219129801, 2593.144262393409, 2605.726398728135, 4452.732836029841, 4540.863774086774, 4624.098300831335, 4662.9533704662945, 4674.345591617176, 4587.724736515803, 4591.150637132133, 4596.563326483979, 4681.063787242548, 4731.57415832575, 4363.214621368153, 4386.495553011397, 4408.97795511022, 4413.801378937939, 4425.070735145623, 4309.892252693692, 4311.978440107795, 4336.48402623638, 4343.869683909472, 4411.911761764763, 4250.766207858566, 4345.239583072966, 4374.387585737999, 4393.692441529094, 4442.444694413199, 4149.958500414988, 4297.0, 4312.956870431287, 4317.69776115672, 4419.138268037734, 4163.958360416387, 4215.894602634928, 4219.367094935754, 4223.429836972031, 4226.281532139513, 4548.863534093983, 4575.725456472589, 4578.816847326103, 4628.398308219944, 4708.552687494683, 4859.343988561534, 4893.608511319086, 4913.508649135094, 4918.581920536759, 4974.204127339644, 4807.567318941312, 4872.293517439987, 4962.478939711351, 4962.503749625044, 4999.12515309823, 4579.404677391918, 4600.700954437951, 4629.3518907353, 4631.467381251132, 4638.350630911675, 5053.646244762905, 5063.1645778446145, 5072.137736584789, 5072.51811077947, 5121.0, 4614.400127983407, 4851.466338702739, 4857.271409288564, 4866.05112003156, 4917.0, 4779.856604301876, 4820.084184005028, 4880.267959805987, 4966.90066198674, 4971.825986090542, 4927.531884470969, 4929.507049295042, 4930.654854160246, 4975.527324904128, 4996.1007018736245, 4903.828366007173, 4910.582600479, 4911.803527858846, 4931.728754918442, 4984.601231901439, 4081.775502347399, 4109.753414795062, 4114.238865809775, 4159.1265834175165, 4207.158568286355, 3646.9817650911577, 3693.1321139532724, 3712.2575484903127, 3713.6472035156617, 3719.5536535615356, 4198.307279298881, 4204.936925946114, 4206.978965105216, 4214.873553793391, 4233.809478573472, 4972.129877271535, 5000.574951129195, 5003.399592048978, 5021.84934451967, 5052.72210028452, 4254.170436764863, 4259.531451540328, 4263.062126332202, 4312.245357062501, 4320.762358070274, 4281.293586558183, 4331.112122014979, 4496.4154659894, 4499.257622492318, 4499.865004049819, 4522.796474158605, 4567.725936443758, 4596.172688916027, 4613.1004454131125, 4678.719276843401, 4948.950510494849, 4955.5044495550155, 4956.033573453142, 4961.454240033521, 5026.572741317029, 4599.4020777300075, 4617.0, 4618.261078227468, 4620.907581848277, 4666.953330466652, 4620.5148459411275, 4717.929231061606, 4718.174319494144, 4788.61691064721, 4790.137775200497, 4835.95164048355, 4839.056384005085, 4847.757612119451, 4849.393825771778, 4851.514848515261, 4675.018246168343, 4735.431748190239, 4740.288956656529, 4740.549647783455, 4740.549647783455, 4746.145693775154, 4758.857234282977, 4759.143354196278, 4762.833300834454, 4767.4994125617695, 4651.046535460155, 4668.346431499524, 4679.789409476513, 4692.9530704692515, 4700.741459219639, 4809.470958194665, 4810.374651295309, 4810.759462026815, 4811.49479304682, 4812.8796780080775, 4730.597899178609, 4731.266653668687, 4735.715857048588, 4790.4251489821445, 4856.878578035577], "value": 4527.88586875662, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.2566874559953, 569.2457493820688, 573.2719446303198, 581.584167320366, 590.06474737541, 27700.307492312702, 30214.884958052946, 30230.244243893914, 30245.24386890329, 38211.617883821156, 35367.82316088416, 39372.40941385881, 39390.60609393905, 39429.60570394295, 39454.60545394545, 7618.047744031982, 7767.300942915136, 7769.494982826126, 7773.028371453568, 7774.144844067148, 7606.201348858373, 7685.8078548036465, 7688.038995125609, 7688.692452301929, 7689.077310722721, 7659.502132361406, 7685.269899359552, 7701.152873183945, 7704.306612404883, 7705.229477052306, 7660.119086305062, 7687.346575541086, 7692.576908270071, 7700.382919586894, 7707.96146019272, 7618.733344332922, 7680.423968202407, 7685.03937007874, 7686.269804368576, 7688.961555192244, 37422.06444838874, 37564.43653345175, 37645.81177094097, 37882.81058594689, 37977.81011094955, 2764.972350276512, 2784.2343355577377, 2844.33158207821, 2873.5976963225166, 2939.1770304314828, 27104.011247134906, 27536.17391478259, 27740.30649233765, 28340.0, 28779.424411511653, 3268.8365581721055, 3388.254583991518, 3394.066631676284, 3411.8805841795665, 3462.0998540379433, 237211.99999999828, 237220.0, 237576.0, 237710.0, 239307.0, 49875.25187122196, 50157.74921125371, 50218.246726299134, 50253.49746502561, 50261.74869125631, 31887.52168717471, 32863.0, 33302.50046249308, 34557.0, 52760.47239527632, 13949.790753138712, 14010.229437380838, 14011.43954241819, 14023.0, 14069.648258793612, 10861.1854110942, 10894.564217431214, 10923.945380273048, 10927.071198948019, 10929.453527323602, 17464.0, 17558.473245802645, 17592.648147037242, 17605.64788704219, 17611.38360157388, 6511.869762604816, 6646.700898459581, 6713.899291510631, 6732.831679208059, 6927.58434493932, 788.4599049651007, 890.7773056735816, 928.215657769184, 935.4761333653177, 970.5583959298502, 27329.180124595896, 27736.167914962585, 27906.16281511558, 27920.301992449946, 28153.0, 921.5898924978454, 930.3487558708931, 940.47333493244, 955.7945041816043, 1046.863907691995, 13973.860261397256, 14636.853631463762, 14659.706805863823, 14882.776758348633, 14934.253287335807, 356086.0, 356344.0, 359261.0, 362147.0, 363420.0, 48255.27617085746, 48712.0, 48730.75634621804, 48802.75598621984, 48897.75551122222, 1052.600011995437, 1100.9064229540418, 1139.2480962564669, 1157.745296034871, 1180.0795379603924, 25404.237872863843, 27616.309592260353, 28642.14073577796, 29072.854635727534, 29524.852375737984, 45787.54212457833, 46564.7671761639, 46674.76662616665, 46786.29820552762, 46954.29568556543, 334256.0, 335651.0, 336432.0, 336694.0, 336766.0, 29691.257718557208, 31159.0, 34466.82766586151, 36138.27723445464, 36733.04103945933, 38999.0, 39668.603313966494, 40494.1901161981, 40796.79601601973, 40990.180196396504, 33745.49381759325, 33898.83050584731, 34034.489482658275, 34119.317613647094, 34517.48223776595, 33384.49923251104, 33559.83220083884, 34138.65861341454, 34480.31039379248, 34975.82512087525, 33357.83321083379, 33946.49080263748, 34061.31877362389, 34243.14392140217, 34572.481412778325, 29820.0, 31357.21606959753, 31713.365732685677, 31773.523397149525, 31776.523352149274, 23805.523889522457, 24496.265112046665, 24517.264482065566, 24871.253862384157, 24883.62674559919], "value": 16979.6177613222, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.8385226648009, 363.4892975369605, 363.9708823294136, 379.99240015199695, 381.5478657790517, 16035.438759643415, 16726.916365418172, 16743.16284185792, 16979.999999999985, 17084.487465376027, 15567.688646227069, 15710.607234819136, 16163.272652730626, 16260.918695406506, 16313.084859633691, 4727.929081063796, 4974.900501989958, 4976.203807390818, 4976.651634385595, 4982.476839931809, 3575.2313252650674, 3791.791451470168, 4849.7817598207985, 5519.448055194469, 5900.0, 5877.118432235156, 5987.790427335044, 5989.88020239595, 5992.131140984555, 5993.220881285427, 5773.0, 5967.701614919259, 5994.1608174855555, 6002.249718785152, 6004.309504406961, 5102.6428150029515, 5288.048151332759, 5293.7617807198385, 5299.5760339172775, 5300.840974770725, 20565.58868822615, 21261.149554017822, 21300.25449109274, 21325.36023919285, 21354.57290854174, 1846.8799528030636, 1849.3342396737164, 1905.5426697592477, 1963.6072785442825, 2085.904899927535, 12728.427220775087, 13468.730625387438, 13595.932020339935, 13950.51173208943, 14090.788638170436, 1732.5495371203451, 1745.3629425259817, 1810.2125575374755, 1889.1121173048646, 1895.2703209264394, 80953.0, 81585.59207203986, 82540.58729706373, 83373.16626833714, 84250.57874710648, 16209.189540522926, 16301.91849040771, 16695.833041669426, 16705.83294167067, 16710.4151354702, 28527.857360713064, 28651.426971460452, 28689.13932582026, 28720.42559148847, 28794.28014299659, 8769.693060742844, 8914.598843052077, 9121.80736742135, 9205.723828285161, 9285.257179425766, 7459.881017847366, 7477.065366829146, 7597.734079307198, 7669.7315593953945, 7742.574158421228, 8063.919360806317, 8335.493131840683, 8463.788405289793, 8516.446430981967, 8544.719631071157, 2566.9871650641626, 3118.8908388206305, 3153.621565412165, 3254.6908043735807, 3504.3341765064556, 720.0, 806.395203597302, 833.2209384225769, 857.5155037403847, 895.7178488776015, 16251.918740406223, 16392.180390980404, 16982.0, 17028.404005859982, 17230.541689776408, 821.3839620284787, 830.8462934357163, 830.8866119399912, 844.2275318084007, 881.8456770065213, 9096.135867092615, 9546.474943878015, 9558.139767420966, 9640.373375730554, 9677.225821934227, 362354.0, 363752.0, 390993.0, 401147.0, 402093.0, 39126.0, 39761.602383976366, 53265.73367133139, 78382.0, 79941.0, 886.4016788667624, 919.2140719684706, 945.2910317262053, 945.976350591227, 946.6639343033262, 15612.531624051297, 15732.528024158835, 16307.347706091623, 16390.836091638932, 16616.086115263293, 38399.616003839605, 39526.12223687805, 39614.0, 40027.3995890056, 40634.1873162541, 47744.7612761934, 50919.745401272754, 50955.2356714657, 51280.23079653733, 52057.7397113012, 7321.297051973501, 7404.444666649915, 7486.139094004041, 7662.885056724042, 7725.227477252454, 6383.0744542042075, 7158.943459261237, 8703.738887833375, 9683.903160968583, 11590.652280431601, 10175.949120254352, 10272.178225742073, 10412.947935260276, 10503.159747220358, 10716.249862509549, 10252.23108266868, 10286.845697314697, 10307.278490505892, 10324.535395907053, 10414.375137491776, 10164.542595583365, 10214.0, 10501.842472363074, 10658.0, 11031.889681103086, 7455.776326710207, 7557.5465472071855, 7645.273698998586, 7891.131975482807, 8014.078380986261, 9722.75693107678, 9875.308728388944, 10236.744081398025, 10274.845877311996, 10619.15046796239], "value": 8865.50514443618, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.3681432912206, 1364.6179069860439, 1383.7163381506787, 1626.625876048508, 1636.4027130097518, 6436.903446448296, 6670.0661907333015, 7377.4466914981385, 7983.481073730203, 7987.161348058457, 7400.370968467687, 7669.271419215165, 7669.731559395423, 7838.05943286805, 7850.725224617139, 2092.6442504774186, 2110.3141479019305, 2125.9893700531475, 2132.1897678882, 2140.411386868608, 1744.9302027918868, 1802.7025540785755, 2086.447091520748, 2089.268755935426, 2132.7120838686733, 2139.8288136949086, 2166.869987800729, 2173.119886445992, 2183.5196256823474, 2189.321310393775, 2094.5077906691913, 2108.3976178104676, 2123.288698286076, 2127.361791462555, 2127.7446706395253, 2054.075665950328, 2065.8760474371584, 2066.121898193277, 2068.834493240537, 2077.0, 7831.6475758591005, 7985.800354991114, 7987.281144696947, 7991.960040199761, 7994.440389172761, 4424.070945101533, 4574.977125114353, 4595.540445955411, 4605.263157894754, 4608.4700259470255, 2646.431017331283, 2713.036871910463, 2740.397112635217, 2778.097118436516, 2790.4558611070847, 902.1474706402453, 912.4798864647154, 913.945163290198, 922.5064590444081, 928.9628414863397, 10545.314554554006, 10581.0, 10592.311499752568, 10612.257142000062, 10612.363258204456, 3887.727859049896, 4119.958800412018, 4235.682323825664, 4240.533541310453, 4248.1078973415315, 9083.318751093562, 9094.681686141086, 9114.179723824887, 9119.635214591475, 9133.634654613874, 4533.478649955231, 4537.410136682211, 4541.977290113528, 4546.590806827401, 4578.473475550354, 4018.4374187613757, 4124.8143833527565, 4137.731047481904, 4149.564295748964, 4151.27352713274, 3509.842057107436, 3633.909152271214, 3704.7777133372083, 3711.2206436648607, 3727.4781530585738, 1022.6727447216967, 1072.4101744040747, 1169.7192673758407, 1177.4230626992712, 1196.132803717298, 601.3145014683265, 673.6362364323309, 778.4200770426069, 805.287320721166, 813.2518083363202, 4636.79134438951, 4762.3808904842845, 4824.951750482521, 4855.684380515255, 4857.417109946829, 847.872819077131, 848.8498085094608, 851.4848516647463, 882.0870399136862, 884.1777147252988, 3185.681431856796, 3363.058343663778, 3423.0659677282256, 3522.242717815631, 3609.826806287967, 9254.814903702023, 9751.317407781387, 9836.213102951746, 9842.212622990144, 9845.704628861145, 9667.468289244018, 9671.564779584936, 9673.322867399354, 9679.225661947028, 9689.612415503301, 6883.27725588816, 7163.3552980232025, 7221.747238846615, 7223.7471688491705, 7226.494145409771, 4951.480094590016, 4976.776045077908, 4988.102141614399, 5025.899482010266, 5098.439171691037, 8370.832583348178, 8658.740237792876, 8738.650453982023, 8744.125587441205, 8827.955860220658, 8864.024957254567, 8938.776530586527, 8956.641734330815, 9025.323100767337, 9099.863502047343, 6328.208973878265, 6492.837679058061, 6493.675316234264, 6497.415232629086, 6498.122753428227, 7021.192562855337, 7031.542949708252, 7108.0, 7110.1112360954885, 7134.714611415485, 5054.2671312660195, 6407.967960160356, 6487.870242595216, 6502.089707441057, 6649.401553860176, 6430.48556115519, 6457.67711614408, 6508.414242717989, 6595.4393876521035, 6611.0, 5733.741981610754, 5835.649861008353, 5836.015754643442, 5836.620619659709, 5847.298324201123, 4222.514410842792, 4223.5565265646665, 4293.592108749664, 4333.848315308949, 4430.2468580342065, 4143.482064741907, 4239.152169566038, 4309.2674245378985, 4359.084592235666, 4407.449068866392], "value": 4005.491809499445, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.5844920987592, 301.7812086237477, 303.14059640918, 307.49877699350054, 309.6253533224798, 4753.168195565775, 4778.187708089625, 4786.787626888342, 4794.089123066615, 4870.586000189988, 4691.411070531047, 4702.200625893598, 4703.7177769333775, 4715.2455607102875, 4718.174319494084, 3503.1592417819666, 3635.7273204509765, 3675.2649470105953, 3731.6828069614116, 3766.9623303766884, 3766.0, 3784.1674831537016, 3793.8103094845287, 3794.1842503861803, 3795.235215624734, 3737.289914916171, 3741.7567858089274, 3745.213505163919, 3748.344039793039, 3752.3620984432578, 3502.2820321833965, 3626.34725749365, 3630.7640003399692, 3736.8505259789576, 3750.7374483786148, 3299.868005279786, 3309.933801323984, 3317.104381816896, 3327.3345330933666, 3332.500124981272, 4638.628909687217, 4642.907141857144, 4646.814127434933, 4653.488116307203, 4656.883577910546, 4186.35111557709, 4267.039916018902, 4272.2950713132295, 4279.229738647043, 4288.69979101463, 4939.629527785431, 4981.708414129468, 4986.52628000343, 4990.451050384455, 4994.475580064077, 3620.8775279663387, 3626.184108575576, 3631.94552081719, 3634.4730014148063, 3637.927241455156, 5076.375559820822, 5204.115300398941, 5212.947870521284, 5215.765290561933, 5215.869603259911, 3658.926821463609, 3694.168812017275, 3705.444183372516, 3719.9442008369897, 3733.6266373362446, 3749.4375843623675, 3761.0033341164067, 3761.4202035145304, 3785.3186426443503, 3788.2234142001375, 4251.213525497793, 4264.850730224427, 4266.850660226877, 4270.893227669271, 4287.228298906227, 4698.7783176373705, 4952.158133117378, 4995.775190116454, 5015.548600625962, 5017.623678224148, 1259.5654499197763, 1263.6651287408845, 1270.4283072617359, 1272.1794442584667, 1277.757226127033, 798.8282519258387, 809.720646376999, 817.8977627796526, 819.1235378145446, 823.2341627209602, 4191.664666826647, 4256.638185754184, 4334.934975975363, 4366.563343665608, 4406.647468202536, 5128.769205385766, 5130.256112863613, 5146.228065790161, 5161.896762064737, 5162.92255616166, 4360.106178233455, 4362.672799540047, 4368.890777730582, 4400.867973960786, 4428.335749637516, 2606.7653911148086, 2698.7031426543062, 2714.891404343804, 2718.3418114949864, 2718.3611851215346, 4764.880877978009, 4772.067312738346, 4775.856724298276, 4790.329353890458, 4810.773252820578, 5238.92141617876, 5245.0558899398475, 5252.947470525322, 5273.736313184402, 5275.709835958983, 4535.142859998246, 4825.0, 4827.141550503082, 4841.733704646208, 4863.80544778212, 5122.8975420492125, 5135.486451354835, 5155.510226528474, 5162.6902385856965, 5194.948050519446, 4886.2746271932765, 5036.6726162799305, 5052.924206136838, 5062.164742817394, 5078.7206703631655, 4780.259059845729, 4804.06320767447, 4804.759762011955, 4812.965212479334, 4830.734309612864, 3620.3483372993114, 3641.490191373263, 3644.4351125575577, 3653.6981701527866, 3692.8707495237536, 5144.459831717616, 5162.122439185423, 5165.535101840853, 5165.793368265227, 5218.452062533531, 4820.927686084641, 4961.50384961501, 4969.900601988013, 4972.776225069808, 4992.675476094042, 4956.851294461172, 4966.553010229097, 4997.3253610762085, 5001.749912504433, 5002.849914502571, 4919.4834542373965, 4936.925946110883, 4942.703437793743, 4943.802247910044, 4961.660351705092, 4783.6412269079265, 4835.468098509091, 4919.729414882216, 5016.949830501794, 5018.598512118949, 4805.663603547718, 4930.5069493050405, 4937.728424936663, 4943.382077240345, 4950.183219768698], "value": 3763.7118499104868, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.8033688209127, 583.182439399845, 625.8372921908756, 700.8843540815766, 702.2861444589721, 12850.22898626083, 13400.731985360288, 13558.728825423486, 13985.720285594281, 13989.370478328474, 13843.723125537508, 13905.374258158381, 13947.790783138262, 13973.161610303388, 13988.720225595482, 610.8442347201458, 621.6114928169894, 732.6483288021752, 757.443279189795, 760.6348952502802, 734.6804140199031, 753.7022875964018, 763.606742527596, 764.6406189091147, 765.311219902087, 799.7041094794905, 801.2988634944423, 801.8757092650649, 802.1136644008375, 802.1897883138014, 630.9085182648536, 649.191756263455, 792.6353877216487, 792.6631181747734, 792.7463211772235, 481.1795888010933, 482.6356101143614, 483.87661146407794, 561.5507593924843, 576.8788554403538, 12524.937375313066, 12568.685782855411, 12573.685657858627, 12583.182093164007, 12596.307203103826, 11880.227785193934, 12206.450709717996, 12441.564545240873, 12501.93749031249, 12977.41601627929, 11741.767114452945, 11746.0, 11789.17475776696, 11832.0, 12517.499300027988, 3988.78061706606, 4034.8904051386103, 4199.202151591188, 4202.432671589327, 4208.705390622657, 61537.6923115386, 63132.68433657848, 63134.36865631331, 63294.0, 63777.0, 10139.188864890792, 10155.492225388849, 10409.323393979366, 10474.528646210938, 10660.62687805923, 17629.7355539667, 17690.5577360567, 17804.821951780574, 17941.0, 18069.54826129331, 6076.179715738407, 6153.938460615336, 6213.751449942042, 6240.563160578807, 6355.396237357444, 3473.94789078164, 3515.4199557073307, 3532.911677208039, 3558.6619271169197, 3609.205974685565, 2593.740625937391, 2635.222609330252, 2677.6786785585855, 2678.397360593851, 2684.8254863433813, 439.95820397062226, 440.13293811191903, 445.24753167148066, 486.7858142417325, 510.5481648740891, 491.16992283041543, 568.2555851834111, 580.4891695308186, 592.0202065581469, 598.2282855116938, 7021.613811240431, 7217.855642887218, 7624.771256862303, 7650.73222437212, 7851.568163751049, 471.5096299848188, 522.4435975685882, 566.6260268222953, 593.1695626123461, 593.2495393327445, 3599.262151258986, 3666.5233519642275, 3786.3563194257044, 3789.1663833956486, 3817.3892177251505, 73218.6339068312, 76380.61809691027, 77168.61415692886, 86390.42641703067, 100805.0, 45261.54738452639, 45549.77225113853, 45943.31085033727, 46088.5391146091, 69152.6542367295, 42347.15305693869, 60266.39733602608, 66053.33946660568, 66597.66701166656, 66708.66645666838, 7467.887981680387, 7929.127795942326, 8000.319972802377, 8186.426950113435, 8228.21831925966, 41532.792336038125, 43725.562744372146, 43763.56236437722, 44247.0, 44876.326855097854, 34698.0, 34861.477077843345, 58591.70704146452, 59312.406875932415, 59431.702841485516, 9499.477528735986, 10086.6469673564, 10128.696139115838, 10132.746681333025, 10251.38491690501, 10847.0, 11106.0, 11338.09295256361, 11818.0, 11826.408679565815, 11201.439928003405, 11310.0, 11438.370889601152, 11851.0, 11966.102542309187, 10832.18758593093, 10974.341539507655, 11180.0, 11927.10546708983, 12303.446344914679, 10410.68767936963, 10483.274348669249, 10873.782524349626, 10876.619318323821, 10963.177761667748, 8362.498250105013, 8542.359323050672, 8721.65113395457, 8934.597943092447, 8956.265895377042, 8850.73447796567, 8951.955240223757, 9033.367664263438, 9153.679621213225, 9206.585703643486], "value": 6130.337908427135, "unit": "score"}], "name": "dromaeo_css", "value": 6307.964699426871, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 113.0, 114.0, 112.0, 113.0, 114.0, 113.0, 113.0, 111.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 132.0, 167.0, 133.0, 145.0, 126.0, 125.0, 169.0, 128.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 162.0, 162.0, 163.0, 163.0, 160.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 110.0, 77.0, 77.0, 78.0, 77.0, 100.0, 77.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 119.0, 84.0, 84.0, 83.0, 107.0, 83.0, 83.0, 111.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 119.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 148.0, 148.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 74.0, 66.0, 66.0, 66.0, 66.0, 67.0, 64.0, 65.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 84.0, 84.0, 83.0, 83.0, 84.0, 83.0, 83.0, 90.0, 83.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 138.0, 140.0, 149.0, 138.0, 139.0, 138.0, 139.0, 191.0, 137.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 179.0, 179.0, 181.0, 177.0, 174.0, 174.0, 178.0, 172.0, 173.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 69.0, 69.0, 70.0, 69.0, 69.0, 68.0, 69.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1558.5, "alertThreshold": 2.0}]} 04:36:55 INFO - Return code: 0 04:36:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:36:55 INFO - # TBPL SUCCESS # 04:36:55 INFO - Running post-action listener: _resource_record_post_action 04:36:55 INFO - [mozharness: 2016-10-14 11:36:55.916978Z] Finished run-tests step (success) 04:36:55 INFO - Running post-run listener: _resource_record_post_run 04:36:55 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392404992; Read time: 4; Write time: 286644 04:36:55 INFO - TinderboxPrint: CPU usage
13.0% 04:36:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 04:36:55 INFO - TinderboxPrint: I/O write bytes / time
392,404,992 / 286,644 04:36:55 INFO - TinderboxPrint: CPU idle
8,362.0 (87.0%) 04:36:55 INFO - TinderboxPrint: CPU user
1,202.0 (12.5%) 04:36:55 INFO - TinderboxPrint: Swap in / out
0 / 0 04:36:55 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 100294656; Read time: 0; Write time: 68528 04:36:56 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 292110336; Read time: 0; Write time: 218116 04:36:56 INFO - Running post-run listener: _upload_blobber_files 04:36:56 INFO - Blob upload gear active. 04:36:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:36:56 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 04:36:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:36:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:36:56 INFO - (blobuploader) - INFO - Open directory for files ... 04:36:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:36:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:36:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:36:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:36:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:36:58 INFO - (blobuploader) - INFO - Done attempting. 04:36:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:36:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:36:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:37:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:01 INFO - (blobuploader) - INFO - Done attempting. 04:37:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:37:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:37:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:02 INFO - (blobuploader) - INFO - Done attempting. 04:37:02 INFO - (blobuploader) - INFO - Iteration through files over. 04:37:02 INFO - Return code: 0 04:37:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:37:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:37:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/143f26449a051f8eca48335d5277ef512b5d8c9993b67756631ffc9afde4cd585cbb6da2ff3ec5ea34ad7534cf333d564b0f9af4221903f71238abebd54ffba2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/329888d81010609e12a9149be0f7c1c881df3e6702a7ad0c901a471b09a8e662cdd9ea0239d925e44d64df90328d26739a2774eac4f24075b8f3f663b4b399f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/edf9dec074edae39d731b35f8de6d8cadd1a1832e54af65c9a5e42d229604a3918e3bddc64f2e6c315f3ef71137e6e96bb2d5c7fff7e3e59b9760e52677781b9"} 04:37:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:37:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:37:02 INFO - Contents: 04:37:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/143f26449a051f8eca48335d5277ef512b5d8c9993b67756631ffc9afde4cd585cbb6da2ff3ec5ea34ad7534cf333d564b0f9af4221903f71238abebd54ffba2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/329888d81010609e12a9149be0f7c1c881df3e6702a7ad0c901a471b09a8e662cdd9ea0239d925e44d64df90328d26739a2774eac4f24075b8f3f663b4b399f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/edf9dec074edae39d731b35f8de6d8cadd1a1832e54af65c9a5e42d229604a3918e3bddc64f2e6c315f3ef71137e6e96bb2d5c7fff7e3e59b9760e52677781b9"} 04:37:02 INFO - Running post-run listener: copy_logs_to_upload_dir 04:37:02 INFO - Copying logs to upload dir... 04:37:02 INFO - mkdir: /builds/slave/test/build/upload/logs 04:37:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.794787 ========= master_lag: 0.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-14 04:37:02.192184) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 04:37:02.196130) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/143f26449a051f8eca48335d5277ef512b5d8c9993b67756631ffc9afde4cd585cbb6da2ff3ec5ea34ad7534cf333d564b0f9af4221903f71238abebd54ffba2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/329888d81010609e12a9149be0f7c1c881df3e6702a7ad0c901a471b09a8e662cdd9ea0239d925e44d64df90328d26739a2774eac4f24075b8f3f663b4b399f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/edf9dec074edae39d731b35f8de6d8cadd1a1832e54af65c9a5e42d229604a3918e3bddc64f2e6c315f3ef71137e6e96bb2d5c7fff7e3e59b9760e52677781b9"} build_url:https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/fKeKxaJ3QsuMoxJ6S39Dtg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/143f26449a051f8eca48335d5277ef512b5d8c9993b67756631ffc9afde4cd585cbb6da2ff3ec5ea34ad7534cf333d564b0f9af4221903f71238abebd54ffba2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/329888d81010609e12a9149be0f7c1c881df3e6702a7ad0c901a471b09a8e662cdd9ea0239d925e44d64df90328d26739a2774eac4f24075b8f3f663b4b399f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/edf9dec074edae39d731b35f8de6d8cadd1a1832e54af65c9a5e42d229604a3918e3bddc64f2e6c315f3ef71137e6e96bb2d5c7fff7e3e59b9760e52677781b9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 04:37:02.228821) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:37:02.229205) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1476443772.785316-663473099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:37:02.278666) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 04:37:02.282062) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 04:37:02.282390) ========= ========= Total master_lag: 0.45 =========