builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1477187227.26 results: success (0) buildid: 20161022183235 builduid: 5d695478ecae4e82b515f91ee934f820 revision: 60dd82380d43a2b681f50842238f829204486290 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-22 18:47:07.264589) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-22 18:47:07.265038) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-22 18:47:07.265336) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-22 18:47:07.279716) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 18:47:07.280014) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-22 18:47:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-10-22 18:47:08 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106561 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 18:47:07.400186) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 18:47:07.400518) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014800 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 18:47:07.450297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-22 18:47:07.450668) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 60dd82380d43a2b681f50842238f829204486290 --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 60dd82380d43a2b681f50842238f829204486290 --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=d6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-22 18:47:08,332 truncating revision to first 12 chars 2016-10-22 18:47:08,332 Setting DEBUG logging. 2016-10-22 18:47:08,332 attempt 1/10 2016-10-22 18:47:08,332 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/60dd82380d43?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-22 18:47:09,833 unpacking tar archive at: fx-team-60dd82380d43/testing/mozharness/ program finished with exit code 0 elapsedTime=1.802121 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-22 18:47:09.266554) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-22 18:47:09.266879) ========= script_repo_revision: 60dd82380d43a2b681f50842238f829204486290 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-22 18:47:09.267275) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-22 18:47:09.267557) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-22 18:47:09.277284) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-22 18:47:09.277589) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:47:10 INFO - MultiFileLogger online at 20161022 18:47:10 in /builds/slave/test 18:47:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:47:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:47:10 INFO - {'append_to_log': False, 18:47:10 INFO - 'base_work_dir': '/builds/slave/test', 18:47:10 INFO - 'blob_upload_branch': 'Fx-Team', 18:47:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:47:10 INFO - 'branch': 'Fx-Team', 18:47:10 INFO - 'buildbot_json_path': 'buildprops.json', 18:47:10 INFO - 'config_files': ('talos/linux_config.py',), 18:47:10 INFO - 'default_actions': ('clobber', 18:47:10 INFO - 'read-buildbot-config', 18:47:10 INFO - 'download-and-extract', 18:47:10 INFO - 'populate-webroot', 18:47:10 INFO - 'create-virtualenv', 18:47:10 INFO - 'install', 18:47:10 INFO - 'run-tests'), 18:47:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:47:10 INFO - 'download_minidump_stackwalk': True, 18:47:10 INFO - 'download_symbols': 'ondemand', 18:47:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:47:10 INFO - 'tooltool.py': '/tools/tooltool.py', 18:47:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:47:10 INFO - '/tools/misc-python/virtualenv.py')}, 18:47:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:47:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:47:10 INFO - 'installer_path': 'installer.exe', 18:47:10 INFO - 'log_level': 'info', 18:47:10 INFO - 'log_name': 'talos', 18:47:10 INFO - 'log_to_console': True, 18:47:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:47:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:47:10 INFO - 'opt_config_files': (), 18:47:10 INFO - 'pip_index': False, 18:47:10 INFO - 'sps_profile': False, 18:47:10 INFO - 'sps_profile_interval': 0, 18:47:10 INFO - 'suite': 'dromaeojs', 18:47:10 INFO - 'system_bits': '32', 18:47:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:47:10 INFO - 'title': 'talos-linux64-ix-034', 18:47:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:47:10 INFO - 'use_talos_json': True, 18:47:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:47:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:47:10 INFO - 'work_dir': 'build'} 18:47:10 INFO - [mozharness: 2016-10-23 01:47:10.260448Z] Running clobber step. 18:47:10 INFO - Running pre-action listener: _resource_record_pre_action 18:47:10 INFO - Running main action method: clobber 18:47:10 INFO - rmtree: /builds/slave/test/build 18:47:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:47:11 INFO - Running post-action listener: _resource_record_post_action 18:47:11 INFO - [mozharness: 2016-10-23 01:47:11.232705Z] Finished clobber step (success) 18:47:11 INFO - [mozharness: 2016-10-23 01:47:11.232804Z] Running read-buildbot-config step. 18:47:11 INFO - Running pre-action listener: _resource_record_pre_action 18:47:11 INFO - Running main action method: read_buildbot_config 18:47:11 INFO - Using buildbot properties: 18:47:11 INFO - { 18:47:11 INFO - "project": "", 18:47:11 INFO - "product": "firefox", 18:47:11 INFO - "script_repo_revision": "production", 18:47:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:47:11 INFO - "repository": "", 18:47:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 18:47:11 INFO - "buildid": "20161022183235", 18:47:11 INFO - "stage_platform": "linux64-pgo", 18:47:11 INFO - "basedir": "/builds/slave/test", 18:47:11 INFO - "buildnumber": 1653, 18:47:11 INFO - "platform": "ubuntu64_hw", 18:47:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:47:11 INFO - "slavebuilddir": "test", 18:47:11 INFO - "branch": "fx-team", 18:47:11 INFO - "revision": "60dd82380d43a2b681f50842238f829204486290", 18:47:11 INFO - "slavename": "talos-linux64-ix-034", 18:47:11 INFO - "builduid": "5d695478ecae4e82b515f91ee934f820", 18:47:11 INFO - "repo_path": "integration/fx-team" 18:47:11 INFO - } 18:47:11 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477175402/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:47:11 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477175402/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 18:47:11 INFO - Running post-action listener: _resource_record_post_action 18:47:11 INFO - [mozharness: 2016-10-23 01:47:11.235571Z] Finished read-buildbot-config step (success) 18:47:11 INFO - [mozharness: 2016-10-23 01:47:11.235659Z] Running download-and-extract step. 18:47:11 INFO - Running pre-action listener: _resource_record_pre_action 18:47:11 INFO - Running main action method: download_and_extract 18:47:11 INFO - mkdir: /builds/slave/test/build/tests 18:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:11 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477175402/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:47:11 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477175402/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:47:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477175402/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:47:11 INFO - Downloaded 1361 bytes. 18:47:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:47:11 INFO - Using the following test package requirements: 18:47:11 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:47:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:47:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:47:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:11 INFO - u'jsshell-linux-x86_64.zip'], 18:47:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:47:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:47:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:47:11 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:47:11 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:47:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:47:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:47:11 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/1477175402/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:47:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477175402/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:47:11 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477175402/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:47:11 INFO - Http code: 200 18:47:11 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 18:47:11 INFO - x-amz-cf-id: qzA3xgfRygdlJLXLrR4IAOJnivbgcJX3sFEDTY23wJKevXqNd-Lhsg== 18:47:11 INFO - x-amz-replication-status: PENDING 18:47:11 INFO - x-amz-version-id: IvxZtBxEFjAwxb.Vi3yHN3uWZDMwvgFO 18:47:11 INFO - Expected file size: 22032383 18:47:11 INFO - Obtained file size: 22032383 18:47:15 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:47:15 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/1477175402/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:47:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477175402/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:47:15 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477175402/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:47:15 INFO - Http code: 200 18:47:15 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 18:47:15 INFO - x-amz-cf-id: OL94TrneBu0JRXo6yn7UhmEMk55HIJSqdwHVWWDUakTcSW-kOFR8XA== 18:47:15 INFO - x-amz-replication-status: PENDING 18:47:15 INFO - x-amz-version-id: IvxZtBxEFjAwxb.Vi3yHN3uWZDMwvgFO 18:47:16 INFO - Expected file size: 22032383 18:47:16 INFO - Obtained file size: 22032383 18:47:20 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/1477175402/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:47:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477175402/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:47:20 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477175402/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:47:20 INFO - Http code: 200 18:47:20 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 18:47:20 INFO - x-amz-cf-id: J0G6pzbXQpwBF67RXmL3yRTn9PfUTX9YfcZtsBoZoHMJ6z_nvSJvxQ== 18:47:20 INFO - x-amz-replication-status: PENDING 18:47:20 INFO - x-amz-version-id: aw3LmL8H455Aiokt9A9RXdV8rznKWllX 18:47:20 INFO - Expected file size: 14409028 18:47:20 INFO - Obtained file size: 14409028 18:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:21 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477175402/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:47:21 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477175402/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:47:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477175402/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:47:21 INFO - Downloaded 59343322 bytes. 18:47:21 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477175402/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:47:21 INFO - mkdir: /builds/slave/test/properties 18:47:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:47:21 INFO - Writing to file /builds/slave/test/properties/build_url 18:47:21 INFO - Contents: 18:47:21 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477175402/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:47:21 INFO - Running post-action listener: _resource_record_post_action 18:47:21 INFO - Running post-action listener: set_extra_try_arguments 18:47:21 INFO - [mozharness: 2016-10-23 01:47:21.902084Z] Finished download-and-extract step (success) 18:47:21 INFO - [mozharness: 2016-10-23 01:47:21.902312Z] Running populate-webroot step. 18:47:21 INFO - Running pre-action listener: _resource_record_pre_action 18:47:21 INFO - Running main action method: populate_webroot 18:47:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:47:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:47:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:47:21 INFO - '--tppagecycles', 18:47:21 INFO - '7'], 18:47:21 INFO - 'tests': ['tsvgm']}}, 18:47:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:47:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:47:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:47:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:47:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:47:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:47:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:21 INFO - 'talos_options': ['--disable-e10s'], 18:47:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:47:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:47:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:21 INFO - 'talos_options': ['--disable-e10s'], 18:47:21 INFO - 'tests': ['damp', 'tps']}, 18:47:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:21 INFO - 'tests': ['damp', 'tps']}, 18:47:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:47:21 INFO - 'tests': ['dromaeo_dom']}, 18:47:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:47:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:47:21 INFO - 'tests': ['basic_compositor_video']}, 18:47:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:47:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:47:21 INFO - 'tests': ['a11yr', 18:47:21 INFO - 'ts_paint', 18:47:21 INFO - 'tpaint', 18:47:21 INFO - 'sessionrestore', 18:47:21 INFO - 'sessionrestore_no_auto_restore', 18:47:21 INFO - 'tabpaint']}, 18:47:21 INFO - 'other-e10s': {'tests': ['a11yr', 18:47:21 INFO - 'ts_paint', 18:47:21 INFO - 'tpaint', 18:47:21 INFO - 'sessionrestore', 18:47:21 INFO - 'sessionrestore_no_auto_restore', 18:47:21 INFO - 'tabpaint']}, 18:47:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:47:21 INFO - 'ts_paint', 18:47:21 INFO - 'tpaint', 18:47:21 INFO - 'sessionrestore', 18:47:21 INFO - 'sessionrestore_no_auto_restore', 18:47:21 INFO - 'tabpaint']}, 18:47:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:47:21 INFO - 'ts_paint', 18:47:21 INFO - 'tpaint', 18:47:21 INFO - 'sessionrestore', 18:47:21 INFO - 'sessionrestore_no_auto_restore', 18:47:21 INFO - 'tabpaint']}, 18:47:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:47:21 INFO - 'tests': ['a11yr', 18:47:21 INFO - 'ts_paint', 18:47:21 INFO - 'tpaint', 18:47:21 INFO - 'sessionrestore', 18:47:21 INFO - 'sessionrestore_no_auto_restore', 18:47:21 INFO - 'tabpaint']}, 18:47:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:47:21 INFO - 'tests': ['a11yr', 18:47:21 INFO - 'ts_paint', 18:47:21 INFO - 'tpaint', 18:47:21 INFO - 'sessionrestore', 18:47:21 INFO - 'sessionrestore_no_auto_restore', 18:47:21 INFO - 'tabpaint']}, 18:47:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:47:21 INFO - 'tests': ['tsvgx', 18:47:21 INFO - 'tsvgr_opacity', 18:47:21 INFO - 'tart', 18:47:21 INFO - 'tscrollx', 18:47:21 INFO - 'cart']}, 18:47:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:47:21 INFO - 'tsvgr_opacity', 18:47:21 INFO - 'tart', 18:47:21 INFO - 'tscrollx', 18:47:21 INFO - 'cart']}, 18:47:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:21 INFO - 'talos_options': ['--disable-e10s'], 18:47:21 INFO - 'tests': ['tp5o']}, 18:47:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:21 INFO - 'tests': ['tp5o']}, 18:47:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:21 INFO - 'talos_options': ['--disable-e10s', 18:47:21 INFO - '--xperf_path', 18:47:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:47:21 INFO - 'tests': ['tp5n']}, 18:47:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:21 INFO - 'talos_options': ['--xperf_path', 18:47:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:47:21 INFO - 'tests': ['tp5n']}}, 18:47:21 INFO - 'talos.zip': {'path': '', 18:47:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:47:21 INFO - Running post-action listener: _resource_record_post_action 18:47:21 INFO - [mozharness: 2016-10-23 01:47:21.918364Z] Finished populate-webroot step (success) 18:47:21 INFO - [mozharness: 2016-10-23 01:47:21.918452Z] Running create-virtualenv step. 18:47:21 INFO - Running pre-action listener: _resource_record_pre_action 18:47:21 INFO - Running main action method: create_virtualenv 18:47:21 INFO - Creating virtualenv /builds/slave/test/build/venv 18:47:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:47:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:47:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:47:22 INFO - Using real prefix '/usr' 18:47:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:47:22 INFO - Installing distribute.............................................................................................................................................................................................done. 18:47:24 INFO - Installing pip.................done. 18:47:24 INFO - Return code: 0 18:47:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:47:24 INFO - Reading from file tmpfile_stdout 18:47:24 INFO - Output received: 18:47:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:47:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:24 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 0x7fcef2fd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e9790>, '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 0x23ea690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eab20>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:47:24 INFO - Using env: {'DISPLAY': ':0', 18:47:24 INFO - 'HOME': '/home/cltbld', 18:47:24 INFO - 'LANG': 'en_US.UTF-8', 18:47:24 INFO - 'LANGUAGE': 'en_US:en', 18:47:24 INFO - 'LOGNAME': 'cltbld', 18:47:24 INFO - 'MAIL': '/var/mail/cltbld', 18:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:24 INFO - 'MOZ_NO_REMOTE': '1', 18:47:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:24 INFO - 'NO_EM_RESTART': '1', 18:47:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:24 INFO - 'PWD': '/builds/slave/test', 18:47:24 INFO - 'SHELL': '/bin/bash', 18:47:24 INFO - 'SHLVL': '1', 18:47:24 INFO - 'TERM': 'linux', 18:47:24 INFO - 'TMOUT': '86400', 18:47:24 INFO - 'USER': 'cltbld', 18:47:24 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 18:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:24 INFO - '_': '/tools/buildbot/bin/python'} 18:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:47:24 INFO - Cleaning up... 18:47:24 INFO - Return code: 0 18:47:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:24 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 0x7fcef2fd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e9790>, '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 0x23ea690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eab20>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:47:24 INFO - Using env: {'DISPLAY': ':0', 18:47:24 INFO - 'HOME': '/home/cltbld', 18:47:24 INFO - 'LANG': 'en_US.UTF-8', 18:47:24 INFO - 'LANGUAGE': 'en_US:en', 18:47:24 INFO - 'LOGNAME': 'cltbld', 18:47:24 INFO - 'MAIL': '/var/mail/cltbld', 18:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:24 INFO - 'MOZ_NO_REMOTE': '1', 18:47:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:24 INFO - 'NO_EM_RESTART': '1', 18:47:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:24 INFO - 'PWD': '/builds/slave/test', 18:47:24 INFO - 'SHELL': '/bin/bash', 18:47:24 INFO - 'SHLVL': '1', 18:47:24 INFO - 'TERM': 'linux', 18:47:24 INFO - 'TMOUT': '86400', 18:47:24 INFO - 'USER': 'cltbld', 18:47:24 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 18:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:24 INFO - '_': '/tools/buildbot/bin/python'} 18:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:25 INFO - Downloading/unpacking psutil>=3.1.1 18:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:47:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:47:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:47:27 INFO - Installing collected packages: psutil 18:47:27 INFO - Running setup.py install for psutil 18:47:27 INFO - building 'psutil._psutil_linux' extension 18:47:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:47:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:47:27 INFO - building 'psutil._psutil_posix' extension 18:47:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:47:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:47:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:47:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:47:27 INFO - Successfully installed psutil 18:47:27 INFO - Cleaning up... 18:47:27 INFO - Return code: 0 18:47:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:27 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 0x7fcef2fd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e9790>, '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 0x23ea690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eab20>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:47:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:47:27 INFO - Using env: {'DISPLAY': ':0', 18:47:27 INFO - 'HOME': '/home/cltbld', 18:47:27 INFO - 'LANG': 'en_US.UTF-8', 18:47:27 INFO - 'LANGUAGE': 'en_US:en', 18:47:27 INFO - 'LOGNAME': 'cltbld', 18:47:27 INFO - 'MAIL': '/var/mail/cltbld', 18:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:27 INFO - 'MOZ_NO_REMOTE': '1', 18:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:27 INFO - 'NO_EM_RESTART': '1', 18:47:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:27 INFO - 'PWD': '/builds/slave/test', 18:47:27 INFO - 'SHELL': '/bin/bash', 18:47:27 INFO - 'SHLVL': '1', 18:47:27 INFO - 'TERM': 'linux', 18:47:27 INFO - 'TMOUT': '86400', 18:47:27 INFO - 'USER': 'cltbld', 18:47:27 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 18:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:27 INFO - '_': '/tools/buildbot/bin/python'} 18:47:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:47:29 INFO - Installing collected packages: mozsystemmonitor 18:47:29 INFO - Running setup.py install for mozsystemmonitor 18:47:30 INFO - Successfully installed mozsystemmonitor 18:47:30 INFO - Cleaning up... 18:47:30 INFO - Return code: 0 18:47:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:30 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 0x7fcef2fd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e9790>, '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 0x23ea690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eab20>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:47:30 INFO - Using env: {'DISPLAY': ':0', 18:47:30 INFO - 'HOME': '/home/cltbld', 18:47:30 INFO - 'LANG': 'en_US.UTF-8', 18:47:30 INFO - 'LANGUAGE': 'en_US:en', 18:47:30 INFO - 'LOGNAME': 'cltbld', 18:47:30 INFO - 'MAIL': '/var/mail/cltbld', 18:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:30 INFO - 'MOZ_NO_REMOTE': '1', 18:47:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:30 INFO - 'NO_EM_RESTART': '1', 18:47:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:30 INFO - 'PWD': '/builds/slave/test', 18:47:30 INFO - 'SHELL': '/bin/bash', 18:47:30 INFO - 'SHLVL': '1', 18:47:30 INFO - 'TERM': 'linux', 18:47:30 INFO - 'TMOUT': '86400', 18:47:30 INFO - 'USER': 'cltbld', 18:47:30 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 18:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:30 INFO - '_': '/tools/buildbot/bin/python'} 18:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:30 INFO - Downloading/unpacking jsonschema==2.5.1 18:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:47:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:32 INFO - Downloading functools32-3.2.3-2.tar.gz 18:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:47:32 INFO - warning: no files found matching '*.txt' 18:47:32 INFO - no previously-included directories found matching 'build' 18:47:32 INFO - no previously-included directories found matching 'dist' 18:47:32 INFO - no previously-included directories found matching '.git*' 18:47:32 INFO - Installing collected packages: jsonschema, functools32 18:47:32 INFO - Running setup.py install for functools32 18:47:32 INFO - warning: no files found matching '*.txt' 18:47:32 INFO - no previously-included directories found matching 'build' 18:47:32 INFO - no previously-included directories found matching 'dist' 18:47:32 INFO - no previously-included directories found matching '.git*' 18:47:32 INFO - Successfully installed jsonschema functools32 18:47:32 INFO - Cleaning up... 18:47:32 INFO - Return code: 0 18:47:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:32 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 0x7fcef2fd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e9790>, '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 0x23ea690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eab20>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:47:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:47:32 INFO - Using env: {'DISPLAY': ':0', 18:47:32 INFO - 'HOME': '/home/cltbld', 18:47:32 INFO - 'LANG': 'en_US.UTF-8', 18:47:32 INFO - 'LANGUAGE': 'en_US:en', 18:47:32 INFO - 'LOGNAME': 'cltbld', 18:47:32 INFO - 'MAIL': '/var/mail/cltbld', 18:47:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:32 INFO - 'MOZ_NO_REMOTE': '1', 18:47:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:32 INFO - 'NO_EM_RESTART': '1', 18:47:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:32 INFO - 'PWD': '/builds/slave/test', 18:47:32 INFO - 'SHELL': '/bin/bash', 18:47:32 INFO - 'SHLVL': '1', 18:47:32 INFO - 'TERM': 'linux', 18:47:32 INFO - 'TMOUT': '86400', 18:47:32 INFO - 'USER': 'cltbld', 18:47:32 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 18:47:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:32 INFO - '_': '/tools/buildbot/bin/python'} 18:47:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:47:32 INFO - Cleaning up... 18:47:32 INFO - Return code: 0 18:47:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:32 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 0x7fcef2fd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e9790>, '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 0x23ea690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eab20>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:47:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:47:32 INFO - Using env: {'DISPLAY': ':0', 18:47:32 INFO - 'HOME': '/home/cltbld', 18:47:32 INFO - 'LANG': 'en_US.UTF-8', 18:47:32 INFO - 'LANGUAGE': 'en_US:en', 18:47:32 INFO - 'LOGNAME': 'cltbld', 18:47:32 INFO - 'MAIL': '/var/mail/cltbld', 18:47:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:32 INFO - 'MOZ_NO_REMOTE': '1', 18:47:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:32 INFO - 'NO_EM_RESTART': '1', 18:47:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:32 INFO - 'PWD': '/builds/slave/test', 18:47:32 INFO - 'SHELL': '/bin/bash', 18:47:32 INFO - 'SHLVL': '1', 18:47:32 INFO - 'TERM': 'linux', 18:47:32 INFO - 'TMOUT': '86400', 18:47:32 INFO - 'USER': 'cltbld', 18:47:32 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 18:47:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:32 INFO - '_': '/tools/buildbot/bin/python'} 18:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:33 INFO - Downloading/unpacking blobuploader==1.2.4 18:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:35 INFO - Downloading blobuploader-1.2.4.tar.gz 18:47:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:47:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:47:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:35 INFO - Downloading docopt-0.6.1.tar.gz 18:47:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:47:35 INFO - Installing collected packages: blobuploader, requests, docopt 18:47:35 INFO - Running setup.py install for blobuploader 18:47:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:47:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:47:35 INFO - Running setup.py install for requests 18:47:36 INFO - Running setup.py install for docopt 18:47:36 INFO - Successfully installed blobuploader requests docopt 18:47:36 INFO - Cleaning up... 18:47:36 INFO - Return code: 0 18:47:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:36 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 0x7fcef2fd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e9790>, '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 0x23ea690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eab20>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:47:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:47:36 INFO - Using env: {'DISPLAY': ':0', 18:47:36 INFO - 'HOME': '/home/cltbld', 18:47:36 INFO - 'LANG': 'en_US.UTF-8', 18:47:36 INFO - 'LANGUAGE': 'en_US:en', 18:47:36 INFO - 'LOGNAME': 'cltbld', 18:47:36 INFO - 'MAIL': '/var/mail/cltbld', 18:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:36 INFO - 'MOZ_NO_REMOTE': '1', 18:47:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:36 INFO - 'NO_EM_RESTART': '1', 18:47:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:36 INFO - 'PWD': '/builds/slave/test', 18:47:36 INFO - 'SHELL': '/bin/bash', 18:47:36 INFO - 'SHLVL': '1', 18:47:36 INFO - 'TERM': 'linux', 18:47:36 INFO - 'TMOUT': '86400', 18:47:36 INFO - 'USER': 'cltbld', 18:47:36 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 18:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:36 INFO - '_': '/tools/buildbot/bin/python'} 18:47:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:47:36 INFO - Running setup.py (path:/tmp/pip-1cFqmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:47:36 INFO - Running setup.py (path:/tmp/pip-Tla7U2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:47:36 INFO - Running setup.py (path:/tmp/pip-gW8IRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:47:36 INFO - Running setup.py (path:/tmp/pip-CvEjvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:47:36 INFO - Running setup.py (path:/tmp/pip-98AiEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:47:37 INFO - Running setup.py (path:/tmp/pip-7VXk0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:47:37 INFO - Running setup.py (path:/tmp/pip-UdBMQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:47:37 INFO - Running setup.py (path:/tmp/pip-J0bBJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:47:37 INFO - Running setup.py (path:/tmp/pip-LyEr3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:47:37 INFO - Running setup.py (path:/tmp/pip-jIXexz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:47:37 INFO - Running setup.py (path:/tmp/pip-2UxQlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:47:37 INFO - Running setup.py (path:/tmp/pip-sIE3z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:47:37 INFO - Running setup.py (path:/tmp/pip-D1aiy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:47:37 INFO - Running setup.py (path:/tmp/pip-MlYZ3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:47:37 INFO - Running setup.py (path:/tmp/pip-GfYw4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:47:37 INFO - Running setup.py (path:/tmp/pip-YMTNTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:47:37 INFO - Running setup.py (path:/tmp/pip-EZpKZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:47:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:47:37 INFO - Running setup.py install for manifestparser 18:47:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:47:38 INFO - Running setup.py install for mozcrash 18:47:38 INFO - Running setup.py install for mozdebug 18:47:38 INFO - Running setup.py install for mozdevice 18:47:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:47:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:47:38 INFO - Running setup.py install for mozfile 18:47:38 INFO - Running setup.py install for mozhttpd 18:47:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:47:38 INFO - Running setup.py install for mozinfo 18:47:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:47:38 INFO - Running setup.py install for mozInstall 18:47:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:47:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:47:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:47:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:47:38 INFO - Running setup.py install for mozleak 18:47:38 INFO - Running setup.py install for mozlog 18:47:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:47:38 INFO - Running setup.py install for moznetwork 18:47:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:47:39 INFO - Running setup.py install for mozprocess 18:47:39 INFO - Running setup.py install for mozprofile 18:47:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:47:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:47:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:47:39 INFO - Running setup.py install for mozrunner 18:47:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:47:39 INFO - Running setup.py install for mozscreenshot 18:47:39 INFO - Running setup.py install for moztest 18:47:39 INFO - Running setup.py install for mozversion 18:47:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:47:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:47:39 INFO - Cleaning up... 18:47:39 INFO - Return code: 0 18:47:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:39 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 0x7fcef2fd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e9790>, '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 0x23ea690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eab20>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:47:39 INFO - Using env: {'DISPLAY': ':0', 18:47:39 INFO - 'HOME': '/home/cltbld', 18:47:39 INFO - 'LANG': 'en_US.UTF-8', 18:47:39 INFO - 'LANGUAGE': 'en_US:en', 18:47:39 INFO - 'LOGNAME': 'cltbld', 18:47:39 INFO - 'MAIL': '/var/mail/cltbld', 18:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:39 INFO - 'MOZ_NO_REMOTE': '1', 18:47:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:39 INFO - 'NO_EM_RESTART': '1', 18:47:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:39 INFO - 'PWD': '/builds/slave/test', 18:47:39 INFO - 'SHELL': '/bin/bash', 18:47:39 INFO - 'SHLVL': '1', 18:47:39 INFO - 'TERM': 'linux', 18:47:39 INFO - 'TMOUT': '86400', 18:47:39 INFO - 'USER': 'cltbld', 18:47:39 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 18:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:39 INFO - '_': '/tools/buildbot/bin/python'} 18:47:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:47:39 INFO - Running setup.py (path:/tmp/pip-zQyG_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:47:40 INFO - Running setup.py (path:/tmp/pip-Hq4Qjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:47:40 INFO - Running setup.py (path:/tmp/pip-giyXOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:47:40 INFO - Running setup.py (path:/tmp/pip-eIyrLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:47:40 INFO - Running setup.py (path:/tmp/pip-eMYHkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:47:40 INFO - Running setup.py (path:/tmp/pip-YmRukW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:47:40 INFO - Running setup.py (path:/tmp/pip-NIuilz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:47:40 INFO - Running setup.py (path:/tmp/pip-ncPo8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:47:40 INFO - Running setup.py (path:/tmp/pip-973FZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:47:40 INFO - Running setup.py (path:/tmp/pip-K4bp15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:47:40 INFO - Running setup.py (path:/tmp/pip-EM8uUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:47:40 INFO - Running setup.py (path:/tmp/pip-VCIH5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:47:40 INFO - Running setup.py (path:/tmp/pip-5YerNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:47:40 INFO - Running setup.py (path:/tmp/pip-YcGoXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:47:40 INFO - Running setup.py (path:/tmp/pip-L7LKpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:47:41 INFO - Running setup.py (path:/tmp/pip-JVnwnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:47:41 INFO - Running setup.py (path:/tmp/pip-Iz7jny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:47:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:43 INFO - Downloading blessings-1.6.tar.gz 18:47:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:47:43 INFO - Installing collected packages: blessings 18:47:43 INFO - Running setup.py install for blessings 18:47:43 INFO - Successfully installed blessings 18:47:43 INFO - Cleaning up... 18:47:43 INFO - Return code: 0 18:47:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:47:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:47:43 INFO - Reading from file tmpfile_stdout 18:47:43 INFO - Current package versions: 18:47:43 INFO - argparse == 1.2.1 18:47:43 INFO - blessings == 1.6 18:47:43 INFO - blobuploader == 1.2.4 18:47:43 INFO - docopt == 0.6.1 18:47:43 INFO - functools32 == 3.2.3-2 18:47:43 INFO - jsonschema == 2.5.1 18:47:43 INFO - manifestparser == 1.1 18:47:43 INFO - mozInstall == 1.12 18:47:43 INFO - mozcrash == 0.17 18:47:43 INFO - mozdebug == 0.1 18:47:43 INFO - mozdevice == 0.48 18:47:43 INFO - mozfile == 1.2 18:47:43 INFO - mozhttpd == 0.7 18:47:43 INFO - mozinfo == 0.9 18:47:43 INFO - mozleak == 0.1 18:47:43 INFO - mozlog == 3.4 18:47:43 INFO - moznetwork == 0.27 18:47:43 INFO - mozprocess == 0.23 18:47:43 INFO - mozprofile == 0.28 18:47:43 INFO - mozrunner == 6.12 18:47:43 INFO - mozscreenshot == 0.1 18:47:43 INFO - mozsystemmonitor == 0.3 18:47:43 INFO - moztest == 0.7 18:47:43 INFO - mozversion == 1.4 18:47:43 INFO - psutil == 3.1.1 18:47:43 INFO - requests == 1.2.3 18:47:43 INFO - wsgiref == 0.1.2 18:47:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:47: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')]} 18:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47: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')]} 18:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:43 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 0x7fcef2fd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e9790>, '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 0x23ea690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eab20>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:47:43 INFO - Using env: {'DISPLAY': ':0', 18:47:43 INFO - 'HOME': '/home/cltbld', 18:47:43 INFO - 'LANG': 'en_US.UTF-8', 18:47:43 INFO - 'LANGUAGE': 'en_US:en', 18:47:43 INFO - 'LOGNAME': 'cltbld', 18:47:43 INFO - 'MAIL': '/var/mail/cltbld', 18:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:43 INFO - 'MOZ_NO_REMOTE': '1', 18:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:43 INFO - 'NO_EM_RESTART': '1', 18:47:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:43 INFO - 'PWD': '/builds/slave/test', 18:47:43 INFO - 'SHELL': '/bin/bash', 18:47:43 INFO - 'SHLVL': '1', 18:47:43 INFO - 'TERM': 'linux', 18:47:43 INFO - 'TMOUT': '86400', 18:47:43 INFO - 'USER': 'cltbld', 18:47:43 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 18:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:43 INFO - '_': '/tools/buildbot/bin/python'} 18:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:47:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:47:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:47:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:47:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:47:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:47:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:47:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:47:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:47:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:47:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:47:43 INFO - Cleaning up... 18:47:43 INFO - Return code: 0 18:47:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:47: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')]} 18:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47: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')]} 18:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:43 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 0x7fcef2fd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e9790>, '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 0x23ea690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eab20>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:47:43 INFO - Using env: {'DISPLAY': ':0', 18:47:43 INFO - 'HOME': '/home/cltbld', 18:47:43 INFO - 'LANG': 'en_US.UTF-8', 18:47:43 INFO - 'LANGUAGE': 'en_US:en', 18:47:43 INFO - 'LOGNAME': 'cltbld', 18:47:43 INFO - 'MAIL': '/var/mail/cltbld', 18:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:43 INFO - 'MOZ_NO_REMOTE': '1', 18:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:43 INFO - 'NO_EM_RESTART': '1', 18:47:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:43 INFO - 'PWD': '/builds/slave/test', 18:47:43 INFO - 'SHELL': '/bin/bash', 18:47:43 INFO - 'SHLVL': '1', 18:47:43 INFO - 'TERM': 'linux', 18:47:43 INFO - 'TMOUT': '86400', 18:47:43 INFO - 'USER': 'cltbld', 18:47:43 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 18:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:43 INFO - '_': '/tools/buildbot/bin/python'} 18:47:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:47:44 INFO - Cleaning up... 18:47:44 INFO - Return code: 0 18:47:44 INFO - Running post-action listener: _resource_record_post_action 18:47:44 INFO - Running post-action listener: _start_resource_monitoring 18:47:44 INFO - Starting resource monitoring. 18:47:44 INFO - [mozharness: 2016-10-23 01:47:44.158514Z] Finished create-virtualenv step (success) 18:47:44 INFO - [mozharness: 2016-10-23 01:47:44.159085Z] Running install step. 18:47:44 INFO - Running pre-action listener: _resource_record_pre_action 18:47:44 INFO - Running main action method: install 18:47:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:47:44 INFO - Reading from file tmpfile_stdout 18:47:44 INFO - Detecting whether we're running mozinstall >=1.0... 18:47:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:47:44 INFO - Reading from file tmpfile_stdout 18:47:44 INFO - Output received: 18:47:44 INFO - Usage: mozinstall [options] installer 18:47:44 INFO - Options: 18:47:44 INFO - -h, --help show this help message and exit 18:47:44 INFO - -d DEST, --destination=DEST 18:47:44 INFO - Directory to install application into. [default: 18:47:44 INFO - "/builds/slave/test"] 18:47:44 INFO - --app=APP Application being installed. [default: firefox] 18:47:44 INFO - mkdir: /builds/slave/test/build/application 18:47:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:48:01 INFO - Reading from file tmpfile_stdout 18:48:01 INFO - Output received: 18:48:01 INFO - /builds/slave/test/build/application/firefox/firefox 18:48:01 INFO - Running post-action listener: _resource_record_post_action 18:48:01 INFO - [mozharness: 2016-10-23 01:48:01.377655Z] Finished install step (success) 18:48:01 INFO - [mozharness: 2016-10-23 01:48:01.377930Z] Running run-tests step. 18:48:01 INFO - Running pre-action listener: _resource_record_pre_action 18:48:01 INFO - Running main action method: run_tests 18:48:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:48:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:48:01 INFO - Python 2.7.3 18:48:01 INFO - Return code: 0 18:48:01 INFO - grabbing minidump binary from tooltool 18:48: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')]} 18:48:01 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 0x23e9790>, '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 0x23ea690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:48:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:48:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:48:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:48:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:48:01 INFO - Return code: 0 18:48:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:48:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:48:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:48:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:48:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:48:01 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/1477175402/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:48:01 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/1477175402/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:48:01 INFO - Using env: {'DISPLAY': ':0', 18:48:01 INFO - 'HOME': '/home/cltbld', 18:48:01 INFO - 'LANG': 'en_US.UTF-8', 18:48:01 INFO - 'LANGUAGE': 'en_US:en', 18:48:01 INFO - 'LOGNAME': 'cltbld', 18:48:01 INFO - 'MAIL': '/var/mail/cltbld', 18:48:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:48:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:01 INFO - 'MOZ_NO_REMOTE': '1', 18:48:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:01 INFO - 'NO_EM_RESTART': '1', 18:48:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:01 INFO - 'PWD': '/builds/slave/test', 18:48:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:48:01 INFO - 'SHELL': '/bin/bash', 18:48:01 INFO - 'SHLVL': '1', 18:48:01 INFO - 'TERM': 'linux', 18:48:01 INFO - 'TMOUT': '86400', 18:48:01 INFO - 'USER': 'cltbld', 18:48:01 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608', 18:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:01 INFO - '_': '/tools/buildbot/bin/python'} 18:48:01 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/1477175402/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:48:01 INFO - mozversion application_buildid: 20161022153002 18:48:01 INFO - mozversion application_changeset: 60dd82380d43a2b681f50842238f829204486290 18:48:01 INFO - mozversion application_display_name: Nightly 18:48:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:48:01 INFO - mozversion application_name: Firefox 18:48:01 INFO - mozversion application_remotingname: firefox 18:48:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:48:01 INFO - mozversion application_vendor: Mozilla 18:48:01 INFO - mozversion application_version: 52.0a1 18:48:01 INFO - mozversion platform_buildid: 20161022153002 18:48:01 INFO - mozversion platform_changeset: 60dd82380d43a2b681f50842238f829204486290 18:48:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:48:01 INFO - mozversion platform_version: 52.0a1 18:48:01 INFO - using testdate: 1477187281 18:48:01 INFO - actual date: 1477187281 18:48:01 INFO - starting webserver on 'localhost:34330' 18:48:01 INFO - SUITE-START | Running 2 tests 18:48:01 INFO - TEST-START | dromaeo_css 18:48:01 INFO - operating with platform_type : linux_ 18:48:01 INFO - Initialising browser for dromaeo_css test... 18:48:01 INFO - TEST-INFO | started process 20688 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbS6jJ_/profile http://localhost:34330/getInfo.html) 18:48:05 INFO - PROCESS | 20688 | __metrics Screen width/height:1600/1200 18:48:05 INFO - PROCESS | 20688 | colorDepth:24 18:48:05 INFO - PROCESS | 20688 | Browser inner width/height: 1024/697 18:48:05 INFO - PROCESS | 20688 | __metrics 18:48:06 INFO - PROCESS | 20688 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:48:06 INFO - PROCESS | 20688 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:48:06 INFO - PROCESS | 20688 | console.error: PushService: 18:48:06 INFO - PROCESS | 20688 | stateChangeProcessEnqueue: Error transitioning state 18:48:06 INFO - PROCESS | 20688 | UnknownError 18:48:07 INFO - TEST-INFO | 20688: exit 0 18:48:07 INFO - Browser initialized. 18:48:07 INFO - Running cycle 1/1 for dromaeo_css test... 18:48:07 INFO - TEST-INFO | started process 20770 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbS6jJ_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:48:19 INFO - PROCESS | 20770 | RSS: Main: 172191744 18:48:19 INFO - PROCESS | 20770 | 18:49:11 INFO - PROCESS | 20770 | 1477187351469 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:51:21 INFO - PROCESS | 20770 | Cycle 1(1): loaded http://localhost:34330/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34330/tests/dromaeo/cssquery-ext.html) 18:51:23 INFO - PROCESS | 20770 | RSS: Main: 325668864 18:51:23 INFO - PROCESS | 20770 | 18:54:25 INFO - PROCESS | 20770 | Cycle 1(1): loaded http://localhost:34330/tests/dromaeo/cssquery-ext.html (next: http://localhost:34330/tests/dromaeo/cssquery-jquery.html) 18:54:26 INFO - PROCESS | 20770 | RSS: Main: 275079168 18:54:26 INFO - PROCESS | 20770 | 18:57:28 INFO - PROCESS | 20770 | Cycle 1(1): loaded http://localhost:34330/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34330/tests/dromaeo/cssquery-mootools.html) 18:57:29 INFO - PROCESS | 20770 | RSS: Main: 218804224 18:57:29 INFO - PROCESS | 20770 | 19:00:31 INFO - PROCESS | 20770 | Cycle 1(1): loaded http://localhost:34330/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34330/tests/dromaeo/cssquery-prototype.html) 19:00:31 INFO - PROCESS | 20770 | RSS: Main: 249946112 19:00:31 INFO - PROCESS | 20770 | 19:03:34 INFO - PROCESS | 20770 | Cycle 1(1): loaded http://localhost:34330/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34330/tests/dromaeo/cssquery-yui.html) 19:03:34 INFO - PROCESS | 20770 | RSS: Main: 212926464 19:03:34 INFO - PROCESS | 20770 | 19:06:37 INFO - PROCESS | 20770 | Cycle 1(1): loaded http://localhost:34330/tests/dromaeo/cssquery-yui.html (next: http://localhost:34330/tests/dromaeo/cssquery-dojo.html) 19:06:38 INFO - PROCESS | 20770 | RSS: Main: 293163008 19:06:38 INFO - PROCESS | 20770 | 19:06:38 INFO - PROCESS | 20770 | __start_tp_report 19:06:38 INFO - PROCESS | 20770 | _x_x_mozilla_page_load 19:06:38 INFO - PROCESS | 20770 | _x_x_mozilla_page_load_details 19:06:38 INFO - PROCESS | 20770 | |i|pagename|runs| 19:06:38 INFO - PROCESS | 20770 | |0;dojo.html;3057.8165310081395;3081.5993920790293;3101.658817530072;3116.2676770958833;3122.828244446556;5256.027634887544;5299.761510732017;5331.2003199520095;5352.491513306235;5383.327084114486;5364.034473794725;5451.700156491392;5555.944440555603;5557;5570.192322113301;4836.661433699643;4838.322634831126;4894.265860120992;4920.630952678545;4936.654434189608;4913.533214344631;5018.949810501903;5029.823956161535;5040.722760248185;5067.721275329855;4775.5701986821;4971.850844474671;4980.427250866161;5017.272495488152;5093.312402825627;4796.304535842318;4858.78135483904;4888.169011268093;4925.285833554115;4956.306117143603;4896.167651499253;4917.090338287392;4917.852464426073;4919.852404427873;4972.105021096201;5457.863553411157;5458.208559758813;5464.28964234647;5475.890482190373;5502.80740174092;5562.3047119110115;5608.46719561641;5702.857428564319;5737.713114344266;5844.53243740504;5781.046127388976;5807.070868661036;5832.825015249549;5859.970700146515;5870.148828419898;5419.403865574784;5425.403205647415;5425.755840987165;5425.9728701356635;5426.647267927572;5678.5741069419955;5727.5990680652785;5792.362840087587;5892.791977644572;5905.704714764244;5617;5667.546596272288;5668.263125793703;5736.4550367715;5738.053221218535;5669.177969194444;5690.430956904276;5735.2257445245195;5739.684317362585;5750.654960702288;5593.692346920877;5644.379118297066;5743.6266642668925;5750.079987202112;5752.3097228332035;5690.800821971294;5710.885782284331;5716.628419152742;5757.337906140848;5765.1640512125505;4327.675424343124;4334.089841133397;4399.186150562156;4400.625946794495;4451.287793953017;3870.612938706107;3933.547642021147;3937;3948.6367563842114;4007.7595344279434;5344.038073146793;5455.372632147274;5471.23402723619;5486.862828429321;5494.890102197934;5749;5754.6547207167705;5774.566907481872;5777.624454410534;5788.710564471844;5283.709395983181;5499.175123731392;5499.862503437366;5510.0632892408385;5518.44815518453;4725.598324142417;4788.497207793132;4811.326414302001;4817.638677099231;4896.559309662076;5944.64332140073;5947.910781338283;5948.405159484017;5949.672767997802;5955.106733989936;5734.111212762028;5746.454086861909;5747.453991870766;5747.453991870766;5748.741306641295;5714.20001199824;5772.278465191851;5847.152162936265;5897.70511474416;5901.645901245939;5575.581831362583;5622.409646987171;5630.5777066720975;5634.352049514195;5694.9179655865255;5661.207430959751;5712.5429965601825;5727.1695604138;5733.426657334233;5733.455321744427;5485.067538518381;5549.750261238335;5599.60802743804;5601.579881508985;5646.209530665628;5660.801871934627;5669.092945128759;5678.914816277676;5712.514436272963;5740.282464691913;5649.180868774087;5655.1517272409465;5658.377578466448;5658.830235092953;5669.574781891292;5476.780928762964;5579.860503487283;5642.520385767256;5724.255846739898;5733.541316694571;5525.696086715108;5564.360098588714;5609.046462101371;5661.46216109469;5677.120046392815 19:06:38 INFO - PROCESS | 20770 | |1;ext.html;565.1550931357618;616.0912653835593;617;635.2059925093636;652.0610321137565;31064.37871242574;43753.78123109384;44386.11227775451;44399.890002749904;44469.332960005624;45772;46058.93968555506;46127.53872461274;46210.76894615531;46256.76871615645;7852;8808.251298639623;8965.32760042996;8967.058458861824;8970.50662213578;7909.406794490407;10476.842847357295;10718.35689858611;10731.248812583122;11100.500477478492;10946.945265273662;10970.670879873616;10986.835197472044;11008.174386920973;11012.559497620086;10748.623798167066;10835.970582794662;10860;10867.565297388095;10887.237893347468;10677.626283080133;10729.83905241422;10732.248742588023;10746.785064298749;10755.892441075568;43192.78403607962;43531;43531.347029794575;43566.425525319704;43578.12843743139;3425.880094196691;3438.9656103438897;3503.91240218994;3782.6973842092843;3839.78881161536;31621;31817.204569885707;31955;32514;33949.981500555026;4259.91480170398;4263.11920042919;4276.217878757807;4392.736435813861;4396.868093957187;322372;323722;324295;325334;326002.9999999976;60124.69937650284;60561.394386056454;60612.393876060676;60663;60701;62959.68520157461;63023;63106.368936310966;63119.36880631227;63430.36569634337;15259.160746158846;15961.281742321624;15962.840371596136;16578.50264492067;16612.25244863984;9899.109080182818;10061.044200800912;11998.880011199952;12092.758144837055;12203.75592488163;18985.715214271797;19003.42989710311;19018.23927042903;19098.90450547766;19154.808451915582;7076.2923707628825;7213.4589905757275;7362.190159082496;7383.2247614000835;7556.924430755732;870.8998465176586;937.9577918993662;949.4303417949175;984.5717113055844;1018.9388636681823;27089.593656095174;27913.860430697718;28126.71873281282;28309.858450707616;28695.978203814248;1008.4604736466102;1034.632705389576;1084.8860869608577;1101.6860194844592;1139.4986206069302;14963.551093467213;15719.371225151095;15741.134237616812;15816.209189540707;15890.205489725467;538204;544292;544507;544632;544636;57933.4206657928;57960.4203957955;57981.71009144927;58236.70881645649;58328.41671583315;1199.9100067494974;1237.1525505029083;1239.5537606461487;1284.6980959474515;1336.4854531005633;23812.880935595906;27626;28257.293567660974;30436.39127217399;30820.69179308268;55922.44077559335;56639.433605665065;56676;56854.71572642276;56969.14546281892;325387;327051;327702;327867;327891;24111.638325425483;24506.87746561327;26388.340291492867;27753.306167345978;28089.71910280871;47070.29394559016;47308.2903756437;47586.52413475821;47630.761846190544;48039.519604804904;38401.48588114946;38620;38713.41929870998;40633.1873362537;44188.627184388424;38424.42363364496;40137.1972560553;40834.183316332914;40957.180856383304;41919.58080419279;41443;41471.58528414798;42808.78595607002;43671.56328436802;44466.3330050043;33798.66201337955;36185.75306580584;37110.44334335041;37340.25319493649;37675.73945563275;27986.331195722538;28007.299817504725;28198.15405537837;28264.762056341726;28312.01235692444 19:06:38 INFO - PROCESS | 20770 | |2;jquery.html;378.76516559732954;382.5696091896616;391.3034798059455;395.2273305687381;404.7955782329923;17125.82874171258;19814;19978.70031949522;20238.89880550597;20244.493887652818;18784.43646690598;18924.432267031978;19033.333833315835;19159.329423470183;19540.511487212792;5588.469095435948;5630.296212973379;5827.329857066428;5882.499987501067;5883.588148829584;5769.7692092316465;5781.161731548944;5823.708814559255;5828.329742079652;5831.329397119343;5561.4716601922955;5665.036943719578;5742.0238559445;5801.535877129841;5804.680742559158;5741.971290143543;5800.477956983849;5804.912926306088;5804.970975145139;5805.941940580625;5041.647084704072;5135.050015747099;5260.921086183672;5288.206768984683;5407.918881216785;13915.095518791246;14069.2965351732;14140.363683634261;14151.150930944073;14182.361793719307;2110.883901385423;2133.5306232628795;2147.14114354258;2183.705199798023;2257.7855103765114;5633.774649014034;9865.309428340019;10019.398836069859;10121.898781012169;10665.893341066567;1811.9184636691248;1843.6681397348473;1860.1131203696366;1896.5637903282184;1998.9800101999085;79081.81377279403;80635.19364806336;81169;82105.58947205286;82816.58591707003;10585.206109541816;10711.143108551452;10904.400257985728;11025.17311201647;11053.226274160892;15582.909196356373;15596.92201538985;15604.921975390278;15609.141497217535;15611.219439028004;7533.937981155391;7699.345555627834;7804.3366313862825;7902.234218023646;8076.313513351313;7344.889826652605;7364.705411783576;7570.924290757132;7677.347425468898;7684.423668224794;4544.772761361919;4711.505291944365;4722.456917454468;4789.592884604847;4815.975920120377;1901.5531350132708;1975.2395327798613;1989.5821877405617;2008.9598208035757;2010.58782949495;980.4852452462371;983.9803203935882;1004.4776716107583;1035.6012935020071;1043.446973104256;18948.446229397337;19038.428847134608;19323.130459129374;19390.515237119183;19465.610687786164;943.3820847345;948.8197242523898;953.594722243044;970.0703874299717;1014.6955913226003;10000.549975251131;10589.735256618646;10645.520951557044;10654.893451065545;10744.623938162127;412726;418175;431839;433727;436517;86210.56894715612;86671.1332886663;86707.56646216729;87855.56072219598;88136.15251161119;978.427619842386;1016.8068067067234;1047.073340094007;1063.9574417023387;1064.9041586257274;16161.726458734465;16765.748513772058;17010;17183.91408043002;17444;39065.41401879031;39660.40509392419;40393.39409908913;40713;41121.1775764489;53322;53525.732371337894;53759;53864.461355385945;56222;8476.03892832371;8495.150484951455;8558.700445484377;8678.08880067609;8817.118288171132;12010;13060.738785224432;13107.606771796862;13210.339483026002;13466.461341546228;10610.151187905103;10834.349939003685;11179.608713695307;11445.313281203154;11732.296062236293;10864.402457864893;10984.670459886216;11111.555537778399;11530.711732206762;11578.131640126856;10966.396848173426;11281.887181128084;11362.54549818031;11856.347900865536;11922.271270665879;7741.206665048215;8291.543965081737;8299.170082991652;8405.243528082501;8584.957075214585;10329.896701032894;10974.451277435937;11198.104151667683;11253.774924501628;11256.774864502828 19:06:38 INFO - PROCESS | 20770 | |3;mootools.html;1299.0452017766934;1413.4416905322398;1479.4673917389741;1604.2139351717653;1796.8023517413073;7500.362469190119;8922.687705930293;9152.816943661139;9173.128552787492;9431.10404511572;9230.86153707695;9302.302327325444;9302.395344302633;9312.30157738169;9322.720318390442;2359.49270906755;2383.1182462488905;2383.165891937825;2387.546366190427;2387.8209134314907;2301.551197516485;2319.5708793873105;2346.741858395575;2351.6472529120597;2351.7295511016196;2308.6998690170253;2314.930552083432;2326.5114325991476;2334.8015418689347;2356.3402247370764;2291.8051965582945;2309.8267629927823;2315.502167034079;2321.651752237161;2326.1858349577683;2247.370736193868;2253.6478113132152;2254.3349711834885;2254.5941730488507;2257.4582100295975;9016.59425325862;9093.045230250795;9144.954275228647;9145.542722863831;9153.679621213225;5274.156135018378;5480.616356855022;5488.862778430531;5490.286262785812;5494.615376923617;3614.3855544557487;3630.8184590770356;3669.87155449558;3677.411614141751;3705.7961812100325;1094.9726256843562;1096.6929259807266;1105.9281146725436;1125.3360517294836;1131.04426759389;12731.809022864665;12792.296423696693;12836.614901553061;12841.614751557468;12878.969682425477;4393.428854248928;4525.524819893863;4685.0629874025335;4688.413948256468;4717.174494463455;10213.234007449471;10222.948885255526;10230.181585473145;10239.027292407209;10246.077852993267;5394.406615272317;5425.945740542544;5426.538744206708;5439.456054394529;5441.347038355423;4348.804303806336;4464.732116073046;4876.073546026244;4980.5019498049905;5028.547430731252;3735.2545878779074;3749.7937613430977;3856.903577410531;3863.072862512977;3877.689784817208;1118.6364431559775;1119.0040863631375;1126.9098472122375;1151;1157.0974639780984;860.7073594977612;878.5255961780567;882.7528292078229;903.9683611073713;937.3953799799092;5762.30852297727;5840.8539786504825;5914.201582786355;5933.2880054393745;6012.098185272244;894.4722613657973;918.2103391083663;938.1369140390857;943.4386540008684;970.4129001953858;3859.3246181918053;3884.6892248620607;3982.342913419311;4080.449139366207;4185.351270553069;10921.890781092246;11143;11235.606753763579;11288.830667539993;11357.545698172145;11136.38749868765;11201.271917325348;11201.831972520418;11214.10287177024;11244.66266012021;8479.364047696448;8631.266342360845;8632.179942905414;8642.30861531076;8645.13548645143;5577.8047768327915;5621.353544342453;5662.122371032497;5743.827685169284;5819.6508209507565;10437.425941572983;10477.9476102619;10574.471276436301;10650.786984260116;10673.35959842412;10111.241656875616;10404.531796069045;10751.086157676686;10860;10877.075448586958;7334.596597186993;7486.9625651873575;7488.700451981859;7820.765377038698;8280.296174825207;8182.7545173644885;8235.094139644514;8567.828643427221;8818.647254109765;8886.066962968795;7371.262873712586;7534.35957943581;7898.210178982055;7908.604569771604;8386.287165590993;7819.765407037798;7861.606919654108;7904.802379940547;7946.125926148235;8009.719659811879;6745.696443660146;6850.0752398425575;6854.588724676535;6861;6867.141607299088;4949.7030178189425;5061.898762024813;5080.517350851663;5194.4805519447755;5408.269883565826;4934.18585933317;5034.219695947134;5063.316452278895;5171.095058364695;5484.890302194013 19:06:38 INFO - PROCESS | 20770 | |4;prototype.html;329.37583279685;330.3871318703804;331.7263257812304;338.5869239527775;342.06957076751235;5251.212318152275;5297.337832770903;5329.600279979008;5371.597130215235;5375.462453754622;4962.114396529323;5097.3373461449955;5139.794408223666;5169.689818610886;5185.55922746566;4137.234611596849;4145.88061223471;4150.211459822624;4154.584541545844;4180.205760905434;4163.375493675958;4175.394567787669;4186.141840922619;4187.20443115807;4194.433751443562;3858.7105967052444;3913.4716813230275;4084.65280451162;4129.256733787917;4136.3381858902585;4103.466549348581;4117.91764164715;4120.979395103035;4124.340105583093;4126.257273690734;3674.52231209941;3691.206390626028;3691.833867475943;3702.315071711742;3713.814309284525;5038.647294689336;5092.745362731848;5136.691798492103;5195.437232145955;5261.76322065508;4663.790129444184;4699.718016918996;4700.976495117503;4704.5765881070865;4734.621230301602;5418.810341638064;5489.807856724996;5501.14732216507;5509.614326997112;5536.280283563151;3966.504186976628;3990.20195960809;4024.63778259958;4035.9798201008807;4061.35018397058;5649.6327738696855;5660.377358490563;5668.291463567054;5674.375818659944;5691.943080569183;4123.175364927027;4148.958510414857;4154.356074808409;4162.604552567501;4164.916701665949;3898.6491215790716;4061.756294622332;4219;4223.472065991751;4238.321868501025;4629.939676843772;4649.372334734835;4676.602488788423;4696.530346965276;4715.198416269242;5520.91718624221;5534.667919924817;5551.500364967173;5557.694326811983;5560.638558493766;1340.4906135668384;1394.414345974693;1416.9089800853285;1432.6203556057653;1437.475321507663;886.9689560865339;908.3006085314271;915.922146617545;920.3603495570514;920.8066306075799;4658.906821863544;4717.976410117927;4748.216544270226;4771.659838113334;4783.210770222944;4997.9504304096545;5019.84940451787;5061.5950723942;5062.974685126551;5083.38999320084;4638.536146385402;4765.356676848651;4777.822747872695;4809.470958194595;4830.372051633335;2652.6418933444124;2656.389030522952;2671.559192733177;2710.539208334588;2710.837349759021;5045.798168073309;5116.258142569307;5144.30551875492;5191.480851914778;5219.6607220531305;4881.389826271716;5057.115004874206;5058.912333848167;5085.466026067284;5104.719240441811;5117;5120.795168193231;5132.615053870974;5170.957471798693;5199.63602547818;5048.368953880765;5072.391313042459;5073.365829271341;5078.7206703631655;5141.2288156775285;4980.427250866197;4994.776279811469;4997.300377947163;5317.229001794641;5703.916255911364;5949.25634295713;5951.7024148791525;5975.282966043928;5982.371850955587;5992;4022.2960981828646;4089.550149483614;4090.365993271048;4091.40674602187;4102.2821006324375;5362.552110930105;5576.7211639417055;5608.860489036273;5646.548276137817;5698.373178950229;5533.723313834212;5587.636803607753;5598.460423383602;5602.52378547828;5634.6337488063145;5347.251384806053;5557.666540007613;5609.691466969356;5640.943590564042;5666.660000399989;5521.69630670317;5545.279113715191;5558.165805284328;5559.555235581225;5560.859069258284;5565.55475561946;5603.187537807076;5617.370962420852;5629.887402252014;5647.830565083054;5215.9739201305265;5447.536959358499;5467.289252397163;5467.589930755289;5479 19:06:38 INFO - PROCESS | 20770 | |5;yui.html;737.9926200737991;757.7991832164474;783.6786917363881;800.2037972217643;838.354467060364;15262;15990.600234994132;15996.200189990497;16000.599985000381;16021.59946001349;15525.456609018687;15682.137482438462;15699.686006279897;15713.84286157141;15717.13555754436;660.5574265242275;671.8051764988147;789.1634867040941;789.8815177723359;812.2851890336495;797.1191833024511;816.2368185746317;816.3754727633366;820.306840719591;822.1244374740912;864.0797550608613;865.3336930563462;866.3199388480044;866.384866744609;867.5271976772674;700.271717413889;862.6290695001147;864.1358641358642;864.2049314630555;864.394923553515;521.6948085370063;609.5337067143639;625.7309356976498;629.26061877294;630.2594451519446;15503;15572.065676059472;15627.843721562753;15663;15671.216439177995;13994.720105597933;14166.858331416657;14431.927840360731;14472.348744306531;14564.854351456455;13138.211707297593;13165.473381064841;13323.600291991255;13507.189568625914;13967.511137110254;4265.509466411371;4305.590968857953;4384.298512238027;4440.800163992596;4519.389882365871;79354;80687;80704;81792.9999999994;82146;11349.886501134883;11509.136814738928;11571.801357742002;11676.241044332091;11775.52897884092;21870.594234634176;21885.452863678536;21886.781132188473;21888.89055554712;21890.671639925415;8329.791755206168;8719.91280087191;8993.14565116313;9001.234895033995;9014.63941442348;4428.73427594339;4545.31820226962;4649.894117705439;4683;4688.5545873142;3578.177019285579;3692.0585250760882;3712.870049548253;3724.273766615538;3731.552213734315;655.2791928878291;662.7315937045408;667.4193451697055;685.2428066985909;692.2247083266673;529.0424331959166;603.0878494661049;674.3627272227698;693.3724978894109;699.2902204262678;8917.464952102895;9308.488033158106;9385.906140938503;9467.573959171854;9542.618295268112;652.2238536141975;655.8557117434157;671.5701950751522;688.7451642892162;711.2176605733652;4222.3244280914905;4330.523642399334;4593.678442508993;4692.202325604655;4753.691010084333;115534;117087.41456292664;118186;122135;122447;96740;98680.50659746655;99095;99390.5030474843;99907;86661.5666921674;91147;93066.53466732622;95861.5206923961;96198;8622.094680058504;8794.736157915273;8868.290536757173;8892.510911899908;8922.464652120894;54044.45955540551;54694;55278;55439.72280138574;57286.7135664319;68587.3141268581;69581.3041869595;74962.6251868759;78628.60685696534;79923.2007679939;13306.600801975956;13389.330533473481;13406.463741450623;13465.259410732111;13683.179009259477;14020.142115467692;14216.147031178163;14346.641333966318;14484.637884052983;14546.927265363605;13685.726285474433;13974.510892118727;14206.21865797391;14663.853361466248;14722;13732.86267137316;14094.50669226572;14367.712645747235;14424.567262982127;14877;12900.548480803127;13668.31762262339;13678.794818077937;13819.654508636962;13846.515371961934;11248.943755281498;11340.886591133984;11707.88292117068;11848.881511185122;12007.257133432071;10437.739056523344;10530.684079477627;11253.76208617035;11636.418179090842;11938 19:06:38 INFO - PROCESS | 20770 | __end_tp_report 19:06:38 INFO - PROCESS | 20770 | __start_cc_report 19:06:38 INFO - PROCESS | 20770 | _x_x_mozilla_cycle_collect,1422 19:06:38 INFO - PROCESS | 20770 | __end_cc_report 19:06:38 INFO - PROCESS | 20770 | __startTimestamp1477188398084__endTimestamp 19:06:38 INFO - PROCESS | 20770 | 19:06:38 INFO - PROCESS | 20770 | ------- Summary: start ------- 19:06:38 INFO - PROCESS | 20770 | Number of tests: 6 19:06:38 INFO - PROCESS | 20770 | 19:06:38 INFO - PROCESS | 20770 | [#0] dojo.html Cycles:165 Average:5348.03 Median:5579.86 stddev:603.17 (10.8%) stddev-sans-first:577.64 19:06:38 INFO - PROCESS | 20770 | Values: 3057.8 3081.6 3101.7 3116.3 3122.8 5256.0 5299.8 5331.2 5352.5 5383.3 5364.0 5451.7 5555.9 5557.0 5570.2 4836.7 4838.3 4894.3 4920.6 4936.7 4913.5 5018.9 5029.8 5040.7 5067.7 4775.6 4971.9 4980.4 5017.3 5093.3 4796.3 4858.8 4888.2 4925.3 4956.3 4896.2 4917.1 4917.9 4919.9 4972.1 5457.9 5458.2 5464.3 5475.9 5502.8 5562.3 5608.5 5702.9 5737.7 5844.5 5781.0 5807.1 5832.8 5860.0 5870.1 5419.4 5425.4 5425.8 5426.0 5426.6 5678.6 5727.6 5792.4 5892.8 5905.7 5617.0 5667.5 5668.3 5736.5 5738.1 5669.2 5690.4 5735.2 5739.7 5750.7 5593.7 5644.4 5743.6 5750.1 5752.3 5690.8 5710.9 5716.6 5757.3 5765.2 4327.7 4334.1 4399.2 4400.6 4451.3 3870.6 3933.5 3937.0 3948.6 4007.8 5344.0 5455.4 5471.2 5486.9 5494.9 5749.0 5754.7 5774.6 5777.6 5788.7 5283.7 5499.2 5499.9 5510.1 5518.4 4725.6 4788.5 4811.3 4817.6 4896.6 5944.6 5947.9 5948.4 5949.7 5955.1 5734.1 5746.5 5747.5 5747.5 5748.7 5714.2 5772.3 5847.2 5897.7 5901.6 5575.6 5622.4 5630.6 5634.4 5694.9 5661.2 5712.5 5727.2 5733.4 5733.5 5485.1 5549.8 5599.6 5601.6 5646.2 5660.8 5669.1 5678.9 5712.5 5740.3 5649.2 5655.2 5658.4 5658.8 5669.6 5476.8 5579.9 5642.5 5724.3 5733.5 5525.7 5564.4 5609.0 5661.5 5677.1 19:06:38 INFO - PROCESS | 20770 | 19:06:38 INFO - PROCESS | 20770 | [#1] ext.html Cycles:180 Average:56864.30 Median:37225.35 stddev:109004.93 (292.8%) stddev-sans-first:109228.76 19:06:38 INFO - PROCESS | 20770 | Values: 565.2 616.1 617.0 635.2 652.1 31064.4 43753.8 44386.1 44399.9 44469.3 45772.0 46058.9 46127.5 46210.8 46256.8 7852.0 8808.3 8965.3 8967.1 8970.5 7909.4 10476.8 10718.4 10731.2 11100.5 10946.9 10970.7 10986.8 11008.2 11012.6 10748.6 10836.0 10860.0 10867.6 10887.2 10677.6 10729.8 10732.2 10746.8 10755.9 43192.8 43531.0 43531.3 43566.4 43578.1 3425.9 3439.0 3503.9 3782.7 3839.8 31621.0 31817.2 31955.0 32514.0 33950.0 4259.9 4263.1 4276.2 4392.7 4396.9 322372.0 323722.0 324295.0 325334.0 326003.0 60124.7 60561.4 60612.4 60663.0 60701.0 62959.7 63023.0 63106.4 63119.4 63430.4 15259.2 15961.3 15962.8 16578.5 16612.3 9899.1 10061.0 11998.9 12092.8 12203.8 18985.7 19003.4 19018.2 19098.9 19154.8 7076.3 7213.5 7362.2 7383.2 7556.9 870.9 938.0 949.4 984.6 1018.9 27089.6 27913.9 28126.7 28309.9 28696.0 1008.5 1034.6 1084.9 1101.7 1139.5 14963.6 15719.4 15741.1 15816.2 15890.2 538204.0 544292.0 544507.0 544632.0 544636.0 57933.4 57960.4 57981.7 58236.7 58328.4 1199.9 1237.2 1239.6 1284.7 1336.5 23812.9 27626.0 28257.3 30436.4 30820.7 55922.4 56639.4 56676.0 56854.7 56969.1 325387.0 327051.0 327702.0 327867.0 327891.0 24111.6 24506.9 26388.3 27753.3 28089.7 47070.3 47308.3 47586.5 47630.8 48039.5 38401.5 38620.0 38713.4 40633.2 44188.6 38424.4 40137.2 40834.2 40957.2 41919.6 41443.0 41471.6 42808.8 43671.6 44466.3 33798.7 36185.8 37110.4 37340.3 37675.7 27986.3 28007.3 28198.2 28264.8 28312.0 19:06:38 INFO - PROCESS | 20770 | 19:06:38 INFO - PROCESS | 20770 | [#2] jquery.html Cycles:180 Average:26575.80 Median:1318.28 stddev:70644.53 (5358.9%) stddev-sans-first:70815.32 19:06:38 INFO - PROCESS | 20770 | Values: 378.8 382.6 391.3 395.2 404.8 17125.8 19814.0 19978.7 20238.9 20244.5 18784.4 18924.4 19033.3 19159.3 19540.5 5588.5 5630.3 5827.3 5882.5 5883.6 5769.8 5781.2 5823.7 5828.3 5831.3 5561.5 5665.0 5742.0 5801.5 5804.7 5742.0 5800.5 5804.9 5805.0 5805.9 5041.6 5135.1 5260.9 5288.2 5407.9 13915.1 14069.3 14140.4 14151.2 14182.4 2110.9 2133.5 2147.1 2183.7 2257.8 5633.8 9865.3 10019.4 10121.9 10665.9 1811.9 1843.7 1860.1 1896.6 1999.0 79081.8 80635.2 81169.0 82105.6 82816.6 10585.2 10711.1 10904.4 11025.2 11053.2 15582.9 15596.9 15604.9 15609.1 15611.2 7533.9 7699.3 7804.3 7902.2 8076.3 7344.9 7364.7 7570.9 7677.3 7684.4 4544.8 4711.5 4722.5 4789.6 4816.0 1901.6 1975.2 1989.6 2009.0 2010.6 980.5 984.0 1004.5 1035.6 1043.4 18948.4 19038.4 19323.1 19390.5 19465.6 943.4 948.8 953.6 970.1 1014.7 10000.5 10589.7 10645.5 10654.9 10744.6 412726.0 418175.0 431839.0 433727.0 436517.0 86210.6 86671.1 86707.6 87855.6 88136.2 978.4 1016.8 1047.1 1064.0 1064.9 16161.7 16765.7 17010.0 17183.9 17444.0 39065.4 39660.4 40393.4 40713.0 41121.2 53322.0 53525.7 53759.0 53864.5 56222.0 8476.0 8495.2 8558.7 8678.1 8817.1 12010.0 13060.7 13107.6 13210.3 13466.5 10610.2 10834.3 11179.6 11445.3 11732.3 10864.4 10984.7 11111.6 11530.7 11578.1 10966.4 11281.9 11362.5 11856.3 11922.3 7741.2 8291.5 8299.2 8405.2 8585.0 10329.9 10974.5 11198.1 11253.8 11256.8 19:06:38 INFO - PROCESS | 20770 | 19:06:38 INFO - PROCESS | 20770 | [#3] mootools.html Cycles:180 Average:5888.07 Median:4702.79 stddev:3426.82 (72.9%) stddev-sans-first:3419.08 19:06:38 INFO - PROCESS | 20770 | Values: 1299.0 1413.4 1479.5 1604.2 1796.8 7500.4 8922.7 9152.8 9173.1 9431.1 9230.9 9302.3 9302.4 9312.3 9322.7 2359.5 2383.1 2383.2 2387.5 2387.8 2301.6 2319.6 2346.7 2351.6 2351.7 2308.7 2314.9 2326.5 2334.8 2356.3 2291.8 2309.8 2315.5 2321.7 2326.2 2247.4 2253.6 2254.3 2254.6 2257.5 9016.6 9093.0 9145.0 9145.5 9153.7 5274.2 5480.6 5488.9 5490.3 5494.6 3614.4 3630.8 3669.9 3677.4 3705.8 1095.0 1096.7 1105.9 1125.3 1131.0 12731.8 12792.3 12836.6 12841.6 12879.0 4393.4 4525.5 4685.1 4688.4 4717.2 10213.2 10222.9 10230.2 10239.0 10246.1 5394.4 5425.9 5426.5 5439.5 5441.3 4348.8 4464.7 4876.1 4980.5 5028.5 3735.3 3749.8 3856.9 3863.1 3877.7 1118.6 1119.0 1126.9 1151.0 1157.1 860.7 878.5 882.8 904.0 937.4 5762.3 5840.9 5914.2 5933.3 6012.1 894.5 918.2 938.1 943.4 970.4 3859.3 3884.7 3982.3 4080.4 4185.4 10921.9 11143.0 11235.6 11288.8 11357.5 11136.4 11201.3 11201.8 11214.1 11244.7 8479.4 8631.3 8632.2 8642.3 8645.1 5577.8 5621.4 5662.1 5743.8 5819.7 10437.4 10477.9 10574.5 10650.8 10673.4 10111.2 10404.5 10751.1 10860.0 10877.1 7334.6 7487.0 7488.7 7820.8 8280.3 8182.8 8235.1 8567.8 8818.6 8886.1 7371.3 7534.4 7898.2 7908.6 8386.3 7819.8 7861.6 7904.8 7946.1 8009.7 6745.7 6850.1 6854.6 6861.0 6867.1 4949.7 5061.9 5080.5 5194.5 5408.3 4934.2 5034.2 5063.3 5171.1 5484.9 19:06:38 INFO - PROCESS | 20770 | 19:06:38 INFO - PROCESS | 20770 | [#4] prototype.html Cycles:180 Average:4527.08 Median:5058.01 stddev:1309.51 (25.9%) stddev-sans-first:1274.71 19:06:38 INFO - PROCESS | 20770 | Values: 329.4 330.4 331.7 338.6 342.1 5251.2 5297.3 5329.6 5371.6 5375.5 4962.1 5097.3 5139.8 5169.7 5185.6 4137.2 4145.9 4150.2 4154.6 4180.2 4163.4 4175.4 4186.1 4187.2 4194.4 3858.7 3913.5 4084.7 4129.3 4136.3 4103.5 4117.9 4121.0 4124.3 4126.3 3674.5 3691.2 3691.8 3702.3 3713.8 5038.6 5092.7 5136.7 5195.4 5261.8 4663.8 4699.7 4701.0 4704.6 4734.6 5418.8 5489.8 5501.1 5509.6 5536.3 3966.5 3990.2 4024.6 4036.0 4061.4 5649.6 5660.4 5668.3 5674.4 5691.9 4123.2 4149.0 4154.4 4162.6 4164.9 3898.6 4061.8 4219.0 4223.5 4238.3 4629.9 4649.4 4676.6 4696.5 4715.2 5520.9 5534.7 5551.5 5557.7 5560.6 1340.5 1394.4 1416.9 1432.6 1437.5 887.0 908.3 915.9 920.4 920.8 4658.9 4718.0 4748.2 4771.7 4783.2 4998.0 5019.8 5061.6 5063.0 5083.4 4638.5 4765.4 4777.8 4809.5 4830.4 2652.6 2656.4 2671.6 2710.5 2710.8 5045.8 5116.3 5144.3 5191.5 5219.7 4881.4 5057.1 5058.9 5085.5 5104.7 5117.0 5120.8 5132.6 5171.0 5199.6 5048.4 5072.4 5073.4 5078.7 5141.2 4980.4 4994.8 4997.3 5317.2 5703.9 5949.3 5951.7 5975.3 5982.4 5992.0 4022.3 4089.6 4090.4 4091.4 4102.3 5362.6 5576.7 5608.9 5646.5 5698.4 5533.7 5587.6 5598.5 5602.5 5634.6 5347.3 5557.7 5609.7 5640.9 5666.7 5521.7 5545.3 5558.2 5559.6 5560.9 5565.6 5603.2 5617.4 5629.9 5647.8 5216.0 5447.5 5467.3 5467.6 5479.0 19:06:38 INFO - PROCESS | 20770 | 19:06:38 INFO - PROCESS | 20770 | [#5] yui.html Cycles:180 Average:21468.28 Median:4666.45 stddev:30997.46 (664.3%) stddev-sans-first:31045.34 19:06:38 INFO - PROCESS | 20770 | Values: 738.0 757.8 783.7 800.2 838.4 15262.0 15990.6 15996.2 16000.6 16021.6 15525.5 15682.1 15699.7 15713.8 15717.1 660.6 671.8 789.2 789.9 812.3 797.1 816.2 816.4 820.3 822.1 864.1 865.3 866.3 866.4 867.5 700.3 862.6 864.1 864.2 864.4 521.7 609.5 625.7 629.3 630.3 15503.0 15572.1 15627.8 15663.0 15671.2 13994.7 14166.9 14431.9 14472.3 14564.9 13138.2 13165.5 13323.6 13507.2 13967.5 4265.5 4305.6 4384.3 4440.8 4519.4 79354.0 80687.0 80704.0 81793.0 82146.0 11349.9 11509.1 11571.8 11676.2 11775.5 21870.6 21885.5 21886.8 21888.9 21890.7 8329.8 8719.9 8993.1 9001.2 9014.6 4428.7 4545.3 4649.9 4683.0 4688.6 3578.2 3692.1 3712.9 3724.3 3731.6 655.3 662.7 667.4 685.2 692.2 529.0 603.1 674.4 693.4 699.3 8917.5 9308.5 9385.9 9467.6 9542.6 652.2 655.9 671.6 688.7 711.2 4222.3 4330.5 4593.7 4692.2 4753.7 115534.0 117087.4 118186.0 122135.0 122447.0 96740.0 98680.5 99095.0 99390.5 99907.0 86661.6 91147.0 93066.5 95861.5 96198.0 8622.1 8794.7 8868.3 8892.5 8922.5 54044.5 54694.0 55278.0 55439.7 57286.7 68587.3 69581.3 74962.6 78628.6 79923.2 13306.6 13389.3 13406.5 13465.3 13683.2 14020.1 14216.1 14346.6 14484.6 14546.9 13685.7 13974.5 14206.2 14663.9 14722.0 13732.9 14094.5 14367.7 14424.6 14877.0 12900.5 13668.3 13678.8 13819.7 13846.5 11248.9 11340.9 11707.9 11848.9 12007.3 10437.7 10530.7 11253.8 11636.4 11938.0 19:06:38 INFO - PROCESS | 20770 | -------- Summary: end -------- 19:06:38 INFO - PROCESS | 20770 | 19:06:38 INFO - TEST-INFO | 20770: exit 0 19:06:38 INFO - TEST-OK | dromaeo_css | took 1117316ms 19:06:38 INFO - TEST-START | kraken 19:06:38 INFO - operating with platform_type : linux_ 19:06:38 INFO - Initialising browser for kraken test... 19:06:38 INFO - TEST-INFO | started process 21079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcinQmb/profile http://localhost:34330/getInfo.html) 19:06:42 INFO - PROCESS | 21079 | __metrics Screen width/height:1600/1200 19:06:42 INFO - PROCESS | 21079 | colorDepth:24 19:06:42 INFO - PROCESS | 21079 | Browser inner width/height: 1024/697 19:06:42 INFO - PROCESS | 21079 | __metrics 19:06:43 INFO - PROCESS | 21079 | 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" 19:06:43 INFO - PROCESS | 21079 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:06:44 INFO - PROCESS | 21079 | console.error: PushService: 19:06:44 INFO - PROCESS | 21079 | stateChangeProcessEnqueue: Error transitioning state 19:06:44 INFO - PROCESS | 21079 | UnknownError 19:06:44 INFO - TEST-INFO | 21079: exit 0 19:06:44 INFO - Browser initialized. 19:06:44 INFO - Running cycle 1/1 for kraken test... 19:06:44 INFO - TEST-INFO | started process 21162 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcinQmb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:06:56 INFO - PROCESS | 21162 | RSS: Main: 174309376 19:06:56 INFO - PROCESS | 21162 | 19:06:59 INFO - PROCESS | 21162 | Cycle 1(1): loaded http://localhost:34330/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34330/tests/kraken/driver.html?testName=audio-beat-detection) 19:07:00 INFO - PROCESS | 21162 | RSS: Main: 229335040 19:07:00 INFO - PROCESS | 21162 | 19:07:03 INFO - PROCESS | 21162 | Cycle 1(1): loaded http://localhost:34330/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34330/tests/kraken/driver.html?testName=audio-dft) 19:07:03 INFO - PROCESS | 21162 | RSS: Main: 216346624 19:07:03 INFO - PROCESS | 21162 | 19:07:06 INFO - PROCESS | 21162 | Cycle 1(1): loaded http://localhost:34330/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34330/tests/kraken/driver.html?testName=audio-fft) 19:07:07 INFO - PROCESS | 21162 | RSS: Main: 297119744 19:07:07 INFO - PROCESS | 21162 | 19:07:09 INFO - PROCESS | 21162 | Cycle 1(1): loaded http://localhost:34330/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34330/tests/kraken/driver.html?testName=audio-oscillator) 19:07:10 INFO - PROCESS | 21162 | RSS: Main: 209063936 19:07:10 INFO - PROCESS | 21162 | 19:07:12 INFO - PROCESS | 21162 | Cycle 1(1): loaded http://localhost:34330/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34330/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:07:12 INFO - PROCESS | 21162 | RSS: Main: 211886080 19:07:12 INFO - PROCESS | 21162 | 19:07:15 INFO - PROCESS | 21162 | Cycle 1(1): loaded http://localhost:34330/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34330/tests/kraken/driver.html?testName=imaging-darkroom) 19:07:16 INFO - PROCESS | 21162 | RSS: Main: 247803904 19:07:16 INFO - PROCESS | 21162 | 19:07:19 INFO - PROCESS | 21162 | Cycle 1(1): loaded http://localhost:34330/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34330/tests/kraken/driver.html?testName=imaging-desaturate) 19:07:20 INFO - PROCESS | 21162 | RSS: Main: 246751232 19:07:20 INFO - PROCESS | 21162 | 19:07:22 INFO - PROCESS | 21162 | Cycle 1(1): loaded http://localhost:34330/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34330/tests/kraken/driver.html?testName=json-parse-financial) 19:07:23 INFO - PROCESS | 21162 | RSS: Main: 246173696 19:07:23 INFO - PROCESS | 21162 | 19:07:24 INFO - PROCESS | 21162 | Cycle 1(1): loaded http://localhost:34330/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34330/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:07:25 INFO - PROCESS | 21162 | RSS: Main: 209580032 19:07:25 INFO - PROCESS | 21162 | 19:07:27 INFO - PROCESS | 21162 | Cycle 1(1): loaded http://localhost:34330/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34330/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:07:27 INFO - PROCESS | 21162 | RSS: Main: 217260032 19:07:27 INFO - PROCESS | 21162 | 19:07:29 INFO - PROCESS | 21162 | Cycle 1(1): loaded http://localhost:34330/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34330/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:07:30 INFO - PROCESS | 21162 | RSS: Main: 225910784 19:07:30 INFO - PROCESS | 21162 | 19:07:33 INFO - PROCESS | 21162 | Cycle 1(1): loaded http://localhost:34330/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:07:33 INFO - PROCESS | 21162 | RSS: Main: 234328064 19:07:33 INFO - PROCESS | 21162 | 19:07:36 INFO - PROCESS | 21162 | Cycle 1(1): loaded http://localhost:34330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:07:37 INFO - PROCESS | 21162 | RSS: Main: 231538688 19:07:37 INFO - PROCESS | 21162 | 19:07:38 INFO - PROCESS | 21162 | Cycle 1(1): loaded http://localhost:34330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34330/tests/kraken/driver.html?testName=ai-astar) 19:07:39 INFO - PROCESS | 21162 | RSS: Main: 283209728 19:07:39 INFO - PROCESS | 21162 | 19:07:39 INFO - PROCESS | 21162 | __start_tp_report 19:07:39 INFO - PROCESS | 21162 | _x_x_mozilla_page_load 19:07:39 INFO - PROCESS | 21162 | _x_x_mozilla_page_load_details 19:07:39 INFO - PROCESS | 21162 | |i|pagename|runs| 19:07:39 INFO - PROCESS | 21162 | |0;ai-astar;103;110;109;110;109;109;109;108;109;109 19:07:39 INFO - PROCESS | 21162 | |1;audio-beat-detection;149;124;122;166;124;128;130;130;154;125 19:07:39 INFO - PROCESS | 21162 | |2;audio-dft;160;160;160;159;159;163;164;162;162;162 19:07:39 INFO - PROCESS | 21162 | |3;audio-fft;75;76;76;105;77;76;76;77;104;74 19:07:39 INFO - PROCESS | 21162 | |4;audio-oscillator;84;84;120;83;84;84;103;83;81;113 19:07:39 INFO - PROCESS | 21162 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 19:07:39 INFO - PROCESS | 21162 | |6;imaging-darkroom;145;146;146;146;145;147;145;145;145;145 19:07:39 INFO - PROCESS | 21162 | |7;imaging-desaturate;84;84;84;84;84;84;84;85;84;84 19:07:39 INFO - PROCESS | 21162 | |8;json-parse-financial;52;51;51;51;52;53;52;53;52;52 19:07:39 INFO - PROCESS | 21162 | |9;json-stringify-tinderbox;59;58;58;59;59;59;59;59;60;59 19:07:39 INFO - PROCESS | 21162 | |10;stanford-crypto-aes;80;81;81;80;86;81;88;80;80;81 19:07:39 INFO - PROCESS | 21162 | |11;stanford-crypto-ccm;143;130;133;135;131;138;130;130;168;139 19:07:39 INFO - PROCESS | 21162 | |12;stanford-crypto-pbkdf2;165;166;168;165;166;165;169;168;168;163 19:07:39 INFO - PROCESS | 21162 | |13;stanford-crypto-sha256-iterative;65;66;68;66;64;65;64;65;63;64 19:07:39 INFO - PROCESS | 21162 | __end_tp_report 19:07:39 INFO - PROCESS | 21162 | __start_cc_report 19:07:39 INFO - PROCESS | 21162 | _x_x_mozilla_cycle_collect,1673 19:07:39 INFO - PROCESS | 21162 | __end_cc_report 19:07:39 INFO - PROCESS | 21162 | __startTimestamp1477188459250__endTimestamp 19:07:39 INFO - PROCESS | 21162 | 19:07:39 INFO - PROCESS | 21162 | ------- Summary: start ------- 19:07:39 INFO - PROCESS | 21162 | Number of tests: 14 19:07:39 INFO - PROCESS | 21162 | 19:07:39 INFO - PROCESS | 21162 | [#0] ai-astar Cycles:10 Average:108.50 Median:109.00 stddev:2.01 (1.8%) stddev-sans-first:0.60 19:07:39 INFO - PROCESS | 21162 | Values: 103.0 110.0 109.0 110.0 109.0 109.0 109.0 108.0 109.0 109.0 19:07:39 INFO - PROCESS | 21162 | 19:07:39 INFO - PROCESS | 21162 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:130.00 stddev:15.38 (11.8%) stddev-sans-first:15.48 19:07:39 INFO - PROCESS | 21162 | Values: 149.0 124.0 122.0 166.0 124.0 128.0 130.0 130.0 154.0 125.0 19:07:39 INFO - PROCESS | 21162 | 19:07:39 INFO - PROCESS | 21162 | [#2] audio-dft Cycles:10 Average:161.10 Median:162.00 stddev:1.73 (1.1%) stddev-sans-first:1.79 19:07:39 INFO - PROCESS | 21162 | Values: 160.0 160.0 160.0 159.0 159.0 163.0 164.0 162.0 162.0 162.0 19:07:39 INFO - PROCESS | 21162 | 19:07:39 INFO - PROCESS | 21162 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:12.10 (15.9%) stddev-sans-first:12.60 19:07:39 INFO - PROCESS | 21162 | Values: 75.0 76.0 76.0 105.0 77.0 76.0 76.0 77.0 104.0 74.0 19:07:39 INFO - PROCESS | 21162 | 19:07:39 INFO - PROCESS | 21162 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:83.50 stddev:14.47 (17.3%) stddev-sans-first:15.06 19:07:39 INFO - PROCESS | 21162 | Values: 84.0 84.0 120.0 83.0 84.0 84.0 103.0 83.0 81.0 113.0 19:07:39 INFO - PROCESS | 21162 | 19:07:39 INFO - PROCESS | 21162 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:07:39 INFO - PROCESS | 21162 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 19:07:39 INFO - PROCESS | 21162 | 19:07:39 INFO - PROCESS | 21162 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 19:07:39 INFO - PROCESS | 21162 | Values: 145.0 146.0 146.0 146.0 145.0 147.0 145.0 145.0 145.0 145.0 19:07:39 INFO - PROCESS | 21162 | 19:07:39 INFO - PROCESS | 21162 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 19:07:39 INFO - PROCESS | 21162 | Values: 84.0 84.0 84.0 84.0 84.0 84.0 84.0 85.0 84.0 84.0 19:07:39 INFO - PROCESS | 21162 | 19:07:39 INFO - PROCESS | 21162 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 19:07:39 INFO - PROCESS | 21162 | Values: 52.0 51.0 51.0 51.0 52.0 53.0 52.0 53.0 52.0 52.0 19:07:39 INFO - PROCESS | 21162 | 19:07:39 INFO - PROCESS | 21162 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 19:07:39 INFO - PROCESS | 21162 | Values: 59.0 58.0 58.0 59.0 59.0 59.0 59.0 59.0 60.0 59.0 19:07:39 INFO - PROCESS | 21162 | 19:07:39 INFO - PROCESS | 21162 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:81.00 stddev:2.82 (3.5%) stddev-sans-first:2.92 19:07:39 INFO - PROCESS | 21162 | Values: 80.0 81.0 81.0 80.0 86.0 81.0 88.0 80.0 80.0 81.0 19:07:39 INFO - PROCESS | 21162 | 19:07:39 INFO - PROCESS | 21162 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:136.50 stddev:11.55 (8.5%) stddev-sans-first:12.09 19:07:39 INFO - PROCESS | 21162 | Values: 143.0 130.0 133.0 135.0 131.0 138.0 130.0 130.0 168.0 139.0 19:07:39 INFO - PROCESS | 21162 | 19:07:39 INFO - PROCESS | 21162 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:167.00 stddev:1.89 (1.1%) stddev-sans-first:1.94 19:07:39 INFO - PROCESS | 21162 | Values: 165.0 166.0 168.0 165.0 166.0 165.0 169.0 168.0 168.0 163.0 19:07:39 INFO - PROCESS | 21162 | 19:07:39 INFO - PROCESS | 21162 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.41 (2.2%) stddev-sans-first:1.50 19:07:39 INFO - PROCESS | 21162 | Values: 65.0 66.0 68.0 66.0 64.0 65.0 64.0 65.0 63.0 64.0 19:07:39 INFO - PROCESS | 21162 | -------- Summary: end -------- 19:07:39 INFO - PROCESS | 21162 | 19:07:40 INFO - TEST-INFO | 21162: exit 0 19:07:40 INFO - TEST-OK | kraken | took 61521ms 19:07:40 INFO - SUITE-END | took 1178s 19:07:40 INFO - Completed test suite (00:19:39) 19:07:40 INFO - javascript benchmark 19:07:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3057.8165310081395, 3081.5993920790293, 3101.658817530072, 3116.2676770958833, 3122.828244446556, 5256.027634887544, 5299.761510732017, 5331.2003199520095, 5352.491513306235, 5383.327084114486, 5364.034473794725, 5451.700156491392, 5555.944440555603, 5557.0, 5570.192322113301, 4836.661433699643, 4838.322634831126, 4894.265860120992, 4920.630952678545, 4936.654434189608, 4913.533214344631, 5018.949810501903, 5029.823956161535, 5040.722760248185, 5067.721275329855, 4775.5701986821, 4971.850844474671, 4980.427250866161, 5017.272495488152, 5093.312402825627, 4796.304535842318, 4858.78135483904, 4888.169011268093, 4925.285833554115, 4956.306117143603, 4896.167651499253, 4917.090338287392, 4917.852464426073, 4919.852404427873, 4972.105021096201, 5457.863553411157, 5458.208559758813, 5464.28964234647, 5475.890482190373, 5502.80740174092, 5562.3047119110115, 5608.46719561641, 5702.857428564319, 5737.713114344266, 5844.53243740504, 5781.046127388976, 5807.070868661036, 5832.825015249549, 5859.970700146515, 5870.148828419898, 5419.403865574784, 5425.403205647415, 5425.755840987165, 5425.9728701356635, 5426.647267927572, 5678.5741069419955, 5727.5990680652785, 5792.362840087587, 5892.791977644572, 5905.704714764244, 5617.0, 5667.546596272288, 5668.263125793703, 5736.4550367715, 5738.053221218535, 5669.177969194444, 5690.430956904276, 5735.2257445245195, 5739.684317362585, 5750.654960702288, 5593.692346920877, 5644.379118297066, 5743.6266642668925, 5750.079987202112, 5752.3097228332035, 5690.800821971294, 5710.885782284331, 5716.628419152742, 5757.337906140848, 5765.1640512125505, 4327.675424343124, 4334.089841133397, 4399.186150562156, 4400.625946794495, 4451.287793953017, 3870.612938706107, 3933.547642021147, 3937.0, 3948.6367563842114, 4007.7595344279434, 5344.038073146793, 5455.372632147274, 5471.23402723619, 5486.862828429321, 5494.890102197934, 5749.0, 5754.6547207167705, 5774.566907481872, 5777.624454410534, 5788.710564471844, 5283.709395983181, 5499.175123731392, 5499.862503437366, 5510.0632892408385, 5518.44815518453, 4725.598324142417, 4788.497207793132, 4811.326414302001, 4817.638677099231, 4896.559309662076, 5944.64332140073, 5947.910781338283, 5948.405159484017, 5949.672767997802, 5955.106733989936, 5734.111212762028, 5746.454086861909, 5747.453991870766, 5747.453991870766, 5748.741306641295, 5714.20001199824, 5772.278465191851, 5847.152162936265, 5897.70511474416, 5901.645901245939, 5575.581831362583, 5622.409646987171, 5630.5777066720975, 5634.352049514195, 5694.9179655865255, 5661.207430959751, 5712.5429965601825, 5727.1695604138, 5733.426657334233, 5733.455321744427, 5485.067538518381, 5549.750261238335, 5599.60802743804, 5601.579881508985, 5646.209530665628, 5660.801871934627, 5669.092945128759, 5678.914816277676, 5712.514436272963, 5740.282464691913, 5649.180868774087, 5655.1517272409465, 5658.377578466448, 5658.830235092953, 5669.574781891292, 5476.780928762964, 5579.860503487283, 5642.520385767256, 5724.255846739898, 5733.541316694571, 5525.696086715108, 5564.360098588714, 5609.046462101371, 5661.46216109469, 5677.120046392815], "value": 5307.259929291611, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.1550931357618, 616.0912653835593, 617.0, 635.2059925093636, 652.0610321137565, 31064.37871242574, 43753.78123109384, 44386.11227775451, 44399.890002749904, 44469.332960005624, 45772.0, 46058.93968555506, 46127.53872461274, 46210.76894615531, 46256.76871615645, 7852.0, 8808.251298639623, 8965.32760042996, 8967.058458861824, 8970.50662213578, 7909.406794490407, 10476.842847357295, 10718.35689858611, 10731.248812583122, 11100.500477478492, 10946.945265273662, 10970.670879873616, 10986.835197472044, 11008.174386920973, 11012.559497620086, 10748.623798167066, 10835.970582794662, 10860.0, 10867.565297388095, 10887.237893347468, 10677.626283080133, 10729.83905241422, 10732.248742588023, 10746.785064298749, 10755.892441075568, 43192.78403607962, 43531.0, 43531.347029794575, 43566.425525319704, 43578.12843743139, 3425.880094196691, 3438.9656103438897, 3503.91240218994, 3782.6973842092843, 3839.78881161536, 31621.0, 31817.204569885707, 31955.0, 32514.0, 33949.981500555026, 4259.91480170398, 4263.11920042919, 4276.217878757807, 4392.736435813861, 4396.868093957187, 322372.0, 323722.0, 324295.0, 325334.0, 326002.9999999976, 60124.69937650284, 60561.394386056454, 60612.393876060676, 60663.0, 60701.0, 62959.68520157461, 63023.0, 63106.368936310966, 63119.36880631227, 63430.36569634337, 15259.160746158846, 15961.281742321624, 15962.840371596136, 16578.50264492067, 16612.25244863984, 9899.109080182818, 10061.044200800912, 11998.880011199952, 12092.758144837055, 12203.75592488163, 18985.715214271797, 19003.42989710311, 19018.23927042903, 19098.90450547766, 19154.808451915582, 7076.2923707628825, 7213.4589905757275, 7362.190159082496, 7383.2247614000835, 7556.924430755732, 870.8998465176586, 937.9577918993662, 949.4303417949175, 984.5717113055844, 1018.9388636681823, 27089.593656095174, 27913.860430697718, 28126.71873281282, 28309.858450707616, 28695.978203814248, 1008.4604736466102, 1034.632705389576, 1084.8860869608577, 1101.6860194844592, 1139.4986206069302, 14963.551093467213, 15719.371225151095, 15741.134237616812, 15816.209189540707, 15890.205489725467, 538204.0, 544292.0, 544507.0, 544632.0, 544636.0, 57933.4206657928, 57960.4203957955, 57981.71009144927, 58236.70881645649, 58328.41671583315, 1199.9100067494974, 1237.1525505029083, 1239.5537606461487, 1284.6980959474515, 1336.4854531005633, 23812.880935595906, 27626.0, 28257.293567660974, 30436.39127217399, 30820.69179308268, 55922.44077559335, 56639.433605665065, 56676.0, 56854.71572642276, 56969.14546281892, 325387.0, 327051.0, 327702.0, 327867.0, 327891.0, 24111.638325425483, 24506.87746561327, 26388.340291492867, 27753.306167345978, 28089.71910280871, 47070.29394559016, 47308.2903756437, 47586.52413475821, 47630.761846190544, 48039.519604804904, 38401.48588114946, 38620.0, 38713.41929870998, 40633.1873362537, 44188.627184388424, 38424.42363364496, 40137.1972560553, 40834.183316332914, 40957.180856383304, 41919.58080419279, 41443.0, 41471.58528414798, 42808.78595607002, 43671.56328436802, 44466.3330050043, 33798.66201337955, 36185.75306580584, 37110.44334335041, 37340.25319493649, 37675.73945563275, 27986.331195722538, 28007.299817504725, 28198.15405537837, 28264.762056341726, 28312.01235692444], "value": 20054.60776052359, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.76516559732954, 382.5696091896616, 391.3034798059455, 395.2273305687381, 404.7955782329923, 17125.82874171258, 19814.0, 19978.70031949522, 20238.89880550597, 20244.493887652818, 18784.43646690598, 18924.432267031978, 19033.333833315835, 19159.329423470183, 19540.511487212792, 5588.469095435948, 5630.296212973379, 5827.329857066428, 5882.499987501067, 5883.588148829584, 5769.7692092316465, 5781.161731548944, 5823.708814559255, 5828.329742079652, 5831.329397119343, 5561.4716601922955, 5665.036943719578, 5742.0238559445, 5801.535877129841, 5804.680742559158, 5741.971290143543, 5800.477956983849, 5804.912926306088, 5804.970975145139, 5805.941940580625, 5041.647084704072, 5135.050015747099, 5260.921086183672, 5288.206768984683, 5407.918881216785, 13915.095518791246, 14069.2965351732, 14140.363683634261, 14151.150930944073, 14182.361793719307, 2110.883901385423, 2133.5306232628795, 2147.14114354258, 2183.705199798023, 2257.7855103765114, 5633.774649014034, 9865.309428340019, 10019.398836069859, 10121.898781012169, 10665.893341066567, 1811.9184636691248, 1843.6681397348473, 1860.1131203696366, 1896.5637903282184, 1998.9800101999085, 79081.81377279403, 80635.19364806336, 81169.0, 82105.58947205286, 82816.58591707003, 10585.206109541816, 10711.143108551452, 10904.400257985728, 11025.17311201647, 11053.226274160892, 15582.909196356373, 15596.92201538985, 15604.921975390278, 15609.141497217535, 15611.219439028004, 7533.937981155391, 7699.345555627834, 7804.3366313862825, 7902.234218023646, 8076.313513351313, 7344.889826652605, 7364.705411783576, 7570.924290757132, 7677.347425468898, 7684.423668224794, 4544.772761361919, 4711.505291944365, 4722.456917454468, 4789.592884604847, 4815.975920120377, 1901.5531350132708, 1975.2395327798613, 1989.5821877405617, 2008.9598208035757, 2010.58782949495, 980.4852452462371, 983.9803203935882, 1004.4776716107583, 1035.6012935020071, 1043.446973104256, 18948.446229397337, 19038.428847134608, 19323.130459129374, 19390.515237119183, 19465.610687786164, 943.3820847345, 948.8197242523898, 953.594722243044, 970.0703874299717, 1014.6955913226003, 10000.549975251131, 10589.735256618646, 10645.520951557044, 10654.893451065545, 10744.623938162127, 412726.0, 418175.0, 431839.0, 433727.0, 436517.0, 86210.56894715612, 86671.1332886663, 86707.56646216729, 87855.56072219598, 88136.15251161119, 978.427619842386, 1016.8068067067234, 1047.073340094007, 1063.9574417023387, 1064.9041586257274, 16161.726458734465, 16765.748513772058, 17010.0, 17183.91408043002, 17444.0, 39065.41401879031, 39660.40509392419, 40393.39409908913, 40713.0, 41121.1775764489, 53322.0, 53525.732371337894, 53759.0, 53864.461355385945, 56222.0, 8476.03892832371, 8495.150484951455, 8558.700445484377, 8678.08880067609, 8817.118288171132, 12010.0, 13060.738785224432, 13107.606771796862, 13210.339483026002, 13466.461341546228, 10610.151187905103, 10834.349939003685, 11179.608713695307, 11445.313281203154, 11732.296062236293, 10864.402457864893, 10984.670459886216, 11111.555537778399, 11530.711732206762, 11578.131640126856, 10966.396848173426, 11281.887181128084, 11362.54549818031, 11856.347900865536, 11922.271270665879, 7741.206665048215, 8291.543965081737, 8299.170082991652, 8405.243528082501, 8584.957075214585, 10329.896701032894, 10974.451277435937, 11198.104151667683, 11253.774924501628, 11256.774864502828], "value": 8878.316770690544, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.0452017766934, 1413.4416905322398, 1479.4673917389741, 1604.2139351717653, 1796.8023517413073, 7500.362469190119, 8922.687705930293, 9152.816943661139, 9173.128552787492, 9431.10404511572, 9230.86153707695, 9302.302327325444, 9302.395344302633, 9312.30157738169, 9322.720318390442, 2359.49270906755, 2383.1182462488905, 2383.165891937825, 2387.546366190427, 2387.8209134314907, 2301.551197516485, 2319.5708793873105, 2346.741858395575, 2351.6472529120597, 2351.7295511016196, 2308.6998690170253, 2314.930552083432, 2326.5114325991476, 2334.8015418689347, 2356.3402247370764, 2291.8051965582945, 2309.8267629927823, 2315.502167034079, 2321.651752237161, 2326.1858349577683, 2247.370736193868, 2253.6478113132152, 2254.3349711834885, 2254.5941730488507, 2257.4582100295975, 9016.59425325862, 9093.045230250795, 9144.954275228647, 9145.542722863831, 9153.679621213225, 5274.156135018378, 5480.616356855022, 5488.862778430531, 5490.286262785812, 5494.615376923617, 3614.3855544557487, 3630.8184590770356, 3669.87155449558, 3677.411614141751, 3705.7961812100325, 1094.9726256843562, 1096.6929259807266, 1105.9281146725436, 1125.3360517294836, 1131.04426759389, 12731.809022864665, 12792.296423696693, 12836.614901553061, 12841.614751557468, 12878.969682425477, 4393.428854248928, 4525.524819893863, 4685.0629874025335, 4688.413948256468, 4717.174494463455, 10213.234007449471, 10222.948885255526, 10230.181585473145, 10239.027292407209, 10246.077852993267, 5394.406615272317, 5425.945740542544, 5426.538744206708, 5439.456054394529, 5441.347038355423, 4348.804303806336, 4464.732116073046, 4876.073546026244, 4980.5019498049905, 5028.547430731252, 3735.2545878779074, 3749.7937613430977, 3856.903577410531, 3863.072862512977, 3877.689784817208, 1118.6364431559775, 1119.0040863631375, 1126.9098472122375, 1151.0, 1157.0974639780984, 860.7073594977612, 878.5255961780567, 882.7528292078229, 903.9683611073713, 937.3953799799092, 5762.30852297727, 5840.8539786504825, 5914.201582786355, 5933.2880054393745, 6012.098185272244, 894.4722613657973, 918.2103391083663, 938.1369140390857, 943.4386540008684, 970.4129001953858, 3859.3246181918053, 3884.6892248620607, 3982.342913419311, 4080.449139366207, 4185.351270553069, 10921.890781092246, 11143.0, 11235.606753763579, 11288.830667539993, 11357.545698172145, 11136.38749868765, 11201.271917325348, 11201.831972520418, 11214.10287177024, 11244.66266012021, 8479.364047696448, 8631.266342360845, 8632.179942905414, 8642.30861531076, 8645.13548645143, 5577.8047768327915, 5621.353544342453, 5662.122371032497, 5743.827685169284, 5819.6508209507565, 10437.425941572983, 10477.9476102619, 10574.471276436301, 10650.786984260116, 10673.35959842412, 10111.241656875616, 10404.531796069045, 10751.086157676686, 10860.0, 10877.075448586958, 7334.596597186993, 7486.9625651873575, 7488.700451981859, 7820.765377038698, 8280.296174825207, 8182.7545173644885, 8235.094139644514, 8567.828643427221, 8818.647254109765, 8886.066962968795, 7371.262873712586, 7534.35957943581, 7898.210178982055, 7908.604569771604, 8386.287165590993, 7819.765407037798, 7861.606919654108, 7904.802379940547, 7946.125926148235, 8009.719659811879, 6745.696443660146, 6850.0752398425575, 6854.588724676535, 6861.0, 6867.141607299088, 4949.7030178189425, 5061.898762024813, 5080.517350851663, 5194.4805519447755, 5408.269883565826, 4934.18585933317, 5034.219695947134, 5063.316452278895, 5171.095058364695, 5484.890302194013], "value": 4657.031766762156, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.37583279685, 330.3871318703804, 331.7263257812304, 338.5869239527775, 342.06957076751235, 5251.212318152275, 5297.337832770903, 5329.600279979008, 5371.597130215235, 5375.462453754622, 4962.114396529323, 5097.3373461449955, 5139.794408223666, 5169.689818610886, 5185.55922746566, 4137.234611596849, 4145.88061223471, 4150.211459822624, 4154.584541545844, 4180.205760905434, 4163.375493675958, 4175.394567787669, 4186.141840922619, 4187.20443115807, 4194.433751443562, 3858.7105967052444, 3913.4716813230275, 4084.65280451162, 4129.256733787917, 4136.3381858902585, 4103.466549348581, 4117.91764164715, 4120.979395103035, 4124.340105583093, 4126.257273690734, 3674.52231209941, 3691.206390626028, 3691.833867475943, 3702.315071711742, 3713.814309284525, 5038.647294689336, 5092.745362731848, 5136.691798492103, 5195.437232145955, 5261.76322065508, 4663.790129444184, 4699.718016918996, 4700.976495117503, 4704.5765881070865, 4734.621230301602, 5418.810341638064, 5489.807856724996, 5501.14732216507, 5509.614326997112, 5536.280283563151, 3966.504186976628, 3990.20195960809, 4024.63778259958, 4035.9798201008807, 4061.35018397058, 5649.6327738696855, 5660.377358490563, 5668.291463567054, 5674.375818659944, 5691.943080569183, 4123.175364927027, 4148.958510414857, 4154.356074808409, 4162.604552567501, 4164.916701665949, 3898.6491215790716, 4061.756294622332, 4219.0, 4223.472065991751, 4238.321868501025, 4629.939676843772, 4649.372334734835, 4676.602488788423, 4696.530346965276, 4715.198416269242, 5520.91718624221, 5534.667919924817, 5551.500364967173, 5557.694326811983, 5560.638558493766, 1340.4906135668384, 1394.414345974693, 1416.9089800853285, 1432.6203556057653, 1437.475321507663, 886.9689560865339, 908.3006085314271, 915.922146617545, 920.3603495570514, 920.8066306075799, 4658.906821863544, 4717.976410117927, 4748.216544270226, 4771.659838113334, 4783.210770222944, 4997.9504304096545, 5019.84940451787, 5061.5950723942, 5062.974685126551, 5083.38999320084, 4638.536146385402, 4765.356676848651, 4777.822747872695, 4809.470958194595, 4830.372051633335, 2652.6418933444124, 2656.389030522952, 2671.559192733177, 2710.539208334588, 2710.837349759021, 5045.798168073309, 5116.258142569307, 5144.30551875492, 5191.480851914778, 5219.6607220531305, 4881.389826271716, 5057.115004874206, 5058.912333848167, 5085.466026067284, 5104.719240441811, 5117.0, 5120.795168193231, 5132.615053870974, 5170.957471798693, 5199.63602547818, 5048.368953880765, 5072.391313042459, 5073.365829271341, 5078.7206703631655, 5141.2288156775285, 4980.427250866197, 4994.776279811469, 4997.300377947163, 5317.229001794641, 5703.916255911364, 5949.25634295713, 5951.7024148791525, 5975.282966043928, 5982.371850955587, 5992.0, 4022.2960981828646, 4089.550149483614, 4090.365993271048, 4091.40674602187, 4102.2821006324375, 5362.552110930105, 5576.7211639417055, 5608.860489036273, 5646.548276137817, 5698.373178950229, 5533.723313834212, 5587.636803607753, 5598.460423383602, 5602.52378547828, 5634.6337488063145, 5347.251384806053, 5557.666540007613, 5609.691466969356, 5640.943590564042, 5666.660000399989, 5521.69630670317, 5545.279113715191, 5558.165805284328, 5559.555235581225, 5560.859069258284, 5565.55475561946, 5603.187537807076, 5617.370962420852, 5629.887402252014, 5647.830565083054, 5215.9739201305265, 5447.536959358499, 5467.289252397163, 5467.589930755289, 5479.0], "value": 4112.176279002066, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.9926200737991, 757.7991832164474, 783.6786917363881, 800.2037972217643, 838.354467060364, 15262.0, 15990.600234994132, 15996.200189990497, 16000.599985000381, 16021.59946001349, 15525.456609018687, 15682.137482438462, 15699.686006279897, 15713.84286157141, 15717.13555754436, 660.5574265242275, 671.8051764988147, 789.1634867040941, 789.8815177723359, 812.2851890336495, 797.1191833024511, 816.2368185746317, 816.3754727633366, 820.306840719591, 822.1244374740912, 864.0797550608613, 865.3336930563462, 866.3199388480044, 866.384866744609, 867.5271976772674, 700.271717413889, 862.6290695001147, 864.1358641358642, 864.2049314630555, 864.394923553515, 521.6948085370063, 609.5337067143639, 625.7309356976498, 629.26061877294, 630.2594451519446, 15503.0, 15572.065676059472, 15627.843721562753, 15663.0, 15671.216439177995, 13994.720105597933, 14166.858331416657, 14431.927840360731, 14472.348744306531, 14564.854351456455, 13138.211707297593, 13165.473381064841, 13323.600291991255, 13507.189568625914, 13967.511137110254, 4265.509466411371, 4305.590968857953, 4384.298512238027, 4440.800163992596, 4519.389882365871, 79354.0, 80687.0, 80704.0, 81792.9999999994, 82146.0, 11349.886501134883, 11509.136814738928, 11571.801357742002, 11676.241044332091, 11775.52897884092, 21870.594234634176, 21885.452863678536, 21886.781132188473, 21888.89055554712, 21890.671639925415, 8329.791755206168, 8719.91280087191, 8993.14565116313, 9001.234895033995, 9014.63941442348, 4428.73427594339, 4545.31820226962, 4649.894117705439, 4683.0, 4688.5545873142, 3578.177019285579, 3692.0585250760882, 3712.870049548253, 3724.273766615538, 3731.552213734315, 655.2791928878291, 662.7315937045408, 667.4193451697055, 685.2428066985909, 692.2247083266673, 529.0424331959166, 603.0878494661049, 674.3627272227698, 693.3724978894109, 699.2902204262678, 8917.464952102895, 9308.488033158106, 9385.906140938503, 9467.573959171854, 9542.618295268112, 652.2238536141975, 655.8557117434157, 671.5701950751522, 688.7451642892162, 711.2176605733652, 4222.3244280914905, 4330.523642399334, 4593.678442508993, 4692.202325604655, 4753.691010084333, 115534.0, 117087.41456292664, 118186.0, 122135.0, 122447.0, 96740.0, 98680.50659746655, 99095.0, 99390.5030474843, 99907.0, 86661.5666921674, 91147.0, 93066.53466732622, 95861.5206923961, 96198.0, 8622.094680058504, 8794.736157915273, 8868.290536757173, 8892.510911899908, 8922.464652120894, 54044.45955540551, 54694.0, 55278.0, 55439.72280138574, 57286.7135664319, 68587.3141268581, 69581.3041869595, 74962.6251868759, 78628.60685696534, 79923.2007679939, 13306.600801975956, 13389.330533473481, 13406.463741450623, 13465.259410732111, 13683.179009259477, 14020.142115467692, 14216.147031178163, 14346.641333966318, 14484.637884052983, 14546.927265363605, 13685.726285474433, 13974.510892118727, 14206.21865797391, 14663.853361466248, 14722.0, 13732.86267137316, 14094.50669226572, 14367.712645747235, 14424.567262982127, 14877.0, 12900.548480803127, 13668.31762262339, 13678.794818077937, 13819.654508636962, 13846.515371961934, 11248.943755281498, 11340.886591133984, 11707.88292117068, 11848.881511185122, 12007.257133432071, 10437.739056523344, 10530.684079477627, 11253.76208617035, 11636.418179090842, 11938.0], "value": 7666.119976573697, "unit": "score"}], "name": "dromaeo_css", "value": 7195.090186617229, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 122.0, 166.0, 124.0, 128.0, 130.0, 130.0, 154.0, 125.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 159.0, 159.0, 163.0, 164.0, 162.0, 162.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 105.0, 77.0, 76.0, 76.0, 77.0, 104.0, 74.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 120.0, 83.0, 84.0, 84.0, 103.0, 83.0, 81.0, 113.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 147.0, 145.0, 145.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 51.0, 52.0, 53.0, 52.0, 53.0, 52.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 81.0, 80.0, 86.0, 81.0, 88.0, 80.0, 80.0, 81.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 130.0, 133.0, 135.0, 131.0, 138.0, 130.0, 130.0, 168.0, 139.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 168.0, 165.0, 166.0, 165.0, 169.0, 168.0, 168.0, 163.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 68.0, 66.0, 64.0, 65.0, 64.0, 65.0, 63.0, 64.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1486.3999999999999, "alertThreshold": 2.0}]} 19:07:41 INFO - Return code: 0 19:07:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:07:41 INFO - # TBPL SUCCESS # 19:07:41 INFO - Running post-action listener: _resource_record_post_action 19:07:41 INFO - [mozharness: 2016-10-23 02:07:41.072068Z] Finished run-tests step (success) 19:07:41 INFO - Running post-run listener: _resource_record_post_run 19:07:41 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391856128; Read time: 12; Write time: 269204 19:07:41 INFO - TinderboxPrint: CPU usage
13.1% 19:07:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 19:07:41 INFO - TinderboxPrint: I/O write bytes / time
391,856,128 / 269,204 19:07:41 INFO - TinderboxPrint: CPU idle
8,295.6 (86.9%) 19:07:41 INFO - TinderboxPrint: CPU user
1,196.9 (12.5%) 19:07:41 INFO - TinderboxPrint: Swap in / out
0 / 0 19:07:41 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103530496; Read time: 0; Write time: 88796 19:07:41 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287854592; Read time: 0; Write time: 180408 19:07:41 INFO - Running post-run listener: _upload_blobber_files 19:07:41 INFO - Blob upload gear active. 19:07:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:07:41 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 19:07:41 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'] 19:07:41 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 19:07:42 INFO - (blobuploader) - INFO - Open directory for files ... 19:07:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:07:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:07:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:42 INFO - (blobuploader) - INFO - Done attempting. 19:07:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:07:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:07:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:43 INFO - (blobuploader) - INFO - Done attempting. 19:07:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:07:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:07:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:47 INFO - (blobuploader) - INFO - Done attempting. 19:07:47 INFO - (blobuploader) - INFO - Iteration through files over. 19:07:47 INFO - Return code: 0 19:07:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:07:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:07:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c21bcddcc8d560ae1dbe70166285d01ece93f19c6042a8263399d6a38f5759b7575daf81bef010d15217969e0fbb261b4347a84b035761d2575efedec9f14c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc8e866e9d52da4fac4a38bcbeef281a72b0ce555e5288713179b48d153f6b4c9fe95c77331661a8796eb8e4c2537df1e8f626f2b98e8a7876cd70af3808b0de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dcccd40311bce3ecc0b31c2f9f70428ed95b0a957bf14f7865a535d79e46991c984104dd130cf0b7d76b625cd5dcd7172e7f6f2f575b9ba260835c5a3fe94eb"} 19:07:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:07:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:07:47 INFO - Contents: 19:07:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c21bcddcc8d560ae1dbe70166285d01ece93f19c6042a8263399d6a38f5759b7575daf81bef010d15217969e0fbb261b4347a84b035761d2575efedec9f14c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc8e866e9d52da4fac4a38bcbeef281a72b0ce555e5288713179b48d153f6b4c9fe95c77331661a8796eb8e4c2537df1e8f626f2b98e8a7876cd70af3808b0de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dcccd40311bce3ecc0b31c2f9f70428ed95b0a957bf14f7865a535d79e46991c984104dd130cf0b7d76b625cd5dcd7172e7f6f2f575b9ba260835c5a3fe94eb"} 19:07:47 INFO - Running post-run listener: copy_logs_to_upload_dir 19:07:47 INFO - Copying logs to upload dir... 19:07:47 INFO - mkdir: /builds/slave/test/build/upload/logs 19:07:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.125236 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-22 19:07:46.410666) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-22 19:07:46.413709) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608 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/5c21bcddcc8d560ae1dbe70166285d01ece93f19c6042a8263399d6a38f5759b7575daf81bef010d15217969e0fbb261b4347a84b035761d2575efedec9f14c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc8e866e9d52da4fac4a38bcbeef281a72b0ce555e5288713179b48d153f6b4c9fe95c77331661a8796eb8e4c2537df1e8f626f2b98e8a7876cd70af3808b0de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dcccd40311bce3ecc0b31c2f9f70428ed95b0a957bf14f7865a535d79e46991c984104dd130cf0b7d76b625cd5dcd7172e7f6f2f575b9ba260835c5a3fe94eb"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477175402/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011556 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477175402/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/5c21bcddcc8d560ae1dbe70166285d01ece93f19c6042a8263399d6a38f5759b7575daf81bef010d15217969e0fbb261b4347a84b035761d2575efedec9f14c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc8e866e9d52da4fac4a38bcbeef281a72b0ce555e5288713179b48d153f6b4c9fe95c77331661a8796eb8e4c2537df1e8f626f2b98e8a7876cd70af3808b0de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dcccd40311bce3ecc0b31c2f9f70428ed95b0a957bf14f7865a535d79e46991c984104dd130cf0b7d76b625cd5dcd7172e7f6f2f575b9ba260835c5a3fe94eb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-22 19:07:46.439066) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 19:07:46.439393) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1477187227.447729-1016673608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 19:07:46.524282) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-22 19:07:46.524598) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-22 19:07:46.524919) ========= ========= Total master_lag: 0.16 =========