builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1476907350.77 results: success (0) buildid: 20161019123949 builduid: a2d09a0e8a404780ae39abb6613bfc8b revision: 9f7b448a6b5ce5dfcffbcde6eed50052f3105a26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 13:02:30.770267) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 13:02:30.770725) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 13:02:30.770996) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 13:02:30.785607) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 13:02:30.785919) ========= 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=920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-19 13:02:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-10-19 13:02:31 (113 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.203669 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 13:02:31.004349) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 13:02:31.004672) ========= 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=920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018673 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 13:02:31.054625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 13:02:31.054981) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9f7b448a6b5ce5dfcffbcde6eed50052f3105a26 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 9f7b448a6b5ce5dfcffbcde6eed50052f3105a26 --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=920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-19 13:02:31,502 truncating revision to first 12 chars 2016-10-19 13:02:31,502 Setting DEBUG logging. 2016-10-19 13:02:31,502 attempt 1/10 2016-10-19 13:02:31,502 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9f7b448a6b5c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 13:02:31,817 unpacking tar archive at: fx-team-9f7b448a6b5c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.687888 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 13:02:31.756265) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 13:02:31.756594) ========= script_repo_revision: 9f7b448a6b5ce5dfcffbcde6eed50052f3105a26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 13:02:31.756999) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 13:02:31.757261) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 13:02:31.765829) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-19 13:02:31.766136) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:02:32 INFO - MultiFileLogger online at 20161019 13:02:32 in /builds/slave/test 13:02:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:02:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:02:32 INFO - {'append_to_log': False, 13:02:32 INFO - 'base_work_dir': '/builds/slave/test', 13:02:32 INFO - 'blob_upload_branch': 'Fx-Team', 13:02:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:02:32 INFO - 'branch': 'Fx-Team', 13:02:32 INFO - 'buildbot_json_path': 'buildprops.json', 13:02:32 INFO - 'config_files': ('talos/linux_config.py',), 13:02:32 INFO - 'default_actions': ('clobber', 13:02:32 INFO - 'read-buildbot-config', 13:02:32 INFO - 'download-and-extract', 13:02:32 INFO - 'populate-webroot', 13:02:32 INFO - 'create-virtualenv', 13:02:32 INFO - 'install', 13:02:32 INFO - 'run-tests'), 13:02:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:02:32 INFO - 'download_minidump_stackwalk': True, 13:02:32 INFO - 'download_symbols': 'ondemand', 13:02:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:02:32 INFO - 'tooltool.py': '/tools/tooltool.py', 13:02:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:02:32 INFO - '/tools/misc-python/virtualenv.py')}, 13:02:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:02:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:02:32 INFO - 'installer_path': 'installer.exe', 13:02:32 INFO - 'log_level': 'info', 13:02:32 INFO - 'log_name': 'talos', 13:02:32 INFO - 'log_to_console': True, 13:02:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:02:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:02:32 INFO - 'opt_config_files': (), 13:02:32 INFO - 'pip_index': False, 13:02:32 INFO - 'sps_profile': False, 13:02:32 INFO - 'sps_profile_interval': 0, 13:02:32 INFO - 'suite': 'dromaeojs', 13:02:32 INFO - 'system_bits': '32', 13:02:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:02:32 INFO - 'title': 'talos-linux64-ix-053', 13:02:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:02:32 INFO - 'use_talos_json': True, 13:02:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:02:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:02:32 INFO - 'work_dir': 'build'} 13:02:32 INFO - [mozharness: 2016-10-19 20:02:32.310592Z] Running clobber step. 13:02:32 INFO - Running pre-action listener: _resource_record_pre_action 13:02:32 INFO - Running main action method: clobber 13:02:32 INFO - rmtree: /builds/slave/test/build 13:02:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:02:33 INFO - Running post-action listener: _resource_record_post_action 13:02:33 INFO - [mozharness: 2016-10-19 20:02:33.289954Z] Finished clobber step (success) 13:02:33 INFO - [mozharness: 2016-10-19 20:02:33.290060Z] Running read-buildbot-config step. 13:02:33 INFO - Running pre-action listener: _resource_record_pre_action 13:02:33 INFO - Running main action method: read_buildbot_config 13:02:33 INFO - Using buildbot properties: 13:02:33 INFO - { 13:02:33 INFO - "project": "", 13:02:33 INFO - "product": "firefox", 13:02:33 INFO - "script_repo_revision": "production", 13:02:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:02:33 INFO - "repository": "", 13:02:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:02:33 INFO - "buildid": "20161019123949", 13:02:33 INFO - "stage_platform": "linux64-pgo", 13:02:33 INFO - "basedir": "/builds/slave/test", 13:02:33 INFO - "buildnumber": 1645, 13:02:33 INFO - "platform": "ubuntu64_hw", 13:02:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:02:33 INFO - "slavebuilddir": "test", 13:02:33 INFO - "branch": "fx-team", 13:02:33 INFO - "revision": "9f7b448a6b5ce5dfcffbcde6eed50052f3105a26", 13:02:33 INFO - "slavename": "talos-linux64-ix-053", 13:02:33 INFO - "builduid": "a2d09a0e8a404780ae39abb6613bfc8b", 13:02:33 INFO - "repo_path": "integration/fx-team" 13:02:33 INFO - } 13:02:33 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 13:02:33 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 13:02:33 INFO - Running post-action listener: _resource_record_post_action 13:02:33 INFO - [mozharness: 2016-10-19 20:02:33.292429Z] Finished read-buildbot-config step (success) 13:02:33 INFO - [mozharness: 2016-10-19 20:02:33.292517Z] Running download-and-extract step. 13:02:33 INFO - Running pre-action listener: _resource_record_pre_action 13:02:33 INFO - Running main action method: download_and_extract 13:02:33 INFO - mkdir: /builds/slave/test/build/tests 13:02:33 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')]} 13:02:33 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:02:33 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/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 13:02:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/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 13:02:33 INFO - Downloaded 1361 bytes. 13:02:33 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:02:33 INFO - Using the following test package requirements: 13:02:33 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:02:33 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:02:33 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:02:33 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:33 INFO - u'jsshell-linux-x86_64.zip'], 13:02:33 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:02:33 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:02:33 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:02:33 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:02:33 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:02:33 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:02:33 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:02:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:02:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:02:33 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:02:33 INFO - Http code: 200 13:02:33 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 13:02:33 INFO - x-amz-cf-id: aw_FI16DwwJVeM-SPcnzg-p_J93yxFsPbk2Kfhz-4bYBJxZB21jGqg== 13:02:33 INFO - x-amz-replication-status: COMPLETED 13:02:33 INFO - x-amz-version-id: NHxRPPjkwzPvIjPqYgpZs5Oa_V14_qym 13:02:33 INFO - Expected file size: 22111179 13:02:33 INFO - Obtained file size: 22111179 13:02:37 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 13:02:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:02:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:02:37 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:02:37 INFO - Http code: 200 13:02:37 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 13:02:37 INFO - x-amz-cf-id: -zRCEo2uxEVqh5d4E3-cwcSn5Qlp5DoMbKHKpZSJOuN_IXWB6wRB2A== 13:02:37 INFO - x-amz-replication-status: COMPLETED 13:02:37 INFO - x-amz-version-id: NHxRPPjkwzPvIjPqYgpZs5Oa_V14_qym 13:02:38 INFO - Expected file size: 22111179 13:02:38 INFO - Obtained file size: 22111179 13:02:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 13:02:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:02:42 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:02:42 INFO - Http code: 200 13:02:42 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 13:02:42 INFO - x-amz-cf-id: CV3pnZVpVOzakSjFTzb-dwi-EqzckGtJ1bgld4xKk1PaWTgKAH1OrQ== 13:02:42 INFO - x-amz-replication-status: COMPLETED 13:02:42 INFO - x-amz-version-id: 6Nm.f4DW6OhyyFKlKhxgVXw7EC94wpNK 13:02:42 INFO - Expected file size: 14409028 13:02:42 INFO - Obtained file size: 14409028 13:02: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')]} 13:02:43 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:02:43 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/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 13:02:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/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 13:02:43 INFO - Downloaded 59471621 bytes. 13:02:43 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:02:43 INFO - mkdir: /builds/slave/test/properties 13:02:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:02:43 INFO - Writing to file /builds/slave/test/properties/build_url 13:02:43 INFO - Contents: 13:02:43 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:02:44 INFO - Running post-action listener: _resource_record_post_action 13:02:44 INFO - Running post-action listener: set_extra_try_arguments 13:02:44 INFO - [mozharness: 2016-10-19 20:02:44.052628Z] Finished download-and-extract step (success) 13:02:44 INFO - [mozharness: 2016-10-19 20:02:44.052853Z] Running populate-webroot step. 13:02:44 INFO - Running pre-action listener: _resource_record_pre_action 13:02:44 INFO - Running main action method: populate_webroot 13:02:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:02:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:02:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:02:44 INFO - '--tppagecycles', 13:02:44 INFO - '7'], 13:02:44 INFO - 'tests': ['tsvgm']}}, 13:02:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:02:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:02:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:02:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:02:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:02:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:02:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:44 INFO - 'talos_options': ['--disable-e10s'], 13:02:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:02:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:02:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:44 INFO - 'talos_options': ['--disable-e10s'], 13:02:44 INFO - 'tests': ['damp', 'tps']}, 13:02:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:44 INFO - 'tests': ['damp', 'tps']}, 13:02:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:02:44 INFO - 'tests': ['dromaeo_dom']}, 13:02:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:02:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:02:44 INFO - 'tests': ['basic_compositor_video']}, 13:02:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:02:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:02:44 INFO - 'tests': ['a11yr', 13:02:44 INFO - 'ts_paint', 13:02:44 INFO - 'tpaint', 13:02:44 INFO - 'sessionrestore', 13:02:44 INFO - 'sessionrestore_no_auto_restore', 13:02:44 INFO - 'tabpaint']}, 13:02:44 INFO - 'other-e10s': {'tests': ['a11yr', 13:02:44 INFO - 'ts_paint', 13:02:44 INFO - 'tpaint', 13:02:44 INFO - 'sessionrestore', 13:02:44 INFO - 'sessionrestore_no_auto_restore', 13:02:44 INFO - 'tabpaint']}, 13:02:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:02:44 INFO - 'ts_paint', 13:02:44 INFO - 'tpaint', 13:02:44 INFO - 'sessionrestore', 13:02:44 INFO - 'sessionrestore_no_auto_restore', 13:02:44 INFO - 'tabpaint']}, 13:02:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:02:44 INFO - 'ts_paint', 13:02:44 INFO - 'tpaint', 13:02:44 INFO - 'sessionrestore', 13:02:44 INFO - 'sessionrestore_no_auto_restore', 13:02:44 INFO - 'tabpaint']}, 13:02:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:02:44 INFO - 'tests': ['a11yr', 13:02:44 INFO - 'ts_paint', 13:02:44 INFO - 'tpaint', 13:02:44 INFO - 'sessionrestore', 13:02:44 INFO - 'sessionrestore_no_auto_restore', 13:02:44 INFO - 'tabpaint']}, 13:02:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:02:44 INFO - 'tests': ['a11yr', 13:02:44 INFO - 'ts_paint', 13:02:44 INFO - 'tpaint', 13:02:44 INFO - 'sessionrestore', 13:02:44 INFO - 'sessionrestore_no_auto_restore', 13:02:44 INFO - 'tabpaint']}, 13:02:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:02:44 INFO - 'tests': ['tsvgx', 13:02:44 INFO - 'tsvgr_opacity', 13:02:44 INFO - 'tart', 13:02:44 INFO - 'tscrollx', 13:02:44 INFO - 'cart']}, 13:02:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:02:44 INFO - 'tsvgr_opacity', 13:02:44 INFO - 'tart', 13:02:44 INFO - 'tscrollx', 13:02:44 INFO - 'cart']}, 13:02:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:44 INFO - 'talos_options': ['--disable-e10s'], 13:02:44 INFO - 'tests': ['tp5o']}, 13:02:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:44 INFO - 'tests': ['tp5o']}, 13:02:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:44 INFO - 'talos_options': ['--disable-e10s', 13:02:44 INFO - '--xperf_path', 13:02:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:02:44 INFO - 'tests': ['tp5n']}, 13:02:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:44 INFO - 'talos_options': ['--xperf_path', 13:02:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:02:44 INFO - 'tests': ['tp5n']}}, 13:02:44 INFO - 'talos.zip': {'path': '', 13:02:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:02:44 INFO - Running post-action listener: _resource_record_post_action 13:02:44 INFO - [mozharness: 2016-10-19 20:02:44.074601Z] Finished populate-webroot step (success) 13:02:44 INFO - [mozharness: 2016-10-19 20:02:44.074689Z] Running create-virtualenv step. 13:02:44 INFO - Running pre-action listener: _resource_record_pre_action 13:02:44 INFO - Running main action method: create_virtualenv 13:02:44 INFO - Creating virtualenv /builds/slave/test/build/venv 13:02:44 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 13:02:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:02:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:02:44 INFO - Using real prefix '/usr' 13:02:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:02:44 INFO - Installing distribute.............................................................................................................................................................................................done. 13:02:46 INFO - Installing pip.................done. 13:02:46 INFO - Return code: 0 13:02:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:02:46 INFO - Reading from file tmpfile_stdout 13:02:46 INFO - Output received: 13:02:46 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) 13:02:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:02: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')]} 13:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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')]} 13:02:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:46 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 0x7f014e7fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e89790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86930>, '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 0x1e87830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e87cc0>, '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': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', '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 13:02:46 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 13:02:46 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 13:02:46 INFO - Using env: {'DISPLAY': ':0', 13:02:46 INFO - 'HOME': '/home/cltbld', 13:02:46 INFO - 'LANG': 'en_US.UTF-8', 13:02:46 INFO - 'LANGUAGE': 'en_US:en', 13:02:46 INFO - 'LOGNAME': 'cltbld', 13:02:46 INFO - 'MAIL': '/var/mail/cltbld', 13:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:46 INFO - 'MOZ_NO_REMOTE': '1', 13:02:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:46 INFO - 'NO_EM_RESTART': '1', 13:02:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:46 INFO - 'PWD': '/builds/slave/test', 13:02:46 INFO - 'SHELL': '/bin/bash', 13:02:46 INFO - 'SHLVL': '1', 13:02:46 INFO - 'TERM': 'linux', 13:02:46 INFO - 'TMOUT': '86400', 13:02:46 INFO - 'USER': 'cltbld', 13:02:46 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', 13:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:46 INFO - '_': '/tools/buildbot/bin/python'} 13:02:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:47 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 13:02:47 INFO - Cleaning up... 13:02:47 INFO - Return code: 0 13:02:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:02:47 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')]} 13:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:47 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')]} 13:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:47 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 0x7f014e7fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e89790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86930>, '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 0x1e87830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e87cc0>, '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': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', '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 13:02:47 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 13:02:47 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 13:02:47 INFO - Using env: {'DISPLAY': ':0', 13:02:47 INFO - 'HOME': '/home/cltbld', 13:02:47 INFO - 'LANG': 'en_US.UTF-8', 13:02:47 INFO - 'LANGUAGE': 'en_US:en', 13:02:47 INFO - 'LOGNAME': 'cltbld', 13:02:47 INFO - 'MAIL': '/var/mail/cltbld', 13:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:47 INFO - 'MOZ_NO_REMOTE': '1', 13:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:47 INFO - 'NO_EM_RESTART': '1', 13:02:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:47 INFO - 'PWD': '/builds/slave/test', 13:02:47 INFO - 'SHELL': '/bin/bash', 13:02:47 INFO - 'SHLVL': '1', 13:02:47 INFO - 'TERM': 'linux', 13:02:47 INFO - 'TMOUT': '86400', 13:02:47 INFO - 'USER': 'cltbld', 13:02:47 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', 13:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:47 INFO - '_': '/tools/buildbot/bin/python'} 13:02:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:47 INFO - Downloading/unpacking psutil>=3.1.1 13:02: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 13:02: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 13:02: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 13:02: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 13:02: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 13:02: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 13:02:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:02:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:02:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:02:49 INFO - Installing collected packages: psutil 13:02:49 INFO - Running setup.py install for psutil 13:02:49 INFO - building 'psutil._psutil_linux' extension 13:02:49 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 13:02:49 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 13:02:49 INFO - building 'psutil._psutil_posix' extension 13:02:49 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 13:02:49 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 13:02:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:02:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:02:49 INFO - Successfully installed psutil 13:02:49 INFO - Cleaning up... 13:02:49 INFO - Return code: 0 13:02:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:49 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 0x7f014e7fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e89790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86930>, '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 0x1e87830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e87cc0>, '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': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', '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 13:02:49 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 13:02:49 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 13:02:49 INFO - Using env: {'DISPLAY': ':0', 13:02:49 INFO - 'HOME': '/home/cltbld', 13:02:49 INFO - 'LANG': 'en_US.UTF-8', 13:02:49 INFO - 'LANGUAGE': 'en_US:en', 13:02:49 INFO - 'LOGNAME': 'cltbld', 13:02:49 INFO - 'MAIL': '/var/mail/cltbld', 13:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:49 INFO - 'MOZ_NO_REMOTE': '1', 13:02:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:49 INFO - 'NO_EM_RESTART': '1', 13:02:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:49 INFO - 'PWD': '/builds/slave/test', 13:02:49 INFO - 'SHELL': '/bin/bash', 13:02:49 INFO - 'SHLVL': '1', 13:02:49 INFO - 'TERM': 'linux', 13:02:49 INFO - 'TMOUT': '86400', 13:02:49 INFO - 'USER': 'cltbld', 13:02:49 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', 13:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:49 INFO - '_': '/tools/buildbot/bin/python'} 13:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:02:50 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 13:02:50 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 13:02:50 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 13:02:50 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 13:02:50 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 13:02:50 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 13:02:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:02:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:02:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:02:52 INFO - Installing collected packages: mozsystemmonitor 13:02:52 INFO - Running setup.py install for mozsystemmonitor 13:02:52 INFO - Successfully installed mozsystemmonitor 13:02:52 INFO - Cleaning up... 13:02:52 INFO - Return code: 0 13:02:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:02:52 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')]} 13:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:52 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')]} 13:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:52 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 0x7f014e7fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e89790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86930>, '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 0x1e87830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e87cc0>, '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': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', '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 13:02:52 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 13:02:52 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 13:02:52 INFO - Using env: {'DISPLAY': ':0', 13:02:52 INFO - 'HOME': '/home/cltbld', 13:02:52 INFO - 'LANG': 'en_US.UTF-8', 13:02:52 INFO - 'LANGUAGE': 'en_US:en', 13:02:52 INFO - 'LOGNAME': 'cltbld', 13:02:52 INFO - 'MAIL': '/var/mail/cltbld', 13:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:52 INFO - 'MOZ_NO_REMOTE': '1', 13:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:52 INFO - 'NO_EM_RESTART': '1', 13:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:52 INFO - 'PWD': '/builds/slave/test', 13:02:52 INFO - 'SHELL': '/bin/bash', 13:02:52 INFO - 'SHLVL': '1', 13:02:52 INFO - 'TERM': 'linux', 13:02:52 INFO - 'TMOUT': '86400', 13:02:52 INFO - 'USER': 'cltbld', 13:02:52 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', 13:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:52 INFO - '_': '/tools/buildbot/bin/python'} 13:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:52 INFO - Downloading/unpacking jsonschema==2.5.1 13:02:52 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 13:02:52 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 13:02:52 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 13:02:52 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 13:02:52 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 13:02:52 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 13:02:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:02:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:02:54 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 13:02:54 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 13:02:54 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 13:02:54 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 13:02:54 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 13:02:54 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 13:02:54 INFO - Downloading functools32-3.2.3-2.tar.gz 13:02:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:02:54 INFO - warning: no files found matching '*.txt' 13:02:54 INFO - no previously-included directories found matching 'build' 13:02:54 INFO - no previously-included directories found matching 'dist' 13:02:54 INFO - no previously-included directories found matching '.git*' 13:02:54 INFO - Installing collected packages: jsonschema, functools32 13:02:54 INFO - Running setup.py install for functools32 13:02:54 INFO - warning: no files found matching '*.txt' 13:02:54 INFO - no previously-included directories found matching 'build' 13:02:54 INFO - no previously-included directories found matching 'dist' 13:02:54 INFO - no previously-included directories found matching '.git*' 13:02:54 INFO - Successfully installed jsonschema functools32 13:02:54 INFO - Cleaning up... 13:02:54 INFO - Return code: 0 13:02:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:02:54 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')]} 13:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:54 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')]} 13:02:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:54 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 0x7f014e7fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e89790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86930>, '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 0x1e87830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e87cc0>, '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': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', '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 13:02:54 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 13:02:54 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 13:02:54 INFO - Using env: {'DISPLAY': ':0', 13:02:54 INFO - 'HOME': '/home/cltbld', 13:02:54 INFO - 'LANG': 'en_US.UTF-8', 13:02:54 INFO - 'LANGUAGE': 'en_US:en', 13:02:54 INFO - 'LOGNAME': 'cltbld', 13:02:54 INFO - 'MAIL': '/var/mail/cltbld', 13:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:54 INFO - 'MOZ_NO_REMOTE': '1', 13:02:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:54 INFO - 'NO_EM_RESTART': '1', 13:02:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:54 INFO - 'PWD': '/builds/slave/test', 13:02:54 INFO - 'SHELL': '/bin/bash', 13:02:54 INFO - 'SHLVL': '1', 13:02:54 INFO - 'TERM': 'linux', 13:02:54 INFO - 'TMOUT': '86400', 13:02:54 INFO - 'USER': 'cltbld', 13:02:54 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', 13:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:54 INFO - '_': '/tools/buildbot/bin/python'} 13:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:02:55 INFO - Cleaning up... 13:02:55 INFO - Return code: 0 13:02:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f014e7fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e89790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86930>, '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 0x1e87830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e87cc0>, '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': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', '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 13:02:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:02:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:02:55 INFO - Using env: {'DISPLAY': ':0', 13:02:55 INFO - 'HOME': '/home/cltbld', 13:02:55 INFO - 'LANG': 'en_US.UTF-8', 13:02:55 INFO - 'LANGUAGE': 'en_US:en', 13:02:55 INFO - 'LOGNAME': 'cltbld', 13:02:55 INFO - 'MAIL': '/var/mail/cltbld', 13:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:55 INFO - 'MOZ_NO_REMOTE': '1', 13:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:55 INFO - 'NO_EM_RESTART': '1', 13:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:55 INFO - 'PWD': '/builds/slave/test', 13:02:55 INFO - 'SHELL': '/bin/bash', 13:02:55 INFO - 'SHLVL': '1', 13:02:55 INFO - 'TERM': 'linux', 13:02:55 INFO - 'TMOUT': '86400', 13:02:55 INFO - 'USER': 'cltbld', 13:02:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', 13:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:55 INFO - '_': '/tools/buildbot/bin/python'} 13:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:55 INFO - Downloading/unpacking blobuploader==1.2.4 13:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:57 INFO - Downloading blobuploader-1.2.4.tar.gz 13:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:02:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:02:57 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 13:02:57 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 13:02:57 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 13:02:57 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 13:02:57 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 13:02:57 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 13:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:02:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:02:57 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 13:02:57 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 13:02:57 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 13:02:57 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 13:02:57 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 13:02:57 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 13:02:57 INFO - Downloading docopt-0.6.1.tar.gz 13:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:02:57 INFO - Installing collected packages: blobuploader, requests, docopt 13:02:57 INFO - Running setup.py install for blobuploader 13:02:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:02:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:02:58 INFO - Running setup.py install for requests 13:02:58 INFO - Running setup.py install for docopt 13:02:58 INFO - Successfully installed blobuploader requests docopt 13:02:58 INFO - Cleaning up... 13:02:58 INFO - Return code: 0 13:02:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:58 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 0x7f014e7fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e89790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86930>, '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 0x1e87830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e87cc0>, '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': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', '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 13:02:58 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 13:02:58 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 13:02:58 INFO - Using env: {'DISPLAY': ':0', 13:02:58 INFO - 'HOME': '/home/cltbld', 13:02:58 INFO - 'LANG': 'en_US.UTF-8', 13:02:58 INFO - 'LANGUAGE': 'en_US:en', 13:02:58 INFO - 'LOGNAME': 'cltbld', 13:02:58 INFO - 'MAIL': '/var/mail/cltbld', 13:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:58 INFO - 'MOZ_NO_REMOTE': '1', 13:02:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:58 INFO - 'NO_EM_RESTART': '1', 13:02:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:58 INFO - 'PWD': '/builds/slave/test', 13:02:58 INFO - 'SHELL': '/bin/bash', 13:02:58 INFO - 'SHLVL': '1', 13:02:58 INFO - 'TERM': 'linux', 13:02:58 INFO - 'TMOUT': '86400', 13:02:58 INFO - 'USER': 'cltbld', 13:02:58 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', 13:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:58 INFO - '_': '/tools/buildbot/bin/python'} 13:02:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:02:58 INFO - Running setup.py (path:/tmp/pip-4ec0HO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:02:58 INFO - Running setup.py (path:/tmp/pip-Ev1A85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:02:58 INFO - Running setup.py (path:/tmp/pip-dpGjyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:02:59 INFO - Running setup.py (path:/tmp/pip-ChFYiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:02:59 INFO - Running setup.py (path:/tmp/pip-6A1_zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:02:59 INFO - Running setup.py (path:/tmp/pip-Z5Ga5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:02:59 INFO - Running setup.py (path:/tmp/pip-91X5iH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:02:59 INFO - Running setup.py (path:/tmp/pip-3gTrVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:02:59 INFO - Running setup.py (path:/tmp/pip-DLAXCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:02:59 INFO - Running setup.py (path:/tmp/pip-n6yNSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:02:59 INFO - Running setup.py (path:/tmp/pip-nKZmND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:02:59 INFO - Running setup.py (path:/tmp/pip-S07Aw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:02:59 INFO - Running setup.py (path:/tmp/pip-33HsBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:02:59 INFO - Running setup.py (path:/tmp/pip-_OsMzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:59 INFO - Running setup.py (path:/tmp/pip-aTkodn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:02:59 INFO - Running setup.py (path:/tmp/pip-hdjM_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:02:59 INFO - Running setup.py (path:/tmp/pip-cmk_HT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:03:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:03:00 INFO - Running setup.py install for manifestparser 13:03:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:03:00 INFO - Running setup.py install for mozcrash 13:03:00 INFO - Running setup.py install for mozdebug 13:03:00 INFO - Running setup.py install for mozdevice 13:03:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:03:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:03:00 INFO - Running setup.py install for mozfile 13:03:00 INFO - Running setup.py install for mozhttpd 13:03:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:03:00 INFO - Running setup.py install for mozinfo 13:03:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:03:00 INFO - Running setup.py install for mozInstall 13:03:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:03:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:03:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:03:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:03:00 INFO - Running setup.py install for mozleak 13:03:00 INFO - Running setup.py install for mozlog 13:03:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:03:01 INFO - Running setup.py install for moznetwork 13:03:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:03:01 INFO - Running setup.py install for mozprocess 13:03:01 INFO - Running setup.py install for mozprofile 13:03:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:03:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:03:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:03:01 INFO - Running setup.py install for mozrunner 13:03:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:03:01 INFO - Running setup.py install for mozscreenshot 13:03:01 INFO - Running setup.py install for moztest 13:03:01 INFO - Running setup.py install for mozversion 13:03:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:03:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:03:01 INFO - Cleaning up... 13:03:01 INFO - Return code: 0 13:03:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:01 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 0x7f014e7fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e89790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86930>, '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 0x1e87830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e87cc0>, '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': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', '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 13:03:01 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 13:03:01 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 13:03:01 INFO - Using env: {'DISPLAY': ':0', 13:03:01 INFO - 'HOME': '/home/cltbld', 13:03:01 INFO - 'LANG': 'en_US.UTF-8', 13:03:01 INFO - 'LANGUAGE': 'en_US:en', 13:03:01 INFO - 'LOGNAME': 'cltbld', 13:03:01 INFO - 'MAIL': '/var/mail/cltbld', 13:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:01 INFO - 'MOZ_NO_REMOTE': '1', 13:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:01 INFO - 'NO_EM_RESTART': '1', 13:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:01 INFO - 'PWD': '/builds/slave/test', 13:03:01 INFO - 'SHELL': '/bin/bash', 13:03:01 INFO - 'SHLVL': '1', 13:03:01 INFO - 'TERM': 'linux', 13:03:01 INFO - 'TMOUT': '86400', 13:03:01 INFO - 'USER': 'cltbld', 13:03:01 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', 13:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:01 INFO - '_': '/tools/buildbot/bin/python'} 13:03:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:03:02 INFO - Running setup.py (path:/tmp/pip-hLhf94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:03:02 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)) 13:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:03:02 INFO - Running setup.py (path:/tmp/pip-czkZSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:03:02 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)) 13:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:03:02 INFO - Running setup.py (path:/tmp/pip-xrbWm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:03:02 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)) 13:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:03:02 INFO - Running setup.py (path:/tmp/pip-BMxJid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:03:02 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)) 13:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:03:02 INFO - Running setup.py (path:/tmp/pip-J68_4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:03:02 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)) 13:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:03:02 INFO - Running setup.py (path:/tmp/pip-ypfn_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:03:02 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)) 13:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:03:02 INFO - Running setup.py (path:/tmp/pip-NLn1Cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:03:02 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)) 13:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:03:02 INFO - Running setup.py (path:/tmp/pip-8r5aSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:03:02 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)) 13:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:03:02 INFO - Running setup.py (path:/tmp/pip-oEgWB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:03:02 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)) 13:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:03:02 INFO - Running setup.py (path:/tmp/pip-DsQ7Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:03:02 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)) 13:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:03:02 INFO - Running setup.py (path:/tmp/pip-hs3b0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:03:02 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)) 13:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:03:02 INFO - Running setup.py (path:/tmp/pip-S7MMqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:03:02 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)) 13:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:03:02 INFO - Running setup.py (path:/tmp/pip-uSiJUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:03:03 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)) 13:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:03:03 INFO - Running setup.py (path:/tmp/pip-Byy0pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:03:03 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)) 13:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:03:03 INFO - Running setup.py (path:/tmp/pip-N7joBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:03:03 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)) 13:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:03:03 INFO - Running setup.py (path:/tmp/pip-gtaW3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:03:03 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)) 13:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:03:03 INFO - Running setup.py (path:/tmp/pip-xvntEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:03:03 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)) 13:03:03 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)) 13:03:03 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)) 13:03:03 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)) 13:03:03 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)) 13:03:03 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)) 13:03:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:05 INFO - Downloading blessings-1.6.tar.gz 13:03:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:03:05 INFO - Installing collected packages: blessings 13:03:05 INFO - Running setup.py install for blessings 13:03:05 INFO - Successfully installed blessings 13:03:05 INFO - Cleaning up... 13:03:05 INFO - Return code: 0 13:03:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:03:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:03:05 INFO - Reading from file tmpfile_stdout 13:03:05 INFO - Current package versions: 13:03:05 INFO - argparse == 1.2.1 13:03:05 INFO - blessings == 1.6 13:03:05 INFO - blobuploader == 1.2.4 13:03:05 INFO - docopt == 0.6.1 13:03:05 INFO - functools32 == 3.2.3-2 13:03:05 INFO - jsonschema == 2.5.1 13:03:05 INFO - manifestparser == 1.1 13:03:05 INFO - mozInstall == 1.12 13:03:05 INFO - mozcrash == 0.17 13:03:05 INFO - mozdebug == 0.1 13:03:05 INFO - mozdevice == 0.48 13:03:05 INFO - mozfile == 1.2 13:03:05 INFO - mozhttpd == 0.7 13:03:05 INFO - mozinfo == 0.9 13:03:05 INFO - mozleak == 0.1 13:03:05 INFO - mozlog == 3.4 13:03:05 INFO - moznetwork == 0.27 13:03:05 INFO - mozprocess == 0.23 13:03:05 INFO - mozprofile == 0.28 13:03:05 INFO - mozrunner == 6.12 13:03:05 INFO - mozscreenshot == 0.1 13:03:05 INFO - mozsystemmonitor == 0.3 13:03:05 INFO - moztest == 0.7 13:03:05 INFO - mozversion == 1.4 13:03:05 INFO - psutil == 3.1.1 13:03:05 INFO - requests == 1.2.3 13:03:05 INFO - wsgiref == 0.1.2 13:03:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:03:05 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')]} 13:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:05 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')]} 13:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:05 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 0x7f014e7fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e89790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86930>, '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 0x1e87830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e87cc0>, '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': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', '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 13:03:05 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 13:03:05 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 13:03:05 INFO - Using env: {'DISPLAY': ':0', 13:03:05 INFO - 'HOME': '/home/cltbld', 13:03:05 INFO - 'LANG': 'en_US.UTF-8', 13:03:05 INFO - 'LANGUAGE': 'en_US:en', 13:03:05 INFO - 'LOGNAME': 'cltbld', 13:03:05 INFO - 'MAIL': '/var/mail/cltbld', 13:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:05 INFO - 'MOZ_NO_REMOTE': '1', 13:03:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:05 INFO - 'NO_EM_RESTART': '1', 13:03:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:05 INFO - 'PWD': '/builds/slave/test', 13:03:05 INFO - 'SHELL': '/bin/bash', 13:03:05 INFO - 'SHLVL': '1', 13:03:05 INFO - 'TERM': 'linux', 13:03:05 INFO - 'TMOUT': '86400', 13:03:05 INFO - 'USER': 'cltbld', 13:03:05 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', 13:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:05 INFO - '_': '/tools/buildbot/bin/python'} 13:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:05 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)) 13:03:05 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)) 13:03:05 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)) 13:03:05 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)) 13:03:05 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)) 13:03:05 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)) 13:03:05 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)) 13:03:05 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)) 13:03:05 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)) 13:03:05 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)) 13:03:05 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)) 13:03:05 INFO - Cleaning up... 13:03:05 INFO - Return code: 0 13:03:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:03:05 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')]} 13:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:05 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')]} 13:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:05 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 0x7f014e7fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e89790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86930>, '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 0x1e87830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e87cc0>, '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': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', '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 13:03:05 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 13:03:05 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 13:03:05 INFO - Using env: {'DISPLAY': ':0', 13:03:05 INFO - 'HOME': '/home/cltbld', 13:03:05 INFO - 'LANG': 'en_US.UTF-8', 13:03:05 INFO - 'LANGUAGE': 'en_US:en', 13:03:05 INFO - 'LOGNAME': 'cltbld', 13:03:05 INFO - 'MAIL': '/var/mail/cltbld', 13:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:05 INFO - 'MOZ_NO_REMOTE': '1', 13:03:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:05 INFO - 'NO_EM_RESTART': '1', 13:03:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:05 INFO - 'PWD': '/builds/slave/test', 13:03:05 INFO - 'SHELL': '/bin/bash', 13:03:05 INFO - 'SHLVL': '1', 13:03:05 INFO - 'TERM': 'linux', 13:03:05 INFO - 'TMOUT': '86400', 13:03:05 INFO - 'USER': 'cltbld', 13:03:05 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', 13:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:05 INFO - '_': '/tools/buildbot/bin/python'} 13:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:03:06 INFO - Cleaning up... 13:03:06 INFO - Return code: 0 13:03:06 INFO - Running post-action listener: _resource_record_post_action 13:03:06 INFO - Running post-action listener: _start_resource_monitoring 13:03:06 INFO - Starting resource monitoring. 13:03:06 INFO - [mozharness: 2016-10-19 20:03:06.185481Z] Finished create-virtualenv step (success) 13:03:06 INFO - [mozharness: 2016-10-19 20:03:06.185942Z] Running install step. 13:03:06 INFO - Running pre-action listener: _resource_record_pre_action 13:03:06 INFO - Running main action method: install 13:03:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:03:06 INFO - Reading from file tmpfile_stdout 13:03:06 INFO - Detecting whether we're running mozinstall >=1.0... 13:03:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:03:06 INFO - Reading from file tmpfile_stdout 13:03:06 INFO - Output received: 13:03:06 INFO - Usage: mozinstall [options] installer 13:03:06 INFO - Options: 13:03:06 INFO - -h, --help show this help message and exit 13:03:06 INFO - -d DEST, --destination=DEST 13:03:06 INFO - Directory to install application into. [default: 13:03:06 INFO - "/builds/slave/test"] 13:03:06 INFO - --app=APP Application being installed. [default: firefox] 13:03:06 INFO - mkdir: /builds/slave/test/build/application 13:03:06 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'] 13:03:06 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 13:03:23 INFO - Reading from file tmpfile_stdout 13:03:23 INFO - Output received: 13:03:23 INFO - /builds/slave/test/build/application/firefox/firefox 13:03:23 INFO - Running post-action listener: _resource_record_post_action 13:03:23 INFO - [mozharness: 2016-10-19 20:03:23.686252Z] Finished install step (success) 13:03:23 INFO - [mozharness: 2016-10-19 20:03:23.686535Z] Running run-tests step. 13:03:23 INFO - Running pre-action listener: _resource_record_pre_action 13:03:23 INFO - Running main action method: run_tests 13:03:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:03:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:03:23 INFO - Python 2.7.3 13:03:23 INFO - Return code: 0 13:03:23 INFO - grabbing minidump binary from tooltool 13:03:23 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')]} 13:03:23 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 0x1e86930>, '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 0x1e87830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e87cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:03:23 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 13:03:23 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 13:03:23 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 13:03:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:03:23 INFO - Return code: 0 13:03:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:03:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:03:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:03:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:03:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:03:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 13:03:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 13:03:23 INFO - Using env: {'DISPLAY': ':0', 13:03:23 INFO - 'HOME': '/home/cltbld', 13:03:23 INFO - 'LANG': 'en_US.UTF-8', 13:03:23 INFO - 'LANGUAGE': 'en_US:en', 13:03:23 INFO - 'LOGNAME': 'cltbld', 13:03:23 INFO - 'MAIL': '/var/mail/cltbld', 13:03:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:03:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:23 INFO - 'MOZ_NO_REMOTE': '1', 13:03:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:03:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:23 INFO - 'NO_EM_RESTART': '1', 13:03:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:23 INFO - 'PWD': '/builds/slave/test', 13:03:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:03:23 INFO - 'SHELL': '/bin/bash', 13:03:23 INFO - 'SHLVL': '1', 13:03:23 INFO - 'TERM': 'linux', 13:03:23 INFO - 'TMOUT': '86400', 13:03:23 INFO - 'USER': 'cltbld', 13:03:23 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551', 13:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:23 INFO - '_': '/tools/buildbot/bin/python'} 13:03:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 13:03:23 INFO - mozversion application_buildid: 20161019093004 13:03:23 INFO - mozversion application_changeset: 9f7b448a6b5ce5dfcffbcde6eed50052f3105a26 13:03:23 INFO - mozversion application_display_name: Nightly 13:03:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:03:23 INFO - mozversion application_name: Firefox 13:03:23 INFO - mozversion application_remotingname: firefox 13:03:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:03:23 INFO - mozversion application_vendor: Mozilla 13:03:23 INFO - mozversion application_version: 52.0a1 13:03:23 INFO - mozversion platform_buildid: 20161019093004 13:03:23 INFO - mozversion platform_changeset: 9f7b448a6b5ce5dfcffbcde6eed50052f3105a26 13:03:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:03:23 INFO - mozversion platform_version: 52.0a1 13:03:23 INFO - using testdate: 1476907403 13:03:23 INFO - actual date: 1476907403 13:03:23 INFO - starting webserver on 'localhost:54506' 13:03:23 INFO - SUITE-START | Running 2 tests 13:03:23 INFO - TEST-START | dromaeo_css 13:03:23 INFO - operating with platform_type : linux_ 13:03:23 INFO - Initialising browser for dromaeo_css test... 13:03:23 INFO - TEST-INFO | started process 3345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxZN6gV/profile http://localhost:54506/getInfo.html) 13:03:28 INFO - PROCESS | 3345 | __metrics Screen width/height:1600/1200 13:03:28 INFO - PROCESS | 3345 | colorDepth:24 13:03:28 INFO - PROCESS | 3345 | Browser inner width/height: 1024/697 13:03:28 INFO - PROCESS | 3345 | __metrics 13:03:28 INFO - PROCESS | 3345 | 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" 13:03:28 INFO - PROCESS | 3345 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:03:29 INFO - PROCESS | 3345 | console.error: PushService: 13:03:29 INFO - PROCESS | 3345 | stateChangeProcessEnqueue: Error transitioning state 13:03:29 INFO - PROCESS | 3345 | UnknownError 13:03:30 INFO - TEST-INFO | 3345: exit 0 13:03:30 INFO - Browser initialized. 13:03:30 INFO - Running cycle 1/1 for dromaeo_css test... 13:03:30 INFO - TEST-INFO | started process 3424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxZN6gV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:03:42 INFO - PROCESS | 3424 | RSS: Main: 171102208 13:03:42 INFO - PROCESS | 3424 | 13:04:33 INFO - PROCESS | 3424 | 1476907473845 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] 13:06:43 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:54506/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54506/tests/dromaeo/cssquery-ext.html) 13:06:46 INFO - PROCESS | 3424 | RSS: Main: 387899392 13:06:46 INFO - PROCESS | 3424 | 13:09:48 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:54506/tests/dromaeo/cssquery-ext.html (next: http://localhost:54506/tests/dromaeo/cssquery-jquery.html) 13:09:49 INFO - PROCESS | 3424 | RSS: Main: 280621056 13:09:49 INFO - PROCESS | 3424 | 13:12:51 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:54506/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54506/tests/dromaeo/cssquery-mootools.html) 13:12:52 INFO - PROCESS | 3424 | RSS: Main: 219729920 13:12:52 INFO - PROCESS | 3424 | 13:15:54 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:54506/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54506/tests/dromaeo/cssquery-prototype.html) 13:15:54 INFO - PROCESS | 3424 | RSS: Main: 262160384 13:15:54 INFO - PROCESS | 3424 | 13:18:57 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:54506/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54506/tests/dromaeo/cssquery-yui.html) 13:18:58 INFO - PROCESS | 3424 | RSS: Main: 219627520 13:18:58 INFO - PROCESS | 3424 | 13:22:01 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:54506/tests/dromaeo/cssquery-yui.html (next: http://localhost:54506/tests/dromaeo/cssquery-dojo.html) 13:22:01 INFO - PROCESS | 3424 | RSS: Main: 314437632 13:22:01 INFO - PROCESS | 3424 | 13:22:01 INFO - PROCESS | 3424 | __start_tp_report 13:22:01 INFO - PROCESS | 3424 | _x_x_mozilla_page_load 13:22:01 INFO - PROCESS | 3424 | _x_x_mozilla_page_load_details 13:22:01 INFO - PROCESS | 3424 | |i|pagename|runs| 13:22:01 INFO - PROCESS | 3424 | |0;dojo.html;3031.105823781984;3053.8473076346204;3090.5209692497665;3094.4739394302965;3104.301532155264;5191.402988656306;5225.608079394042;5286.497782710646;5301.151815709487;5349.037173308808;5305.7877684892555;5308.177232528955;5365.973170134153;5377.8117765878105;5452.40023597405;4775.522447755231;4820.011897560991;4865.610751139918;4879.58523525499;4886.34034405356;4888.633352498559;4950.257461380786;5001.324821149153;5008.899822003557;5070.771815268304;4731.266653668652;4916.410030796292;4916.975415122902;4936.80252789888;5035.924461133086;4773.212419950704;4802.59177969873;4853.102176097434;4863.610911127102;4880.438749543812;4826.4690884003085;4833.63747718919;4836.564709176191;4853.975730121362;4906.337644418029;5349.197620356938;5351.678899266057;5351.866203344908;5363;5370.57035437168;5540.085885828834;5596.1605759136455;5598.944010559883;5683.460071293221;5730.19777231188;5702.543796496312;5709.514691251248;5722.113072473773;5724.484796368347;5727.255456790591;5295.179247216649;5321.388040375367;5344.064788662007;5355.3305836770405;5356.839294821161;5812.7674893003805;5827.24245848037;5867.325257595346;5872.530197584183;5918.260217472816;5651.604387692904;5663.886722265532;5664.773409063674;5722.513586345207;5738.68437235956;5704.743286552115;5736.512396446349;5748.597598168171;5749.223854779635;5752.964466396089;5545.306836645419;5590.972045139748;5617.9719101404235;5721.628094173865;5728.112142617901;5682.204491371212;5704.771809127671;5719.170720245541;5761.85595360111;5767.567432442584;4411.073674528321;4418.425604671372;4419.160359531678;4421.801018954155;4471.28459446487;3884.2231553689376;3896.1038961038553;3941.586133456003;3962.8018599070506;3979.3235150024566;5334.91997620036;5372.194170874322;5381.54256888161;5401.02781499326;5462.126059830408;5703.600747947687;5710.428957104256;5712.800051998243;5713.885722285531;5719.5996280260815;5347.465253474621;5357.517823395913;5362.088444964365;5363.356397232279;5461.726913654302;4778.689385189951;4838.516148385203;4947.950520494749;4982.277569752366;5003.049420610072;5964.075568286922;5968.46283834457;5968.910466342922;5985.0124729420895;6025.0661147522205;5709.68596727184;5767.9711601443405;5770.278715160605;5774.56690748204;5775.393583673654;5711.685857277889;5754.482096611325;5765.279340082489;5884;5902.498287645427;5634;5690.260266165372;5743.885122297447;5748.9425105748405;5751.252337196138;5765.336986246635;5780.075187969905;5780.624259423124;5785.190073389813;5800.419958004166;5369.221462887781;5621.971890140687;5639.097744360883;5640.069388551007;5644.407337229532;5432.212329212163;5493.606750314202;5520.033994050945;5527.474889885454;5530.944690553043;5516.668999860021;5522.751476183501;5528;5528.80649177293;5533.114701647717;5404.351477822686;5407.432219616883;5444.673319600836;5539.335279766293;5580.5535557156145;5308;5352.277442545206;5353.4646535346155;5355.6786592803;5394.379646340721 13:22:01 INFO - PROCESS | 3424 | |1;ext.html;592.5792687192094;609.1593600830853;617.0374216222693;623.7504998000799;629.1820633176872;30719.84640076802;41253.58746412535;42087;42166.57833421665;44942;42064.57935420652;42490.7875460623;42511;42532.36201456981;42732.57267427325;8670.306375489961;8826.955865220698;8830.779230519223;8832.425892317011;8835.249003834682;7792.961035194844;7962.880556791652;10229.283950123494;10478.895211047906;10481.371117732922;10572.471376431185;10660.626878059269;10662.147028237723;10664.78670426591;10668;10494.737631559196;10508.632197873114;10564.26050176484;10569.577216911315;10583.523741431654;10426.914617076614;10484.423356715377;10495.265331426803;10496.055355018008;10497.632582859564;40581.39127913084;40715.796421018;40873.59126408728;40888.79555602233;40919.59080409217;2936.9559456607954;2942.6615939167054;2989.8355590442516;3488.0930957951114;3517.3492903812876;30160.396792064035;30325.848370758227;30928.845355773075;31939.25093483172;32835.50746738801;3913.5890731473355;4050.4734384530116;4052.230076285496;4149.481314835645;4217.051163488221;310096;312813;315153.42423287965;315936;317318;57357;57719.71140144272;57806;57820.421795781505;57840.71079644575;33546.49680254798;33905.830470847985;34227.65772342295;35450.82274588611;59936.40063599395;14008.439662413593;14107.576772696835;14137.717245655029;14187.432502699776;14188.64528386778;9064.773380665405;10408.115310198567;10451.372917624967;10458.52936617854;10464.372137671764;15883.126428046568;17668.469945901645;18094.457166285032;18259.63480730378;18872;6786.491013174032;6959.406791517574;7039.36645701879;7058.505904586629;7100.970039660699;933.9252859771202;973.4354074636693;988.9505524723735;1041.2086814021247;1061.9415932123807;30526.69473305283;30590.23524411863;30674.07977760671;30912;31145.377092458024;1039.3504059962524;1071.373246650718;1071.4696225368336;1087.1140020882956;1146.3981409759942;15927;16306.918465407596;16791.664166716597;16826.158692065346;17479.300827966737;471806;472515;474601;474977;475615;54084.72957635186;54526.45473545293;54599.18101228485;54630.18054729182;54642.45357546374;1282.7354383095046;1285.8392700912386;1289.6969212235117;1321.3327269728918;1321.6761893336002;28451.715482844906;30831.845840770653;31072;31230.843845780626;31634.525482117326;47303.763481182374;48078.27882581694;48196.7590162047;48289.27566086441;48337;414325;417008;417203;418082;418197;22880.885595571915;24862.37844053913;25023.624645629967;25589;25634.487310253317;37711.62288377081;41160;41942.370864436445;42732.57267427286;45798.77100614476;36442.453363200104;37445;37551.43672844964;38541;38872.805635971636;37100.81449592735;37484.43773343347;37647.623523764414;38417.61582384141;39018;37237.44143837791;37782.2443551133;37935.43096853494;38391;38575;33632.83183584164;35704;36692.266154677294;36709.44935825912;36812;27022.189334320003;27376.178714638594;27407.314817129733;27536.724632754216;27622.309442264104 13:22:01 INFO - PROCESS | 3424 | |2;jquery.html;356.37456264256224;369.1325385344441;372.43761919501543;376.8963535027867;394.68228076398503;14132;17707.64584708305;18486.537836554075;18655.720164197548;19540.31608893689;16483.83516164838;16893.83106168938;16924.915375423137;16996.49010529683;17773.11134443276;4471.977640111795;4910.950890491085;4942.950570494285;4964.528369804881;4968.975155124219;3758.609314553605;4919.065377578248;4948.010397920412;4953.083679519283;4954.108260513106;3914.8042597870135;3934.449177115206;6267.561270711052;6327.367263273659;6344.524160687944;5481.808136715235;5949.018411962064;6283.937160628381;6307.716152773113;6309.77915772948;5332.226827110087;5343.145096784535;5354.9196762048605;5359.437259087817;5361.731913404353;17970.281188752433;19649.9017504913;22273.331800046024;22342.888285558467;22438.439039024153;1959.0988145452966;2088.1021160900805;2127.4787677019076;2329.5108027314286;2523.3313172009434;9125.406848554823;9250.444973301623;12723.363831808372;13116.622754610818;13579.864201358057;1627.9430219942365;1679.8236185200622;1685.2163743859041;1685.7808484897007;1780.1788152740596;78232;80482.59758701228;80536;81764;83015.5849220756;10210.285280030475;10224.335418197794;10296.485175741183;10323.948380258202;10442.2168337375;14286;14287.928560357339;14288.42846286137;14310.57068287953;14321.78517322241;6995.370416662525;7052.612106334201;7222.891656625155;7282.453815963718;7356.043714317105;6573.868522629521;6658.738407419256;6821.079154314104;6827;6838.179418469816;4270.231358355526;4378.277584198571;4383.975057210515;4470.105978804252;4498.685092043525;1686.4568919438577;1779.7330400440037;1787.5263055290359;1810.6831304521656;1814.5917168636952;905.8595917632778;919.3977944446399;952.7237101240563;986.6891929042329;1015.0052948110745;17371.565710857078;18554.72167917482;18710.625787484176;18914.810851891303;19243.326483573008;896.9237614802815;938.6198589571235;945.6030449607579;967.820225164316;1001.1590264178126;10179.7455063624;10407.843882341771;10522.421266830244;10525.21060920434;10546.103581195532;465711;505098;514920;525219;528508;89427.55286223527;92636.07363926274;93949;94390.52804735933;98407;973.4500007495742;996.7657600463886;1027.3938376357985;1031.4224034540532;1031.7059638003134;16366.427175049292;16432.424865129662;16926.746098808773;17506.299748009937;17622.211224586776;39424;40242.396364055145;40882.38676419915;41047.38428923509;41822.58177418187;55313.44686553083;56328;56852.14721779094;57674.134887977554;58373;6976.407005404598;7619.238076192337;7626.733064342721;7684.731034413992;8138.796530086795;12186.329751863732;12620.368981550702;12823.294718790183;12897.48410063587;13254.698120751777;11192.824753400775;11271.718207044561;11744.94127529357;11931.642050738492;12034.75930481403;11006.944965275123;11296.096312295162;11584.768304634028;11624.302541847515;11636.534303959803;11297.774044519228;11360.602378916697;11366.147538934778;11827.763444731228;12139.332336721565;6986.580805151707;7148.499605027599;7158.606276654834;7188.245234250538;7562.810929726801;8321.542315172723;11264.66206013821;11295.943520282346;11695.298282103102;11794.705132371759 13:22:01 INFO - PROCESS | 3424 | |3;mootools.html;1309.3387839141233;1434.3115304653763;1493.6863258715669;1584;1757.4376199616129;7910.881336779946;8717.738467845968;8920.107989201077;8987.550622468883;9194.954025229865;9056.275497960163;9107.225885799699;9127.178553930145;9133.497657628828;9136.954315228431;2212.2810086721797;2232.263353093483;2239.540894116702;2240.8767517786514;2241.7421996470453;2160.79472450117;2191.7808219178114;2203.900824462895;2215.82273418127;2216.789405006522;2185.7595664476894;2225.6327705928584;2238.3956331790405;2252.5044490212126;2276.9203077892194;1991.9900400497977;2012.597480503905;2012.7383440152687;2016.7176595276674;2026.7567891852925;2155.493459037125;2186.9453263668374;2199.538096999632;2256.8194544436406;2261.231181398316;8969.058248883905;9108.089191080906;9148.817023659489;9159.679411220575;9169.816603667889;4998.10034193845;5190.792368305263;5196.792128314863;5201.531862132389;5215.817446389358;3241.38413701396;3384.729221662261;3405.642407547197;3420.1278673938236;3438.2435864109857;1078.730317420645;1097.078454098553;2046.703228031942;2100.684897265407;2147.066026278558;12724.745505089846;12802;12813.359332033455;12855.807162892565;12910.806337905033;4084.611961863618;4197.307444271661;4356.08522210333;4357.106793107406;4370.8907277317685;9876;9878.851817222747;9888.357256778287;9890.653827116017;9913.058259465339;5055.494450554988;5062.924056139161;5065.848024559269;5067.391912970394;5067.670601410897;4128.153728485653;4152.086540960984;4742.5020372861045;4768.1417344878255;4768.213244814636;3712.777233366007;3731.477593136963;3846.6345697158727;3853.903652408656;3875.5736868944396;1055.7518983038979;1059.904608585231;1062.2033474893828;1064.6060957445795;1080.935143891369;789.5223389849059;860.1355637584313;905.6196397513061;936.9875849144895;941.802221533472;5749.281339832521;5847.649141051551;5873.618214816023;5959.28488581373;6090.421409966046;386.63076761692514;387.5020598530874;396.03367782610337;396.26295091130476;405.4971834924731;3797.9430308545393;3890.7471014383973;3914.8434062637175;3918.0988372673874;3928.332183528807;11048.613298534512;11217.15871309655;11312.151588630886;11322.490487928064;11446.656600302003;11220;11268.211225214156;11271.605493807841;11276.1542884284;11286.435678216221;8113.052867311802;8285.337173026144;8403.285720713808;8440;8444.873326900102;5825.242718446575;5978.730957106854;6051.4553690168095;6052.455279024909;6121.693915304306;10439.37363758177;10520;10526.789464210826;10537.683869483928;10681.89318106809;9771.560279787569;10256.12822910061;10286.691399258034;10589.682309530726;10597;7094.858102838018;7278.818029549304;7816.84366312682;7954.801129971797;7994.880076798736;8302.128276531119;8522.616482258438;8593.44142630727;8786.560671966248;8799.648014079621;7757.3794096473275;7917.293008531678;7929.207079292025;8070.394720395876;8111;7565.773026809205;7639.350655194371;7743.070831500031;7796.88304675419;7804.9219507806465;7062.682179302046;7181.35367816899;7192.604406757679;7195.496315257882;7204.855902882018;5312.362516498045;5334.653247538898;5380.650257733235;5411.134218525017;5514.448555144453;5289.41816400188;5398.892022159614;5452.972735136299;5531.751071201886;5569.693666848362 13:22:01 INFO - PROCESS | 3424 | |4;prototype.html;323.81380706093995;325.1383832842966;331.52260744527877;333.79972016789924;339.5907930943214;5050.772715227814;5206;5240.563138140768;5244.816431424901;5258.605604579653;5061.468545802683;5156.149235376168;5175.637705360627;5182.8704282392955;5183.2743415921805;4089.670856971489;4092.242935057024;4095.4061661059127;4101.118259574191;4102.17956408718;3816.656500914917;3956.1889812588493;4097.631213190813;4100.835966561334;4107.630313271805;3999.70002249831;4062.6546743526687;4086.5300490443683;4086.5504794472586;4099.626625080602;4074.246264441073;4077.16527562598;4080.5715399882884;4083.9183216335805;4099.73351732138;3630.8547658093644;3633.818309084562;3637.563492380905;3639.4358874374516;3645.179834537208;4911.852644420673;5045.520675535819;5062.898742025139;5080.79676812927;5085.694858308513;4660.8539236015895;4665.510121437234;4672.13565490382;4675.345451636774;4677.976610116928;5431.972840135813;5440.401555828856;5445;5463.562914966793;5496.5053145217125;3778.2065766189135;3942.073612701013;3942.7634341939574;3958.604139586047;3977.34373828318;5684.602077854552;5708.77164913403;5715.199872017921;5720.998825205573;5724.713764311809;4027.395890616431;4037.152198038445;4042.049304008032;4045.352743561075;4070.8371665133063;3897.8440862365755;3989.5810939851476;4026.697997650188;4043.211573743151;4136.751794892316;4592.196365636;4597.586217240464;4605.0067456153765;4623.676342656049;4631.421072365954;5454.863628409242;5483.150111732688;5541.695206763586;5577.414371491016;5581.358143813432;1367.685432350565;1383.584924522639;1396.7695330270392;1401.5444980381417;1404.9297535123408;865.8181781825762;887.7780554861284;895.2882458445551;903.8192361527721;905.2531661379388;4669.276262179367;4679.4618618858585;4688.57802797743;4691.724513610896;4702.694324868872;4833.341662085839;4896.167651499253;4922.4093108826455;4943;5009.699418034929;4424.915895605597;4592.6555508337005;4636.814527418933;4645.095510840607;4666.696664716783;2591.961120583193;2619.777318927874;2656.1633085577982;2656.6015097735494;2659.295286749013;5062.519060689228;5134.921666450013;5136.614753893398;5173.456787037307;5178.896422071537;4847.878803029953;4918.311436398907;5106.804074248034;5116.232565115188;5127.66670166438;4962.305277261186;5017.043353092297;5050.242463630485;5084.601734522962;5091;4906.901861962812;4916.729579873141;4933.8158841876975;4946.975265123651;4954.628402869727;4689.390379250675;4904.6566740327835;4908.8954985129485;4910.558049775537;4911.312416261798;5031;5071.518205770446;5081.441041485507;5101.617378696538;5115.335006449287;3604.4953706480587;3629.219717760694;3646.2525182337026;3662.2675464907657;3801.4297855321925;5488.286522752017;5509.779608815603;5586.217929489956;5593;5642.576806739593;5452.291202143696;5457.399686034453;5458.426865179099;5461.508464238079;5491.929073830564;5228.085085110167;5432.913417316474;5450.291462109901;5454.89986355264;5474.3704473986;5371.919421208763;5378.811741589026;5402.783888644411;5460.235567020541;5467.043267428264;5477.123660214346;5484.424135465878;5504.9449505504435;5506.788506528717;5533.916991245215;5212.582993360446;5352.384475785335;5366.9873797326;5381.757820898148;5390.326209223847 13:22:01 INFO - PROCESS | 3424 | |5;yui.html;633.1231244726055;649.4252586460981;649.779075114461;668.8461653819625;706.7879636109169;12257.264564126148;13131.1464754791;13143.211407315568;13263.867361326384;13337;12644.936775316133;12739.745205095893;12747.362631868416;12784.360781960888;12796.744065118692;786.3237615650551;808.2483290539795;809.6639894443799;811.4441607498882;811.5090370325956;659.9439047680953;674.1505702814464;793.4604468961104;793.8055176481741;796.5698522797683;841.877927700483;843.9156084391542;844.5144042175742;849.6643825688849;850.2220468271524;840.5671079394117;843.2663582683074;845.1843970568369;846.5640195299426;846.6740304982595;504.1228262822699;512.6821370750122;516.4602989875589;522.156716902204;606.2240332374568;11329.376884271362;11334.319940803578;11344.886551134548;11427;11583.536658533649;13423.731525369536;13946.093503922313;13971.65070873226;14062.92968535161;14108.4816837168;12534.185277956904;12535;12535.122541422104;12786.61640150797;13195.868041319656;4274.700770946035;4314.654827613815;4341.435613370273;4372.256716358227;4567.794449249792;79770;79825;80578.5971070141;82853;83409.58295208485;10451.163906887583;10703.946480267548;10791.514381852836;10802.783944321069;11030.448477576088;21169.364919052452;21291.36125916225;21468.248611298528;21794.673079903812;21823.454413639785;7186.604736739425;7991.56046417441;8095.676172953016;8143;8217.54803485802;4425.645948324126;4476.149531588988;4680.180968330528;4699.318598803155;4762.452317983476;3067.55520449538;3185.0444866539947;3187.5815262208557;3190.6968837960358;3195.201199700075;577.3850848845966;580.9012467880386;581.1892410087988;582.3070546050187;582.9504492118217;463.6893281501402;512.3134999101222;553.2669213292404;624.4348864277836;636.3000699230809;8873.51541568362;8971.685990990283;9359.344845860724;9359.812803744024;9479.857802132974;545.7762317449826;610.2951091489336;615.7013848283578;627.5136769003967;650.5836264790538;4004.6796256299426;4477.955220447819;4482.708623939434;4517.932231016537;4528.43394575678;114733;115920;119528.40235798765;120108.39945800215;120319.39840300742;102994.48502757438;103302;103584;103782.48108759407;107892.46053769838;71369.64315178494;71883;71896.28103719105;91336;95008.52495737615;9258.166764991183;9804.607815687577;10051.214471832203;10124.645637402655;10143.442110683984;45893.77053114713;47325.763371182926;47855.5214447865;47897.5210247907;47999.04001920012;72746.63626681833;75218;75984.24015759771;76507.31600022093;76927.23072769424;11456.599019034295;11493.138014648768;11585.420728963687;11601.129915256559;12341.3829308536;12524.311162886128;13447.327633618084;13672.726545468837;13937.163770173822;13941;13461.663458413226;13872.722545549233;14023.298835058411;14246.242538595305;14440.855591444371;10063.748406289902;12597.811032834697;12639.304838233618;13134.343282836011;13586;12681.556145534862;13918.164910105426;14312.427502899767;14347.210903400413;14392.42430302818;11101.833472498081;11447.198696091195;11464.25482343645;11600.332376341465;12171.75656486883;11592.6522204334;11897.821532676844;11980.880191198325;12121.393930303626;12167.939160304142 13:22:01 INFO - PROCESS | 3424 | __end_tp_report 13:22:01 INFO - PROCESS | 3424 | __start_cc_report 13:22:01 INFO - PROCESS | 3424 | _x_x_mozilla_cycle_collect,2220 13:22:01 INFO - PROCESS | 3424 | __end_cc_report 13:22:01 INFO - PROCESS | 3424 | __startTimestamp1476908521309__endTimestamp 13:22:01 INFO - PROCESS | 3424 | 13:22:01 INFO - PROCESS | 3424 | ------- Summary: start ------- 13:22:01 INFO - PROCESS | 3424 | Number of tests: 6 13:22:01 INFO - PROCESS | 3424 | 13:22:01 INFO - PROCESS | 3424 | [#0] dojo.html Cycles:165 Average:5304.69 Median:5452.40 stddev:596.22 (10.9%) stddev-sans-first:570.75 13:22:01 INFO - PROCESS | 3424 | Values: 3031.1 3053.8 3090.5 3094.5 3104.3 5191.4 5225.6 5286.5 5301.2 5349.0 5305.8 5308.2 5366.0 5377.8 5452.4 4775.5 4820.0 4865.6 4879.6 4886.3 4888.6 4950.3 5001.3 5008.9 5070.8 4731.3 4916.4 4917.0 4936.8 5035.9 4773.2 4802.6 4853.1 4863.6 4880.4 4826.5 4833.6 4836.6 4854.0 4906.3 5349.2 5351.7 5351.9 5363.0 5370.6 5540.1 5596.2 5598.9 5683.5 5730.2 5702.5 5709.5 5722.1 5724.5 5727.3 5295.2 5321.4 5344.1 5355.3 5356.8 5812.8 5827.2 5867.3 5872.5 5918.3 5651.6 5663.9 5664.8 5722.5 5738.7 5704.7 5736.5 5748.6 5749.2 5753.0 5545.3 5591.0 5618.0 5721.6 5728.1 5682.2 5704.8 5719.2 5761.9 5767.6 4411.1 4418.4 4419.2 4421.8 4471.3 3884.2 3896.1 3941.6 3962.8 3979.3 5334.9 5372.2 5381.5 5401.0 5462.1 5703.6 5710.4 5712.8 5713.9 5719.6 5347.5 5357.5 5362.1 5363.4 5461.7 4778.7 4838.5 4948.0 4982.3 5003.0 5964.1 5968.5 5968.9 5985.0 6025.1 5709.7 5768.0 5770.3 5774.6 5775.4 5711.7 5754.5 5765.3 5884.0 5902.5 5634.0 5690.3 5743.9 5748.9 5751.3 5765.3 5780.1 5780.6 5785.2 5800.4 5369.2 5622.0 5639.1 5640.1 5644.4 5432.2 5493.6 5520.0 5527.5 5530.9 5516.7 5522.8 5528.0 5528.8 5533.1 5404.4 5407.4 5444.7 5539.3 5580.6 5308.0 5352.3 5353.5 5355.7 5394.4 13:22:01 INFO - PROCESS | 3424 | 13:22:01 INFO - PROCESS | 3424 | [#1] ext.html Cycles:180 Average:55316.91 Median:36073.23 stddev:107732.28 (298.6%) stddev-sans-first:107956.15 13:22:01 INFO - PROCESS | 3424 | Values: 592.6 609.2 617.0 623.8 629.2 30719.8 41253.6 42087.0 42166.6 44942.0 42064.6 42490.8 42511.0 42532.4 42732.6 8670.3 8827.0 8830.8 8832.4 8835.2 7793.0 7962.9 10229.3 10478.9 10481.4 10572.5 10660.6 10662.1 10664.8 10668.0 10494.7 10508.6 10564.3 10569.6 10583.5 10426.9 10484.4 10495.3 10496.1 10497.6 40581.4 40715.8 40873.6 40888.8 40919.6 2937.0 2942.7 2989.8 3488.1 3517.3 30160.4 30325.8 30928.8 31939.3 32835.5 3913.6 4050.5 4052.2 4149.5 4217.1 310096.0 312813.0 315153.4 315936.0 317318.0 57357.0 57719.7 57806.0 57820.4 57840.7 33546.5 33905.8 34227.7 35450.8 59936.4 14008.4 14107.6 14137.7 14187.4 14188.6 9064.8 10408.1 10451.4 10458.5 10464.4 15883.1 17668.5 18094.5 18259.6 18872.0 6786.5 6959.4 7039.4 7058.5 7101.0 933.9 973.4 989.0 1041.2 1061.9 30526.7 30590.2 30674.1 30912.0 31145.4 1039.4 1071.4 1071.5 1087.1 1146.4 15927.0 16306.9 16791.7 16826.2 17479.3 471806.0 472515.0 474601.0 474977.0 475615.0 54084.7 54526.5 54599.2 54630.2 54642.5 1282.7 1285.8 1289.7 1321.3 1321.7 28451.7 30831.8 31072.0 31230.8 31634.5 47303.8 48078.3 48196.8 48289.3 48337.0 414325.0 417008.0 417203.0 418082.0 418197.0 22880.9 24862.4 25023.6 25589.0 25634.5 37711.6 41160.0 41942.4 42732.6 45798.8 36442.5 37445.0 37551.4 38541.0 38872.8 37100.8 37484.4 37647.6 38417.6 39018.0 37237.4 37782.2 37935.4 38391.0 38575.0 33632.8 35704.0 36692.3 36709.4 36812.0 27022.2 27376.2 27407.3 27536.7 27622.3 13:22:01 INFO - PROCESS | 3424 | 13:22:01 INFO - PROCESS | 3424 | [#2] jquery.html Cycles:180 Average:29015.69 Median:2067.75 stddev:83847.46 (4055.0%) stddev-sans-first:84055.06 13:22:01 INFO - PROCESS | 3424 | Values: 356.4 369.1 372.4 376.9 394.7 14132.0 17707.6 18486.5 18655.7 19540.3 16483.8 16893.8 16924.9 16996.5 17773.1 4472.0 4911.0 4943.0 4964.5 4969.0 3758.6 4919.1 4948.0 4953.1 4954.1 3914.8 3934.4 6267.6 6327.4 6344.5 5481.8 5949.0 6283.9 6307.7 6309.8 5332.2 5343.1 5354.9 5359.4 5361.7 17970.3 19649.9 22273.3 22342.9 22438.4 1959.1 2088.1 2127.5 2329.5 2523.3 9125.4 9250.4 12723.4 13116.6 13579.9 1627.9 1679.8 1685.2 1685.8 1780.2 78232.0 80482.6 80536.0 81764.0 83015.6 10210.3 10224.3 10296.5 10323.9 10442.2 14286.0 14287.9 14288.4 14310.6 14321.8 6995.4 7052.6 7222.9 7282.5 7356.0 6573.9 6658.7 6821.1 6827.0 6838.2 4270.2 4378.3 4384.0 4470.1 4498.7 1686.5 1779.7 1787.5 1810.7 1814.6 905.9 919.4 952.7 986.7 1015.0 17371.6 18554.7 18710.6 18914.8 19243.3 896.9 938.6 945.6 967.8 1001.2 10179.7 10407.8 10522.4 10525.2 10546.1 465711.0 505098.0 514920.0 525219.0 528508.0 89427.6 92636.1 93949.0 94390.5 98407.0 973.5 996.8 1027.4 1031.4 1031.7 16366.4 16432.4 16926.7 17506.3 17622.2 39424.0 40242.4 40882.4 41047.4 41822.6 55313.4 56328.0 56852.1 57674.1 58373.0 6976.4 7619.2 7626.7 7684.7 8138.8 12186.3 12620.4 12823.3 12897.5 13254.7 11192.8 11271.7 11744.9 11931.6 12034.8 11006.9 11296.1 11584.8 11624.3 11636.5 11297.8 11360.6 11366.1 11827.8 12139.3 6986.6 7148.5 7158.6 7188.2 7562.8 8321.5 11264.7 11295.9 11695.3 11794.7 13:22:01 INFO - PROCESS | 3424 | 13:22:01 INFO - PROCESS | 3424 | [#3] mootools.html Cycles:180 Average:5825.94 Median:4556.70 stddev:3438.56 (75.5%) stddev-sans-first:3431.46 13:22:01 INFO - PROCESS | 3424 | Values: 1309.3 1434.3 1493.7 1584.0 1757.4 7910.9 8717.7 8920.1 8987.6 9195.0 9056.3 9107.2 9127.2 9133.5 9137.0 2212.3 2232.3 2239.5 2240.9 2241.7 2160.8 2191.8 2203.9 2215.8 2216.8 2185.8 2225.6 2238.4 2252.5 2276.9 1992.0 2012.6 2012.7 2016.7 2026.8 2155.5 2186.9 2199.5 2256.8 2261.2 8969.1 9108.1 9148.8 9159.7 9169.8 4998.1 5190.8 5196.8 5201.5 5215.8 3241.4 3384.7 3405.6 3420.1 3438.2 1078.7 1097.1 2046.7 2100.7 2147.1 12724.7 12802.0 12813.4 12855.8 12910.8 4084.6 4197.3 4356.1 4357.1 4370.9 9876.0 9878.9 9888.4 9890.7 9913.1 5055.5 5062.9 5065.8 5067.4 5067.7 4128.2 4152.1 4742.5 4768.1 4768.2 3712.8 3731.5 3846.6 3853.9 3875.6 1055.8 1059.9 1062.2 1064.6 1080.9 789.5 860.1 905.6 937.0 941.8 5749.3 5847.6 5873.6 5959.3 6090.4 386.6 387.5 396.0 396.3 405.5 3797.9 3890.7 3914.8 3918.1 3928.3 11048.6 11217.2 11312.2 11322.5 11446.7 11220.0 11268.2 11271.6 11276.2 11286.4 8113.1 8285.3 8403.3 8440.0 8444.9 5825.2 5978.7 6051.5 6052.5 6121.7 10439.4 10520.0 10526.8 10537.7 10681.9 9771.6 10256.1 10286.7 10589.7 10597.0 7094.9 7278.8 7816.8 7954.8 7994.9 8302.1 8522.6 8593.4 8786.6 8799.6 7757.4 7917.3 7929.2 8070.4 8111.0 7565.8 7639.4 7743.1 7796.9 7804.9 7062.7 7181.4 7192.6 7195.5 7204.9 5312.4 5334.7 5380.7 5411.1 5514.4 5289.4 5398.9 5453.0 5531.8 5569.7 13:22:01 INFO - PROCESS | 3424 | 13:22:01 INFO - PROCESS | 3424 | [#4] prototype.html Cycles:180 Average:4420.53 Median:4917.52 stddev:1276.70 (26.0%) stddev-sans-first:1242.70 13:22:01 INFO - PROCESS | 3424 | Values: 323.8 325.1 331.5 333.8 339.6 5050.8 5206.0 5240.6 5244.8 5258.6 5061.5 5156.1 5175.6 5182.9 5183.3 4089.7 4092.2 4095.4 4101.1 4102.2 3816.7 3956.2 4097.6 4100.8 4107.6 3999.7 4062.7 4086.5 4086.6 4099.6 4074.2 4077.2 4080.6 4083.9 4099.7 3630.9 3633.8 3637.6 3639.4 3645.2 4911.9 5045.5 5062.9 5080.8 5085.7 4660.9 4665.5 4672.1 4675.3 4678.0 5432.0 5440.4 5445.0 5463.6 5496.5 3778.2 3942.1 3942.8 3958.6 3977.3 5684.6 5708.8 5715.2 5721.0 5724.7 4027.4 4037.2 4042.0 4045.4 4070.8 3897.8 3989.6 4026.7 4043.2 4136.8 4592.2 4597.6 4605.0 4623.7 4631.4 5454.9 5483.2 5541.7 5577.4 5581.4 1367.7 1383.6 1396.8 1401.5 1404.9 865.8 887.8 895.3 903.8 905.3 4669.3 4679.5 4688.6 4691.7 4702.7 4833.3 4896.2 4922.4 4943.0 5009.7 4424.9 4592.7 4636.8 4645.1 4666.7 2592.0 2619.8 2656.2 2656.6 2659.3 5062.5 5134.9 5136.6 5173.5 5178.9 4847.9 4918.3 5106.8 5116.2 5127.7 4962.3 5017.0 5050.2 5084.6 5091.0 4906.9 4916.7 4933.8 4947.0 4954.6 4689.4 4904.7 4908.9 4910.6 4911.3 5031.0 5071.5 5081.4 5101.6 5115.3 3604.5 3629.2 3646.3 3662.3 3801.4 5488.3 5509.8 5586.2 5593.0 5642.6 5452.3 5457.4 5458.4 5461.5 5491.9 5228.1 5432.9 5450.3 5454.9 5474.4 5371.9 5378.8 5402.8 5460.2 5467.0 5477.1 5484.4 5504.9 5506.8 5533.9 5212.6 5352.4 5367.0 5381.8 5390.3 13:22:01 INFO - PROCESS | 3424 | 13:22:01 INFO - PROCESS | 3424 | [#5] yui.html Cycles:180 Average:20604.05 Median:4328.05 stddev:30605.03 (707.1%) stddev-sans-first:30654.15 13:22:01 INFO - PROCESS | 3424 | Values: 633.1 649.4 649.8 668.8 706.8 12257.3 13131.1 13143.2 13263.9 13337.0 12644.9 12739.7 12747.4 12784.4 12796.7 786.3 808.2 809.7 811.4 811.5 659.9 674.2 793.5 793.8 796.6 841.9 843.9 844.5 849.7 850.2 840.6 843.3 845.2 846.6 846.7 504.1 512.7 516.5 522.2 606.2 11329.4 11334.3 11344.9 11427.0 11583.5 13423.7 13946.1 13971.7 14062.9 14108.5 12534.2 12535.0 12535.1 12786.6 13195.9 4274.7 4314.7 4341.4 4372.3 4567.8 79770.0 79825.0 80578.6 82853.0 83409.6 10451.2 10703.9 10791.5 10802.8 11030.4 21169.4 21291.4 21468.2 21794.7 21823.5 7186.6 7991.6 8095.7 8143.0 8217.5 4425.6 4476.1 4680.2 4699.3 4762.5 3067.6 3185.0 3187.6 3190.7 3195.2 577.4 580.9 581.2 582.3 583.0 463.7 512.3 553.3 624.4 636.3 8873.5 8971.7 9359.3 9359.8 9479.9 545.8 610.3 615.7 627.5 650.6 4004.7 4478.0 4482.7 4517.9 4528.4 114733.0 115920.0 119528.4 120108.4 120319.4 102994.5 103302.0 103584.0 103782.5 107892.5 71369.6 71883.0 71896.3 91336.0 95008.5 9258.2 9804.6 10051.2 10124.6 10143.4 45893.8 47325.8 47855.5 47897.5 47999.0 72746.6 75218.0 75984.2 76507.3 76927.2 11456.6 11493.1 11585.4 11601.1 12341.4 12524.3 13447.3 13672.7 13937.2 13941.0 13461.7 13872.7 14023.3 14246.2 14440.9 10063.7 12597.8 12639.3 13134.3 13586.0 12681.6 13918.2 14312.4 14347.2 14392.4 11101.8 11447.2 11464.3 11600.3 12171.8 11592.7 11897.8 11980.9 12121.4 12167.9 13:22:01 INFO - PROCESS | 3424 | -------- Summary: end -------- 13:22:01 INFO - PROCESS | 3424 | 13:22:02 INFO - TEST-INFO | 3424: exit 0 13:22:02 INFO - TEST-OK | dromaeo_css | took 1118276ms 13:22:02 INFO - TEST-START | kraken 13:22:02 INFO - operating with platform_type : linux_ 13:22:02 INFO - Initialising browser for kraken test... 13:22:02 INFO - TEST-INFO | started process 3737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0jPIkF/profile http://localhost:54506/getInfo.html) 13:22:06 INFO - PROCESS | 3737 | __metrics Screen width/height:1600/1200 13:22:06 INFO - PROCESS | 3737 | colorDepth:24 13:22:06 INFO - PROCESS | 3737 | Browser inner width/height: 1024/697 13:22:06 INFO - PROCESS | 3737 | __metrics 13:22:06 INFO - PROCESS | 3737 | 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" 13:22:06 INFO - PROCESS | 3737 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:22:07 INFO - PROCESS | 3737 | console.error: PushService: 13:22:07 INFO - PROCESS | 3737 | stateChangeProcessEnqueue: Error transitioning state 13:22:07 INFO - PROCESS | 3737 | UnknownError 13:22:08 INFO - TEST-INFO | 3737: exit 0 13:22:08 INFO - Browser initialized. 13:22:08 INFO - Running cycle 1/1 for kraken test... 13:22:08 INFO - TEST-INFO | started process 3819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0jPIkF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:22:20 INFO - PROCESS | 3819 | RSS: Main: 171925504 13:22:20 INFO - PROCESS | 3819 | 13:22:23 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:54506/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54506/tests/kraken/driver.html?testName=audio-beat-detection) 13:22:23 INFO - PROCESS | 3819 | RSS: Main: 238239744 13:22:23 INFO - PROCESS | 3819 | 13:22:26 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:54506/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54506/tests/kraken/driver.html?testName=audio-dft) 13:22:27 INFO - PROCESS | 3819 | RSS: Main: 215838720 13:22:27 INFO - PROCESS | 3819 | 13:22:30 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:54506/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54506/tests/kraken/driver.html?testName=audio-fft) 13:22:30 INFO - PROCESS | 3819 | RSS: Main: 297570304 13:22:30 INFO - PROCESS | 3819 | 13:22:32 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:54506/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54506/tests/kraken/driver.html?testName=audio-oscillator) 13:22:33 INFO - PROCESS | 3819 | RSS: Main: 208662528 13:22:33 INFO - PROCESS | 3819 | 13:22:35 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:54506/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54506/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:22:36 INFO - PROCESS | 3819 | RSS: Main: 212324352 13:22:36 INFO - PROCESS | 3819 | 13:22:39 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:54506/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54506/tests/kraken/driver.html?testName=imaging-darkroom) 13:22:39 INFO - PROCESS | 3819 | RSS: Main: 248119296 13:22:39 INFO - PROCESS | 3819 | 13:22:43 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:54506/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54506/tests/kraken/driver.html?testName=imaging-desaturate) 13:22:43 INFO - PROCESS | 3819 | RSS: Main: 247095296 13:22:43 INFO - PROCESS | 3819 | 13:22:46 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:54506/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54506/tests/kraken/driver.html?testName=json-parse-financial) 13:22:47 INFO - PROCESS | 3819 | RSS: Main: 246263808 13:22:47 INFO - PROCESS | 3819 | 13:22:48 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:54506/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54506/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:22:49 INFO - PROCESS | 3819 | RSS: Main: 209092608 13:22:49 INFO - PROCESS | 3819 | 13:22:50 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:54506/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54506/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:22:51 INFO - PROCESS | 3819 | RSS: Main: 216346624 13:22:51 INFO - PROCESS | 3819 | 13:22:53 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:54506/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54506/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:22:54 INFO - PROCESS | 3819 | RSS: Main: 226041856 13:22:54 INFO - PROCESS | 3819 | 13:22:56 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:54506/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54506/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:22:57 INFO - PROCESS | 3819 | RSS: Main: 234745856 13:22:57 INFO - PROCESS | 3819 | 13:23:00 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:54506/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54506/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:23:00 INFO - PROCESS | 3819 | RSS: Main: 231968768 13:23:00 INFO - PROCESS | 3819 | 13:23:02 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:54506/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54506/tests/kraken/driver.html?testName=ai-astar) 13:23:02 INFO - PROCESS | 3819 | RSS: Main: 283414528 13:23:02 INFO - PROCESS | 3819 | 13:23:02 INFO - PROCESS | 3819 | __start_tp_report 13:23:02 INFO - PROCESS | 3819 | _x_x_mozilla_page_load 13:23:02 INFO - PROCESS | 3819 | _x_x_mozilla_page_load_details 13:23:02 INFO - PROCESS | 3819 | |i|pagename|runs| 13:23:02 INFO - PROCESS | 3819 | |0;ai-astar;103;110;111;111;111;111;111;110;111;109 13:23:02 INFO - PROCESS | 3819 | |1;audio-beat-detection;150;121;131;162;127;123;130;123;179;122 13:23:02 INFO - PROCESS | 3819 | |2;audio-dft;159;161;161;160;163;161;162;161;161;162 13:23:02 INFO - PROCESS | 3819 | |3;audio-fft;75;75;77;105;76;76;76;75;97;76 13:23:02 INFO - PROCESS | 3819 | |4;audio-oscillator;83;84;116;83;82;84;104;83;84;112 13:23:02 INFO - PROCESS | 3819 | |5;imaging-gaussian-blur;116;117;117;116;117;116;117;117;116;117 13:23:02 INFO - PROCESS | 3819 | |6;imaging-darkroom;146;149;148;146;147;147;146;147;146;147 13:23:02 INFO - PROCESS | 3819 | |7;imaging-desaturate;85;84;84;85;85;86;84;84;84;84 13:23:02 INFO - PROCESS | 3819 | |8;json-parse-financial;56;54;53;55;52;53;54;53;53;55 13:23:02 INFO - PROCESS | 3819 | |9;json-stringify-tinderbox;60;59;59;60;60;60;60;60;60;60 13:23:02 INFO - PROCESS | 3819 | |10;stanford-crypto-aes;87;81;79;80;81;80;89;81;81;80 13:23:02 INFO - PROCESS | 3819 | |11;stanford-crypto-ccm;130;141;139;132;134;130;141;138;182;140 13:23:02 INFO - PROCESS | 3819 | |12;stanford-crypto-pbkdf2;168;166;165;164;167;168;166;171;167;175 13:23:02 INFO - PROCESS | 3819 | |13;stanford-crypto-sha256-iterative;70;67;66;67;66;65;66;67;68;65 13:23:02 INFO - PROCESS | 3819 | __end_tp_report 13:23:02 INFO - PROCESS | 3819 | __start_cc_report 13:23:02 INFO - PROCESS | 3819 | _x_x_mozilla_cycle_collect,1689 13:23:02 INFO - PROCESS | 3819 | __end_cc_report 13:23:02 INFO - PROCESS | 3819 | __startTimestamp1476908582844__endTimestamp 13:23:02 INFO - PROCESS | 3819 | 13:23:02 INFO - PROCESS | 3819 | ------- Summary: start ------- 13:23:02 INFO - PROCESS | 3819 | Number of tests: 14 13:23:02 INFO - PROCESS | 3819 | 13:23:02 INFO - PROCESS | 3819 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:2.49 (2.2%) stddev-sans-first:0.73 13:23:02 INFO - PROCESS | 3819 | Values: 103.0 110.0 111.0 111.0 111.0 111.0 111.0 110.0 111.0 109.0 13:23:02 INFO - PROCESS | 3819 | 13:23:02 INFO - PROCESS | 3819 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:130.50 stddev:20.04 (15.4%) stddev-sans-first:20.68 13:23:02 INFO - PROCESS | 3819 | Values: 150.0 121.0 131.0 162.0 127.0 123.0 130.0 123.0 179.0 122.0 13:23:02 INFO - PROCESS | 3819 | 13:23:02 INFO - PROCESS | 3819 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:0.87 13:23:02 INFO - PROCESS | 3819 | Values: 159.0 161.0 161.0 160.0 163.0 161.0 162.0 161.0 161.0 162.0 13:23:02 INFO - PROCESS | 3819 | 13:23:02 INFO - PROCESS | 3819 | [#3] audio-fft Cycles:10 Average:80.80 Median:76.00 stddev:10.83 (14.2%) stddev-sans-first:11.28 13:23:02 INFO - PROCESS | 3819 | Values: 75.0 75.0 77.0 105.0 76.0 76.0 76.0 75.0 97.0 76.0 13:23:02 INFO - PROCESS | 3819 | 13:23:02 INFO - PROCESS | 3819 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:83.00 stddev:13.55 (16.3%) stddev-sans-first:14.02 13:23:02 INFO - PROCESS | 3819 | Values: 83.0 84.0 116.0 83.0 82.0 84.0 104.0 83.0 84.0 112.0 13:23:02 INFO - PROCESS | 3819 | 13:23:02 INFO - PROCESS | 3819 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 13:23:02 INFO - PROCESS | 3819 | Values: 116.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 13:23:02 INFO - PROCESS | 3819 | 13:23:02 INFO - PROCESS | 3819 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 13:23:02 INFO - PROCESS | 3819 | Values: 146.0 149.0 148.0 146.0 147.0 147.0 146.0 147.0 146.0 147.0 13:23:02 INFO - PROCESS | 3819 | 13:23:02 INFO - PROCESS | 3819 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 13:23:02 INFO - PROCESS | 3819 | Values: 85.0 84.0 84.0 85.0 85.0 86.0 84.0 84.0 84.0 84.0 13:23:02 INFO - PROCESS | 3819 | 13:23:02 INFO - PROCESS | 3819 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.23 (2.3%) stddev-sans-first:1.01 13:23:02 INFO - PROCESS | 3819 | Values: 56.0 54.0 53.0 55.0 52.0 53.0 54.0 53.0 53.0 55.0 13:23:02 INFO - PROCESS | 3819 | 13:23:02 INFO - PROCESS | 3819 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 13:23:02 INFO - PROCESS | 3819 | Values: 60.0 59.0 59.0 60.0 60.0 60.0 60.0 60.0 60.0 60.0 13:23:02 INFO - PROCESS | 3819 | 13:23:02 INFO - PROCESS | 3819 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:81.00 stddev:3.31 (4.1%) stddev-sans-first:2.96 13:23:02 INFO - PROCESS | 3819 | Values: 87.0 81.0 79.0 80.0 81.0 80.0 89.0 81.0 81.0 80.0 13:23:02 INFO - PROCESS | 3819 | 13:23:02 INFO - PROCESS | 3819 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:139.50 stddev:15.15 (10.9%) stddev-sans-first:15.57 13:23:02 INFO - PROCESS | 3819 | Values: 130.0 141.0 139.0 132.0 134.0 130.0 141.0 138.0 182.0 140.0 13:23:02 INFO - PROCESS | 3819 | 13:23:02 INFO - PROCESS | 3819 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:167.50 stddev:3.20 (1.9%) stddev-sans-first:3.39 13:23:02 INFO - PROCESS | 3819 | Values: 168.0 166.0 165.0 164.0 167.0 168.0 166.0 171.0 167.0 175.0 13:23:02 INFO - PROCESS | 3819 | 13:23:02 INFO - PROCESS | 3819 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.49 (2.2%) stddev-sans-first:1.00 13:23:02 INFO - PROCESS | 3819 | Values: 70.0 67.0 66.0 67.0 66.0 65.0 66.0 67.0 68.0 65.0 13:23:02 INFO - PROCESS | 3819 | -------- Summary: end -------- 13:23:02 INFO - PROCESS | 3819 | 13:23:04 INFO - TEST-INFO | 3819: exit 0 13:23:04 INFO - TEST-OK | kraken | took 61836ms 13:23:04 INFO - SUITE-END | took 1180s 13:23:04 INFO - Completed test suite (00:19:40) 13:23:04 INFO - javascript benchmark 13:23:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3031.105823781984, 3053.8473076346204, 3090.5209692497665, 3094.4739394302965, 3104.301532155264, 5191.402988656306, 5225.608079394042, 5286.497782710646, 5301.151815709487, 5349.037173308808, 5305.7877684892555, 5308.177232528955, 5365.973170134153, 5377.8117765878105, 5452.40023597405, 4775.522447755231, 4820.011897560991, 4865.610751139918, 4879.58523525499, 4886.34034405356, 4888.633352498559, 4950.257461380786, 5001.324821149153, 5008.899822003557, 5070.771815268304, 4731.266653668652, 4916.410030796292, 4916.975415122902, 4936.80252789888, 5035.924461133086, 4773.212419950704, 4802.59177969873, 4853.102176097434, 4863.610911127102, 4880.438749543812, 4826.4690884003085, 4833.63747718919, 4836.564709176191, 4853.975730121362, 4906.337644418029, 5349.197620356938, 5351.678899266057, 5351.866203344908, 5363.0, 5370.57035437168, 5540.085885828834, 5596.1605759136455, 5598.944010559883, 5683.460071293221, 5730.19777231188, 5702.543796496312, 5709.514691251248, 5722.113072473773, 5724.484796368347, 5727.255456790591, 5295.179247216649, 5321.388040375367, 5344.064788662007, 5355.3305836770405, 5356.839294821161, 5812.7674893003805, 5827.24245848037, 5867.325257595346, 5872.530197584183, 5918.260217472816, 5651.604387692904, 5663.886722265532, 5664.773409063674, 5722.513586345207, 5738.68437235956, 5704.743286552115, 5736.512396446349, 5748.597598168171, 5749.223854779635, 5752.964466396089, 5545.306836645419, 5590.972045139748, 5617.9719101404235, 5721.628094173865, 5728.112142617901, 5682.204491371212, 5704.771809127671, 5719.170720245541, 5761.85595360111, 5767.567432442584, 4411.073674528321, 4418.425604671372, 4419.160359531678, 4421.801018954155, 4471.28459446487, 3884.2231553689376, 3896.1038961038553, 3941.586133456003, 3962.8018599070506, 3979.3235150024566, 5334.91997620036, 5372.194170874322, 5381.54256888161, 5401.02781499326, 5462.126059830408, 5703.600747947687, 5710.428957104256, 5712.800051998243, 5713.885722285531, 5719.5996280260815, 5347.465253474621, 5357.517823395913, 5362.088444964365, 5363.356397232279, 5461.726913654302, 4778.689385189951, 4838.516148385203, 4947.950520494749, 4982.277569752366, 5003.049420610072, 5964.075568286922, 5968.46283834457, 5968.910466342922, 5985.0124729420895, 6025.0661147522205, 5709.68596727184, 5767.9711601443405, 5770.278715160605, 5774.56690748204, 5775.393583673654, 5711.685857277889, 5754.482096611325, 5765.279340082489, 5884.0, 5902.498287645427, 5634.0, 5690.260266165372, 5743.885122297447, 5748.9425105748405, 5751.252337196138, 5765.336986246635, 5780.075187969905, 5780.624259423124, 5785.190073389813, 5800.419958004166, 5369.221462887781, 5621.971890140687, 5639.097744360883, 5640.069388551007, 5644.407337229532, 5432.212329212163, 5493.606750314202, 5520.033994050945, 5527.474889885454, 5530.944690553043, 5516.668999860021, 5522.751476183501, 5528.0, 5528.80649177293, 5533.114701647717, 5404.351477822686, 5407.432219616883, 5444.673319600836, 5539.335279766293, 5580.5535557156145, 5308.0, 5352.277442545206, 5353.4646535346155, 5355.6786592803, 5394.379646340721], "value": 5264.736386839842, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.5792687192094, 609.1593600830853, 617.0374216222693, 623.7504998000799, 629.1820633176872, 30719.84640076802, 41253.58746412535, 42087.0, 42166.57833421665, 44942.0, 42064.57935420652, 42490.7875460623, 42511.0, 42532.36201456981, 42732.57267427325, 8670.306375489961, 8826.955865220698, 8830.779230519223, 8832.425892317011, 8835.249003834682, 7792.961035194844, 7962.880556791652, 10229.283950123494, 10478.895211047906, 10481.371117732922, 10572.471376431185, 10660.626878059269, 10662.147028237723, 10664.78670426591, 10668.0, 10494.737631559196, 10508.632197873114, 10564.26050176484, 10569.577216911315, 10583.523741431654, 10426.914617076614, 10484.423356715377, 10495.265331426803, 10496.055355018008, 10497.632582859564, 40581.39127913084, 40715.796421018, 40873.59126408728, 40888.79555602233, 40919.59080409217, 2936.9559456607954, 2942.6615939167054, 2989.8355590442516, 3488.0930957951114, 3517.3492903812876, 30160.396792064035, 30325.848370758227, 30928.845355773075, 31939.25093483172, 32835.50746738801, 3913.5890731473355, 4050.4734384530116, 4052.230076285496, 4149.481314835645, 4217.051163488221, 310096.0, 312813.0, 315153.42423287965, 315936.0, 317318.0, 57357.0, 57719.71140144272, 57806.0, 57820.421795781505, 57840.71079644575, 33546.49680254798, 33905.830470847985, 34227.65772342295, 35450.82274588611, 59936.40063599395, 14008.439662413593, 14107.576772696835, 14137.717245655029, 14187.432502699776, 14188.64528386778, 9064.773380665405, 10408.115310198567, 10451.372917624967, 10458.52936617854, 10464.372137671764, 15883.126428046568, 17668.469945901645, 18094.457166285032, 18259.63480730378, 18872.0, 6786.491013174032, 6959.406791517574, 7039.36645701879, 7058.505904586629, 7100.970039660699, 933.9252859771202, 973.4354074636693, 988.9505524723735, 1041.2086814021247, 1061.9415932123807, 30526.69473305283, 30590.23524411863, 30674.07977760671, 30912.0, 31145.377092458024, 1039.3504059962524, 1071.373246650718, 1071.4696225368336, 1087.1140020882956, 1146.3981409759942, 15927.0, 16306.918465407596, 16791.664166716597, 16826.158692065346, 17479.300827966737, 471806.0, 472515.0, 474601.0, 474977.0, 475615.0, 54084.72957635186, 54526.45473545293, 54599.18101228485, 54630.18054729182, 54642.45357546374, 1282.7354383095046, 1285.8392700912386, 1289.6969212235117, 1321.3327269728918, 1321.6761893336002, 28451.715482844906, 30831.845840770653, 31072.0, 31230.843845780626, 31634.525482117326, 47303.763481182374, 48078.27882581694, 48196.7590162047, 48289.27566086441, 48337.0, 414325.0, 417008.0, 417203.0, 418082.0, 418197.0, 22880.885595571915, 24862.37844053913, 25023.624645629967, 25589.0, 25634.487310253317, 37711.62288377081, 41160.0, 41942.370864436445, 42732.57267427286, 45798.77100614476, 36442.453363200104, 37445.0, 37551.43672844964, 38541.0, 38872.805635971636, 37100.81449592735, 37484.43773343347, 37647.623523764414, 38417.61582384141, 39018.0, 37237.44143837791, 37782.2443551133, 37935.43096853494, 38391.0, 38575.0, 33632.83183584164, 35704.0, 36692.266154677294, 36709.44935825912, 36812.0, 27022.189334320003, 27376.178714638594, 27407.314817129733, 27536.724632754216, 27622.309442264104], "value": 19123.992986586825, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.37456264256224, 369.1325385344441, 372.43761919501543, 376.8963535027867, 394.68228076398503, 14132.0, 17707.64584708305, 18486.537836554075, 18655.720164197548, 19540.31608893689, 16483.83516164838, 16893.83106168938, 16924.915375423137, 16996.49010529683, 17773.11134443276, 4471.977640111795, 4910.950890491085, 4942.950570494285, 4964.528369804881, 4968.975155124219, 3758.609314553605, 4919.065377578248, 4948.010397920412, 4953.083679519283, 4954.108260513106, 3914.8042597870135, 3934.449177115206, 6267.561270711052, 6327.367263273659, 6344.524160687944, 5481.808136715235, 5949.018411962064, 6283.937160628381, 6307.716152773113, 6309.77915772948, 5332.226827110087, 5343.145096784535, 5354.9196762048605, 5359.437259087817, 5361.731913404353, 17970.281188752433, 19649.9017504913, 22273.331800046024, 22342.888285558467, 22438.439039024153, 1959.0988145452966, 2088.1021160900805, 2127.4787677019076, 2329.5108027314286, 2523.3313172009434, 9125.406848554823, 9250.444973301623, 12723.363831808372, 13116.622754610818, 13579.864201358057, 1627.9430219942365, 1679.8236185200622, 1685.2163743859041, 1685.7808484897007, 1780.1788152740596, 78232.0, 80482.59758701228, 80536.0, 81764.0, 83015.5849220756, 10210.285280030475, 10224.335418197794, 10296.485175741183, 10323.948380258202, 10442.2168337375, 14286.0, 14287.928560357339, 14288.42846286137, 14310.57068287953, 14321.78517322241, 6995.370416662525, 7052.612106334201, 7222.891656625155, 7282.453815963718, 7356.043714317105, 6573.868522629521, 6658.738407419256, 6821.079154314104, 6827.0, 6838.179418469816, 4270.231358355526, 4378.277584198571, 4383.975057210515, 4470.105978804252, 4498.685092043525, 1686.4568919438577, 1779.7330400440037, 1787.5263055290359, 1810.6831304521656, 1814.5917168636952, 905.8595917632778, 919.3977944446399, 952.7237101240563, 986.6891929042329, 1015.0052948110745, 17371.565710857078, 18554.72167917482, 18710.625787484176, 18914.810851891303, 19243.326483573008, 896.9237614802815, 938.6198589571235, 945.6030449607579, 967.820225164316, 1001.1590264178126, 10179.7455063624, 10407.843882341771, 10522.421266830244, 10525.21060920434, 10546.103581195532, 465711.0, 505098.0, 514920.0, 525219.0, 528508.0, 89427.55286223527, 92636.07363926274, 93949.0, 94390.52804735933, 98407.0, 973.4500007495742, 996.7657600463886, 1027.3938376357985, 1031.4224034540532, 1031.7059638003134, 16366.427175049292, 16432.424865129662, 16926.746098808773, 17506.299748009937, 17622.211224586776, 39424.0, 40242.396364055145, 40882.38676419915, 41047.38428923509, 41822.58177418187, 55313.44686553083, 56328.0, 56852.14721779094, 57674.134887977554, 58373.0, 6976.407005404598, 7619.238076192337, 7626.733064342721, 7684.731034413992, 8138.796530086795, 12186.329751863732, 12620.368981550702, 12823.294718790183, 12897.48410063587, 13254.698120751777, 11192.824753400775, 11271.718207044561, 11744.94127529357, 11931.642050738492, 12034.75930481403, 11006.944965275123, 11296.096312295162, 11584.768304634028, 11624.302541847515, 11636.534303959803, 11297.774044519228, 11360.602378916697, 11366.147538934778, 11827.763444731228, 12139.332336721565, 6986.580805151707, 7148.499605027599, 7158.606276654834, 7188.245234250538, 7562.810929726801, 8321.542315172723, 11264.66206013821, 11295.943520282346, 11695.298282103102, 11794.705132371759], "value": 8717.771289949738, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.3387839141233, 1434.3115304653763, 1493.6863258715669, 1584.0, 1757.4376199616129, 7910.881336779946, 8717.738467845968, 8920.107989201077, 8987.550622468883, 9194.954025229865, 9056.275497960163, 9107.225885799699, 9127.178553930145, 9133.497657628828, 9136.954315228431, 2212.2810086721797, 2232.263353093483, 2239.540894116702, 2240.8767517786514, 2241.7421996470453, 2160.79472450117, 2191.7808219178114, 2203.900824462895, 2215.82273418127, 2216.789405006522, 2185.7595664476894, 2225.6327705928584, 2238.3956331790405, 2252.5044490212126, 2276.9203077892194, 1991.9900400497977, 2012.597480503905, 2012.7383440152687, 2016.7176595276674, 2026.7567891852925, 2155.493459037125, 2186.9453263668374, 2199.538096999632, 2256.8194544436406, 2261.231181398316, 8969.058248883905, 9108.089191080906, 9148.817023659489, 9159.679411220575, 9169.816603667889, 4998.10034193845, 5190.792368305263, 5196.792128314863, 5201.531862132389, 5215.817446389358, 3241.38413701396, 3384.729221662261, 3405.642407547197, 3420.1278673938236, 3438.2435864109857, 1078.730317420645, 1097.078454098553, 2046.703228031942, 2100.684897265407, 2147.066026278558, 12724.745505089846, 12802.0, 12813.359332033455, 12855.807162892565, 12910.806337905033, 4084.611961863618, 4197.307444271661, 4356.08522210333, 4357.106793107406, 4370.8907277317685, 9876.0, 9878.851817222747, 9888.357256778287, 9890.653827116017, 9913.058259465339, 5055.494450554988, 5062.924056139161, 5065.848024559269, 5067.391912970394, 5067.670601410897, 4128.153728485653, 4152.086540960984, 4742.5020372861045, 4768.1417344878255, 4768.213244814636, 3712.777233366007, 3731.477593136963, 3846.6345697158727, 3853.903652408656, 3875.5736868944396, 1055.7518983038979, 1059.904608585231, 1062.2033474893828, 1064.6060957445795, 1080.935143891369, 789.5223389849059, 860.1355637584313, 905.6196397513061, 936.9875849144895, 941.802221533472, 5749.281339832521, 5847.649141051551, 5873.618214816023, 5959.28488581373, 6090.421409966046, 386.63076761692514, 387.5020598530874, 396.03367782610337, 396.26295091130476, 405.4971834924731, 3797.9430308545393, 3890.7471014383973, 3914.8434062637175, 3918.0988372673874, 3928.332183528807, 11048.613298534512, 11217.15871309655, 11312.151588630886, 11322.490487928064, 11446.656600302003, 11220.0, 11268.211225214156, 11271.605493807841, 11276.1542884284, 11286.435678216221, 8113.052867311802, 8285.337173026144, 8403.285720713808, 8440.0, 8444.873326900102, 5825.242718446575, 5978.730957106854, 6051.4553690168095, 6052.455279024909, 6121.693915304306, 10439.37363758177, 10520.0, 10526.789464210826, 10537.683869483928, 10681.89318106809, 9771.560279787569, 10256.12822910061, 10286.691399258034, 10589.682309530726, 10597.0, 7094.858102838018, 7278.818029549304, 7816.84366312682, 7954.801129971797, 7994.880076798736, 8302.128276531119, 8522.616482258438, 8593.44142630727, 8786.560671966248, 8799.648014079621, 7757.3794096473275, 7917.293008531678, 7929.207079292025, 8070.394720395876, 8111.0, 7565.773026809205, 7639.350655194371, 7743.070831500031, 7796.88304675419, 7804.9219507806465, 7062.682179302046, 7181.35367816899, 7192.604406757679, 7195.496315257882, 7204.855902882018, 5312.362516498045, 5334.653247538898, 5380.650257733235, 5411.134218525017, 5514.448555144453, 5289.41816400188, 5398.892022159614, 5452.972735136299, 5531.751071201886, 5569.693666848362], "value": 4516.9990030670015, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.81380706093995, 325.1383832842966, 331.52260744527877, 333.79972016789924, 339.5907930943214, 5050.772715227814, 5206.0, 5240.563138140768, 5244.816431424901, 5258.605604579653, 5061.468545802683, 5156.149235376168, 5175.637705360627, 5182.8704282392955, 5183.2743415921805, 4089.670856971489, 4092.242935057024, 4095.4061661059127, 4101.118259574191, 4102.17956408718, 3816.656500914917, 3956.1889812588493, 4097.631213190813, 4100.835966561334, 4107.630313271805, 3999.70002249831, 4062.6546743526687, 4086.5300490443683, 4086.5504794472586, 4099.626625080602, 4074.246264441073, 4077.16527562598, 4080.5715399882884, 4083.9183216335805, 4099.73351732138, 3630.8547658093644, 3633.818309084562, 3637.563492380905, 3639.4358874374516, 3645.179834537208, 4911.852644420673, 5045.520675535819, 5062.898742025139, 5080.79676812927, 5085.694858308513, 4660.8539236015895, 4665.510121437234, 4672.13565490382, 4675.345451636774, 4677.976610116928, 5431.972840135813, 5440.401555828856, 5445.0, 5463.562914966793, 5496.5053145217125, 3778.2065766189135, 3942.073612701013, 3942.7634341939574, 3958.604139586047, 3977.34373828318, 5684.602077854552, 5708.77164913403, 5715.199872017921, 5720.998825205573, 5724.713764311809, 4027.395890616431, 4037.152198038445, 4042.049304008032, 4045.352743561075, 4070.8371665133063, 3897.8440862365755, 3989.5810939851476, 4026.697997650188, 4043.211573743151, 4136.751794892316, 4592.196365636, 4597.586217240464, 4605.0067456153765, 4623.676342656049, 4631.421072365954, 5454.863628409242, 5483.150111732688, 5541.695206763586, 5577.414371491016, 5581.358143813432, 1367.685432350565, 1383.584924522639, 1396.7695330270392, 1401.5444980381417, 1404.9297535123408, 865.8181781825762, 887.7780554861284, 895.2882458445551, 903.8192361527721, 905.2531661379388, 4669.276262179367, 4679.4618618858585, 4688.57802797743, 4691.724513610896, 4702.694324868872, 4833.341662085839, 4896.167651499253, 4922.4093108826455, 4943.0, 5009.699418034929, 4424.915895605597, 4592.6555508337005, 4636.814527418933, 4645.095510840607, 4666.696664716783, 2591.961120583193, 2619.777318927874, 2656.1633085577982, 2656.6015097735494, 2659.295286749013, 5062.519060689228, 5134.921666450013, 5136.614753893398, 5173.456787037307, 5178.896422071537, 4847.878803029953, 4918.311436398907, 5106.804074248034, 5116.232565115188, 5127.66670166438, 4962.305277261186, 5017.043353092297, 5050.242463630485, 5084.601734522962, 5091.0, 4906.901861962812, 4916.729579873141, 4933.8158841876975, 4946.975265123651, 4954.628402869727, 4689.390379250675, 4904.6566740327835, 4908.8954985129485, 4910.558049775537, 4911.312416261798, 5031.0, 5071.518205770446, 5081.441041485507, 5101.617378696538, 5115.335006449287, 3604.4953706480587, 3629.219717760694, 3646.2525182337026, 3662.2675464907657, 3801.4297855321925, 5488.286522752017, 5509.779608815603, 5586.217929489956, 5593.0, 5642.576806739593, 5452.291202143696, 5457.399686034453, 5458.426865179099, 5461.508464238079, 5491.929073830564, 5228.085085110167, 5432.913417316474, 5450.291462109901, 5454.89986355264, 5474.3704473986, 5371.919421208763, 5378.811741589026, 5402.783888644411, 5460.235567020541, 5467.043267428264, 5477.123660214346, 5484.424135465878, 5504.9449505504435, 5506.788506528717, 5533.916991245215, 5212.582993360446, 5352.384475785335, 5366.9873797326, 5381.757820898148, 5390.326209223847], "value": 4017.806341191165, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.1231244726055, 649.4252586460981, 649.779075114461, 668.8461653819625, 706.7879636109169, 12257.264564126148, 13131.1464754791, 13143.211407315568, 13263.867361326384, 13337.0, 12644.936775316133, 12739.745205095893, 12747.362631868416, 12784.360781960888, 12796.744065118692, 786.3237615650551, 808.2483290539795, 809.6639894443799, 811.4441607498882, 811.5090370325956, 659.9439047680953, 674.1505702814464, 793.4604468961104, 793.8055176481741, 796.5698522797683, 841.877927700483, 843.9156084391542, 844.5144042175742, 849.6643825688849, 850.2220468271524, 840.5671079394117, 843.2663582683074, 845.1843970568369, 846.5640195299426, 846.6740304982595, 504.1228262822699, 512.6821370750122, 516.4602989875589, 522.156716902204, 606.2240332374568, 11329.376884271362, 11334.319940803578, 11344.886551134548, 11427.0, 11583.536658533649, 13423.731525369536, 13946.093503922313, 13971.65070873226, 14062.92968535161, 14108.4816837168, 12534.185277956904, 12535.0, 12535.122541422104, 12786.61640150797, 13195.868041319656, 4274.700770946035, 4314.654827613815, 4341.435613370273, 4372.256716358227, 4567.794449249792, 79770.0, 79825.0, 80578.5971070141, 82853.0, 83409.58295208485, 10451.163906887583, 10703.946480267548, 10791.514381852836, 10802.783944321069, 11030.448477576088, 21169.364919052452, 21291.36125916225, 21468.248611298528, 21794.673079903812, 21823.454413639785, 7186.604736739425, 7991.56046417441, 8095.676172953016, 8143.0, 8217.54803485802, 4425.645948324126, 4476.149531588988, 4680.180968330528, 4699.318598803155, 4762.452317983476, 3067.55520449538, 3185.0444866539947, 3187.5815262208557, 3190.6968837960358, 3195.201199700075, 577.3850848845966, 580.9012467880386, 581.1892410087988, 582.3070546050187, 582.9504492118217, 463.6893281501402, 512.3134999101222, 553.2669213292404, 624.4348864277836, 636.3000699230809, 8873.51541568362, 8971.685990990283, 9359.344845860724, 9359.812803744024, 9479.857802132974, 545.7762317449826, 610.2951091489336, 615.7013848283578, 627.5136769003967, 650.5836264790538, 4004.6796256299426, 4477.955220447819, 4482.708623939434, 4517.932231016537, 4528.43394575678, 114733.0, 115920.0, 119528.40235798765, 120108.39945800215, 120319.39840300742, 102994.48502757438, 103302.0, 103584.0, 103782.48108759407, 107892.46053769838, 71369.64315178494, 71883.0, 71896.28103719105, 91336.0, 95008.52495737615, 9258.166764991183, 9804.607815687577, 10051.214471832203, 10124.645637402655, 10143.442110683984, 45893.77053114713, 47325.763371182926, 47855.5214447865, 47897.5210247907, 47999.04001920012, 72746.63626681833, 75218.0, 75984.24015759771, 76507.31600022093, 76927.23072769424, 11456.599019034295, 11493.138014648768, 11585.420728963687, 11601.129915256559, 12341.3829308536, 12524.311162886128, 13447.327633618084, 13672.726545468837, 13937.163770173822, 13941.0, 13461.663458413226, 13872.722545549233, 14023.298835058411, 14246.242538595305, 14440.855591444371, 10063.748406289902, 12597.811032834697, 12639.304838233618, 13134.343282836011, 13586.0, 12681.556145534862, 13918.164910105426, 14312.427502899767, 14347.210903400413, 14392.42430302818, 11101.833472498081, 11447.198696091195, 11464.25482343645, 11600.332376341465, 12171.75656486883, 11592.6522204334, 11897.821532676844, 11980.880191198325, 12121.393930303626, 12167.939160304142], "value": 7196.324830034967, "unit": "score"}], "name": "dromaeo_css", "value": 6969.891656016996, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 111.0, 111.0, 111.0, 111.0, 111.0, 110.0, 111.0, 109.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 131.0, 162.0, 127.0, 123.0, 130.0, 123.0, 179.0, 122.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 161.0, 160.0, 163.0, 161.0, 162.0, 161.0, 161.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 105.0, 76.0, 76.0, 76.0, 75.0, 97.0, 76.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 116.0, 83.0, 82.0, 84.0, 104.0, 83.0, 84.0, 112.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 148.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 85.0, 86.0, 84.0, 84.0, 84.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 53.0, 55.0, 52.0, 53.0, 54.0, 53.0, 53.0, 55.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 81.0, 79.0, 80.0, 81.0, 80.0, 89.0, 81.0, 81.0, 80.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 141.0, 139.0, 132.0, 134.0, 130.0, 141.0, 138.0, 182.0, 140.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 165.0, 164.0, 167.0, 168.0, 166.0, 171.0, 167.0, 175.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 66.0, 67.0, 66.0, 65.0, 66.0, 67.0, 68.0, 65.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1498.6000000000001, "alertThreshold": 2.0}]} 13:23:04 INFO - Return code: 0 13:23:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:23:04 INFO - # TBPL SUCCESS # 13:23:04 INFO - Running post-action listener: _resource_record_post_action 13:23:04 INFO - [mozharness: 2016-10-19 20:23:04.666139Z] Finished run-tests step (success) 13:23:04 INFO - Running post-run listener: _resource_record_post_run 13:23:04 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 407535616; Read time: 0; Write time: 340444 13:23:04 INFO - TinderboxPrint: CPU usage
13.1% 13:23:04 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:23:04 INFO - TinderboxPrint: I/O write bytes / time
407,535,616 / 340,444 13:23:04 INFO - TinderboxPrint: CPU idle
8,301.2 (86.8%) 13:23:04 INFO - TinderboxPrint: CPU user
1,204.6 (12.6%) 13:23:04 INFO - TinderboxPrint: Swap in / out
0 / 0 13:23:04 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 119705600; Read time: 0; Write time: 115432 13:23:04 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 287215616; Read time: 0; Write time: 225012 13:23:05 INFO - Running post-run listener: _upload_blobber_files 13:23:05 INFO - Blob upload gear active. 13:23:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:23:05 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 13:23:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:23:05 INFO - (blobuploader) - INFO - Open directory for files ... 13:23:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:23:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:23:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:23:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:23:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:23:06 INFO - (blobuploader) - INFO - Done attempting. 13:23:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:23:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:23:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:23:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:23:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:23:10 INFO - (blobuploader) - INFO - Done attempting. 13:23:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:23:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:23:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:23:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:23:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:23:11 INFO - (blobuploader) - INFO - Done attempting. 13:23:11 INFO - (blobuploader) - INFO - Iteration through files over. 13:23:11 INFO - Return code: 0 13:23:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:23:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:23:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e365ca4ee3abfab1b9be42f2ae6e90ecb68151b46d503efcc516201aa23b0912c38ae8754ea95a3f4c5490e3ef5ec6dfe66fab83cfffd569df78f670fcd6449b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16d58ebd2593345d604a189e7610d4a8b43724e6a44befebfd34834406ab5fc8ed5a888753ffaa7144087ee603d1e87a03d406b206e65891be42d222b0bb6963", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ed05e55566fb732fda834e99b89efecbff865b063890c70848f873fe31480fce77fe1c4511fa61b4a0bd3db1f82fc2535e2094c7c7dd51a059ff08357f09901"} 13:23:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:23:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:23:11 INFO - Contents: 13:23:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e365ca4ee3abfab1b9be42f2ae6e90ecb68151b46d503efcc516201aa23b0912c38ae8754ea95a3f4c5490e3ef5ec6dfe66fab83cfffd569df78f670fcd6449b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16d58ebd2593345d604a189e7610d4a8b43724e6a44befebfd34834406ab5fc8ed5a888753ffaa7144087ee603d1e87a03d406b206e65891be42d222b0bb6963", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ed05e55566fb732fda834e99b89efecbff865b063890c70848f873fe31480fce77fe1c4511fa61b4a0bd3db1f82fc2535e2094c7c7dd51a059ff08357f09901"} 13:23:11 INFO - Running post-run listener: copy_logs_to_upload_dir 13:23:11 INFO - Copying logs to upload dir... 13:23:11 INFO - mkdir: /builds/slave/test/build/upload/logs 13:23:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.351212 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-19 13:23:11.124669) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 13:23:11.130137) ========= 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=920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e365ca4ee3abfab1b9be42f2ae6e90ecb68151b46d503efcc516201aa23b0912c38ae8754ea95a3f4c5490e3ef5ec6dfe66fab83cfffd569df78f670fcd6449b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16d58ebd2593345d604a189e7610d4a8b43724e6a44befebfd34834406ab5fc8ed5a888753ffaa7144087ee603d1e87a03d406b206e65891be42d222b0bb6963", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ed05e55566fb732fda834e99b89efecbff865b063890c70848f873fe31480fce77fe1c4511fa61b4a0bd3db1f82fc2535e2094c7c7dd51a059ff08357f09901"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011569 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476894604/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e365ca4ee3abfab1b9be42f2ae6e90ecb68151b46d503efcc516201aa23b0912c38ae8754ea95a3f4c5490e3ef5ec6dfe66fab83cfffd569df78f670fcd6449b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16d58ebd2593345d604a189e7610d4a8b43724e6a44befebfd34834406ab5fc8ed5a888753ffaa7144087ee603d1e87a03d406b206e65891be42d222b0bb6963", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ed05e55566fb732fda834e99b89efecbff865b063890c70848f873fe31480fce77fe1c4511fa61b4a0bd3db1f82fc2535e2094c7c7dd51a059ff08357f09901"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 13:23:11.156275) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 13:23:11.156617) ========= 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=920470bf432669ad7e3a5387000001ca-1476907350.394206-162845551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 13:23:11.238618) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 13:23:11.238943) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 13:23:11.239233) ========= ========= Total master_lag: 0.16 =========