builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-049 starttime: 1475794204.35 results: success (0) buildid: 20161006154716 builduid: 9c325189d4104d399c429cfc2826fa92 revision: ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 15:50:04.354541) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 15:50:04.354975) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 15:50:04.355241) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 15:50:04.369848) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:50:04.370183) ========= 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=db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 15:50:04-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.9M=0s 2016-10-06 15:50:04 (66.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121855 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:50:04.505569) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:50:04.505888) ========= 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=db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015324 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:50:04.555528) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 15:50:04.558443) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df --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 ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df --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=db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 15:50:04,935 truncating revision to first 12 chars 2016-10-06 15:50:04,935 Setting DEBUG logging. 2016-10-06 15:50:04,935 attempt 1/10 2016-10-06 15:50:04,935 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ef345e3b5fa9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 15:50:06,441 unpacking tar archive at: fx-team-ef345e3b5fa9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.916877 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 15:50:06.489427) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 15:50:06.489769) ========= script_repo_revision: ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 15:50:06.490166) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 15:50:06.490432) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 15:50:06.499331) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-06 15:50:06.499732) ========= /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=db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:50:06 INFO - MultiFileLogger online at 20161006 15:50:06 in /builds/slave/test 15:50:06 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 15:50:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:50:06 INFO - {'append_to_log': False, 15:50:06 INFO - 'base_work_dir': '/builds/slave/test', 15:50:06 INFO - 'blob_upload_branch': 'Fx-Team', 15:50:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:50:06 INFO - 'branch': 'Fx-Team', 15:50:06 INFO - 'buildbot_json_path': 'buildprops.json', 15:50:06 INFO - 'config_files': ('talos/linux_config.py',), 15:50:06 INFO - 'default_actions': ('clobber', 15:50:06 INFO - 'read-buildbot-config', 15:50:06 INFO - 'download-and-extract', 15:50:06 INFO - 'populate-webroot', 15:50:06 INFO - 'create-virtualenv', 15:50:06 INFO - 'install', 15:50:06 INFO - 'run-tests'), 15:50:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:50:06 INFO - 'download_minidump_stackwalk': True, 15:50:06 INFO - 'download_symbols': 'ondemand', 15:50:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:50:06 INFO - 'tooltool.py': '/tools/tooltool.py', 15:50:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:50:06 INFO - '/tools/misc-python/virtualenv.py')}, 15:50:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:50:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:50:06 INFO - 'installer_path': 'installer.exe', 15:50:06 INFO - 'log_level': 'info', 15:50:06 INFO - 'log_name': 'talos', 15:50:06 INFO - 'log_to_console': True, 15:50:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:50:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:50:06 INFO - 'opt_config_files': (), 15:50:06 INFO - 'pip_index': False, 15:50:06 INFO - 'sps_profile': False, 15:50:06 INFO - 'sps_profile_interval': 0, 15:50:06 INFO - 'suite': 'dromaeojs', 15:50:06 INFO - 'system_bits': '32', 15:50:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:50:06 INFO - 'title': 'talos-linux64-ix-049', 15:50:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:50:06 INFO - 'use_talos_json': True, 15:50:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:50:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:50:06 INFO - 'work_dir': 'build'} 15:50:06 INFO - [mozharness: 2016-10-06 22:50:06.969087Z] Running clobber step. 15:50:06 INFO - Running pre-action listener: _resource_record_pre_action 15:50:06 INFO - Running main action method: clobber 15:50:06 INFO - rmtree: /builds/slave/test/build 15:50:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:50:07 INFO - Running post-action listener: _resource_record_post_action 15:50:07 INFO - [mozharness: 2016-10-06 22:50:07.432206Z] Finished clobber step (success) 15:50:07 INFO - [mozharness: 2016-10-06 22:50:07.432307Z] Running read-buildbot-config step. 15:50:07 INFO - Running pre-action listener: _resource_record_pre_action 15:50:07 INFO - Running main action method: read_buildbot_config 15:50:07 INFO - Using buildbot properties: 15:50:07 INFO - { 15:50:07 INFO - "project": "", 15:50:07 INFO - "product": "firefox", 15:50:07 INFO - "script_repo_revision": "production", 15:50:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:50:07 INFO - "repository": "", 15:50:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 15:50:07 INFO - "buildid": "20161006154716", 15:50:07 INFO - "stage_platform": "linux64-pgo", 15:50:07 INFO - "basedir": "/builds/slave/test", 15:50:07 INFO - "buildnumber": 1624, 15:50:07 INFO - "platform": "ubuntu64_hw", 15:50:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:50:07 INFO - "slavebuilddir": "test", 15:50:07 INFO - "branch": "fx-team", 15:50:07 INFO - "revision": "ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df", 15:50:07 INFO - "slavename": "talos-linux64-ix-049", 15:50:07 INFO - "builduid": "9c325189d4104d399c429cfc2826fa92", 15:50:07 INFO - "repo_path": "integration/fx-team" 15:50:07 INFO - } 15:50:07 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:50:07 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 15:50:07 INFO - Running post-action listener: _resource_record_post_action 15:50:07 INFO - [mozharness: 2016-10-06 22:50:07.434857Z] Finished read-buildbot-config step (success) 15:50:07 INFO - [mozharness: 2016-10-06 22:50:07.434945Z] Running download-and-extract step. 15:50:07 INFO - Running pre-action listener: _resource_record_pre_action 15:50:07 INFO - Running main action method: download_and_extract 15:50:07 INFO - mkdir: /builds/slave/test/build/tests 15:50:07 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')]} 15:50:07 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:50:07 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/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 15:50:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/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 15:50:07 INFO - Downloaded 1361 bytes. 15:50:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:50:07 INFO - Using the following test package requirements: 15:50:07 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:50:07 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:50:07 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:50:07 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:07 INFO - u'jsshell-linux-x86_64.zip'], 15:50:07 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:50:07 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:50:07 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:50:07 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:50:07 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:50:07 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:50:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:50:07 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/1475782213/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:50:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:50:07 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:50:07 INFO - Http code: 200 15:50:07 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 15:50:07 INFO - x-amz-cf-id: WicuwyTzeSTkB_qffn6Gfjg6CX-8_r6BKSb2GhCxWK3ZdKv_4CofUw== 15:50:07 INFO - x-amz-replication-status: COMPLETED 15:50:07 INFO - x-amz-version-id: w1P88ttxLDtKSap6UU85ULloCNnisI8m 15:50:07 INFO - Expected file size: 22018140 15:50:07 INFO - Obtained file size: 22018140 15:50:11 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 15:50: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/1475782213/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:50: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/1475782213/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:50:11 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:50:11 INFO - Http code: 200 15:50:11 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 15:50:11 INFO - x-amz-cf-id: mGrsVZeq5mntAutnoJPeTXuMSul0FHlrgrXRtTJve7D3gA1_KgH8Fw== 15:50:11 INFO - x-amz-replication-status: COMPLETED 15:50:11 INFO - x-amz-version-id: w1P88ttxLDtKSap6UU85ULloCNnisI8m 15:50:12 INFO - Expected file size: 22018140 15:50:12 INFO - Obtained file size: 22018140 15:50:16 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/1475782213/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:50:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:50:16 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:50:16 INFO - Http code: 200 15:50:16 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 15:50:16 INFO - x-amz-cf-id: T6bLp8bpkINiicPkVz61I2lzZKWMLm4J7ByA10bPCxk6_mN1lxBOIA== 15:50:16 INFO - x-amz-replication-status: COMPLETED 15:50:16 INFO - x-amz-version-id: JkkGCay6lzPmBKyga2XB6rsQcr24f59Y 15:50:17 INFO - Expected file size: 14409006 15:50:17 INFO - Obtained file size: 14409006 15:50:17 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')]} 15:50:17 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:50:17 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/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 15:50:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/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 15:50:17 INFO - Downloaded 59705984 bytes. 15:50:17 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:50:17 INFO - mkdir: /builds/slave/test/properties 15:50:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:50:17 INFO - Writing to file /builds/slave/test/properties/build_url 15:50:17 INFO - Contents: 15:50:17 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:50:18 INFO - Running post-action listener: _resource_record_post_action 15:50:18 INFO - Running post-action listener: set_extra_try_arguments 15:50:18 INFO - [mozharness: 2016-10-06 22:50:18.205599Z] Finished download-and-extract step (success) 15:50:18 INFO - [mozharness: 2016-10-06 22:50:18.205825Z] Running populate-webroot step. 15:50:18 INFO - Running pre-action listener: _resource_record_pre_action 15:50:18 INFO - Running main action method: populate_webroot 15:50:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:50:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:50:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:50:18 INFO - '--tppagecycles', 15:50:18 INFO - '7'], 15:50:18 INFO - 'tests': ['tsvgm']}}, 15:50:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:50:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:50:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:50:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:50:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:50:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:50:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:18 INFO - 'talos_options': ['--disable-e10s'], 15:50:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:50:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:50:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:18 INFO - 'talos_options': ['--disable-e10s'], 15:50:18 INFO - 'tests': ['damp', 'tps']}, 15:50:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:18 INFO - 'tests': ['damp', 'tps']}, 15:50:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:50:18 INFO - 'tests': ['dromaeo_dom']}, 15:50:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:50:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:50:18 INFO - 'tests': ['basic_compositor_video']}, 15:50:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:50:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:50:18 INFO - 'tests': ['a11yr', 15:50:18 INFO - 'ts_paint', 15:50:18 INFO - 'tpaint', 15:50:18 INFO - 'sessionrestore', 15:50:18 INFO - 'sessionrestore_no_auto_restore', 15:50:18 INFO - 'tabpaint']}, 15:50:18 INFO - 'other-e10s': {'tests': ['a11yr', 15:50:18 INFO - 'ts_paint', 15:50:18 INFO - 'tpaint', 15:50:18 INFO - 'sessionrestore', 15:50:18 INFO - 'sessionrestore_no_auto_restore', 15:50:18 INFO - 'tabpaint']}, 15:50:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:50:18 INFO - 'ts_paint', 15:50:18 INFO - 'tpaint', 15:50:18 INFO - 'sessionrestore', 15:50:18 INFO - 'sessionrestore_no_auto_restore', 15:50:18 INFO - 'tabpaint']}, 15:50:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:50:18 INFO - 'ts_paint', 15:50:18 INFO - 'tpaint', 15:50:18 INFO - 'sessionrestore', 15:50:18 INFO - 'sessionrestore_no_auto_restore', 15:50:18 INFO - 'tabpaint']}, 15:50:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:50:18 INFO - 'tests': ['a11yr', 15:50:18 INFO - 'ts_paint', 15:50:18 INFO - 'tpaint', 15:50:18 INFO - 'sessionrestore', 15:50:18 INFO - 'sessionrestore_no_auto_restore', 15:50:18 INFO - 'tabpaint']}, 15:50:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:50:18 INFO - 'tests': ['a11yr', 15:50:18 INFO - 'ts_paint', 15:50:18 INFO - 'tpaint', 15:50:18 INFO - 'sessionrestore', 15:50:18 INFO - 'sessionrestore_no_auto_restore', 15:50:18 INFO - 'tabpaint']}, 15:50:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:50:18 INFO - 'tests': ['tsvgx', 15:50:18 INFO - 'tsvgr_opacity', 15:50:18 INFO - 'tart', 15:50:18 INFO - 'tscrollx', 15:50:18 INFO - 'cart']}, 15:50:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:50:18 INFO - 'tsvgr_opacity', 15:50:18 INFO - 'tart', 15:50:18 INFO - 'tscrollx', 15:50:18 INFO - 'cart']}, 15:50:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:18 INFO - 'talos_options': ['--disable-e10s'], 15:50:18 INFO - 'tests': ['tp5o']}, 15:50:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:18 INFO - 'tests': ['tp5o']}, 15:50:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:18 INFO - 'talos_options': ['--disable-e10s', 15:50:18 INFO - '--xperf_path', 15:50:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:50:18 INFO - 'tests': ['tp5n']}, 15:50:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:18 INFO - 'talos_options': ['--xperf_path', 15:50:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:50:18 INFO - 'tests': ['tp5n']}}, 15:50:18 INFO - 'talos.zip': {'path': '', 15:50:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:50:18 INFO - Running post-action listener: _resource_record_post_action 15:50:18 INFO - [mozharness: 2016-10-06 22:50:18.220807Z] Finished populate-webroot step (success) 15:50:18 INFO - [mozharness: 2016-10-06 22:50:18.220894Z] Running create-virtualenv step. 15:50:18 INFO - Running pre-action listener: _resource_record_pre_action 15:50:18 INFO - Running main action method: create_virtualenv 15:50:18 INFO - Creating virtualenv /builds/slave/test/build/venv 15:50:18 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 15:50:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:50:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:50:18 INFO - Using real prefix '/usr' 15:50:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:50:18 INFO - Installing distribute.............................................................................................................................................................................................done. 15:50:20 INFO - Installing pip.................done. 15:50:20 INFO - Return code: 0 15:50:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:50:21 INFO - Reading from file tmpfile_stdout 15:50:21 INFO - Output received: 15:50:21 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) 15:50:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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')]} 15:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:21 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 0x7f88a0577f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5930>, '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 0x10c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', '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 15:50:21 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 15:50:21 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 15:50:21 INFO - Using env: {'DISPLAY': ':0', 15:50:21 INFO - 'HOME': '/home/cltbld', 15:50:21 INFO - 'LANG': 'en_US.UTF-8', 15:50:21 INFO - 'LANGUAGE': 'en_US:en', 15:50:21 INFO - 'LOGNAME': 'cltbld', 15:50:21 INFO - 'MAIL': '/var/mail/cltbld', 15:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:21 INFO - 'MOZ_NO_REMOTE': '1', 15:50:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:21 INFO - 'NO_EM_RESTART': '1', 15:50:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:21 INFO - 'PWD': '/builds/slave/test', 15:50:21 INFO - 'SHELL': '/bin/bash', 15:50:21 INFO - 'SHLVL': '1', 15:50:21 INFO - 'TERM': 'linux', 15:50:21 INFO - 'TMOUT': '86400', 15:50:21 INFO - 'USER': 'cltbld', 15:50:21 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', 15:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:21 INFO - '_': '/tools/buildbot/bin/python'} 15:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:21 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 15:50:21 INFO - Cleaning up... 15:50:21 INFO - Return code: 0 15:50:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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')]} 15:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:21 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 0x7f88a0577f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5930>, '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 0x10c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', '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 15:50:21 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 15:50:21 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 15:50:21 INFO - Using env: {'DISPLAY': ':0', 15:50:21 INFO - 'HOME': '/home/cltbld', 15:50:21 INFO - 'LANG': 'en_US.UTF-8', 15:50:21 INFO - 'LANGUAGE': 'en_US:en', 15:50:21 INFO - 'LOGNAME': 'cltbld', 15:50:21 INFO - 'MAIL': '/var/mail/cltbld', 15:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:21 INFO - 'MOZ_NO_REMOTE': '1', 15:50:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:21 INFO - 'NO_EM_RESTART': '1', 15:50:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:21 INFO - 'PWD': '/builds/slave/test', 15:50:21 INFO - 'SHELL': '/bin/bash', 15:50:21 INFO - 'SHLVL': '1', 15:50:21 INFO - 'TERM': 'linux', 15:50:21 INFO - 'TMOUT': '86400', 15:50:21 INFO - 'USER': 'cltbld', 15:50:21 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', 15:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:21 INFO - '_': '/tools/buildbot/bin/python'} 15:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:21 INFO - Downloading/unpacking psutil>=3.1.1 15:50:21 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 15:50:21 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 15:50:21 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 15:50:21 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 15:50:21 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 15:50:21 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 15:50:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:50:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:50:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:50:23 INFO - Installing collected packages: psutil 15:50:23 INFO - Running setup.py install for psutil 15:50:23 INFO - building 'psutil._psutil_linux' extension 15:50:23 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 15:50:23 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 15:50:23 INFO - building 'psutil._psutil_posix' extension 15:50:23 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 15:50:23 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 15:50:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:50:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:50:23 INFO - Successfully installed psutil 15:50:23 INFO - Cleaning up... 15:50:24 INFO - Return code: 0 15:50:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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')]} 15:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88a0577f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5930>, '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 0x10c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', '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 15:50: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:50: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 mozsystemmonitor==0.3 15:50:24 INFO - Using env: {'DISPLAY': ':0', 15:50:24 INFO - 'HOME': '/home/cltbld', 15:50:24 INFO - 'LANG': 'en_US.UTF-8', 15:50:24 INFO - 'LANGUAGE': 'en_US:en', 15:50:24 INFO - 'LOGNAME': 'cltbld', 15:50:24 INFO - 'MAIL': '/var/mail/cltbld', 15:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:24 INFO - 'MOZ_NO_REMOTE': '1', 15:50:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:24 INFO - 'NO_EM_RESTART': '1', 15:50:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:24 INFO - 'PWD': '/builds/slave/test', 15:50:24 INFO - 'SHELL': '/bin/bash', 15:50:24 INFO - 'SHLVL': '1', 15:50:24 INFO - 'TERM': 'linux', 15:50:24 INFO - 'TMOUT': '86400', 15:50:24 INFO - 'USER': 'cltbld', 15:50:24 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', 15:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:24 INFO - '_': '/tools/buildbot/bin/python'} 15:50:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:50:24 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 15:50:24 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 15:50:24 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 15:50:24 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 15:50:24 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 15:50:24 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 15:50:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:50:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:50:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:50:26 INFO - Installing collected packages: mozsystemmonitor 15:50:26 INFO - Running setup.py install for mozsystemmonitor 15:50:26 INFO - Successfully installed mozsystemmonitor 15:50:26 INFO - Cleaning up... 15:50:26 INFO - Return code: 0 15:50:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:50:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:26 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 0x7f88a0577f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5930>, '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 0x10c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', '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 15:50:26 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 15:50:26 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 15:50:26 INFO - Using env: {'DISPLAY': ':0', 15:50:26 INFO - 'HOME': '/home/cltbld', 15:50:26 INFO - 'LANG': 'en_US.UTF-8', 15:50:26 INFO - 'LANGUAGE': 'en_US:en', 15:50:26 INFO - 'LOGNAME': 'cltbld', 15:50:26 INFO - 'MAIL': '/var/mail/cltbld', 15:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:26 INFO - 'MOZ_NO_REMOTE': '1', 15:50:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:26 INFO - 'NO_EM_RESTART': '1', 15:50:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:26 INFO - 'PWD': '/builds/slave/test', 15:50:26 INFO - 'SHELL': '/bin/bash', 15:50:26 INFO - 'SHLVL': '1', 15:50:26 INFO - 'TERM': 'linux', 15:50:26 INFO - 'TMOUT': '86400', 15:50:26 INFO - 'USER': 'cltbld', 15:50:26 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', 15:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:26 INFO - '_': '/tools/buildbot/bin/python'} 15:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:26 INFO - Downloading/unpacking jsonschema==2.5.1 15:50:26 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 15:50:26 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 15:50:26 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 15:50:26 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 15:50:26 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 15:50:26 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 15:50:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:50:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:50:28 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 15:50:28 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 15:50:28 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 15:50:28 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 15:50:28 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 15:50:28 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 15:50:28 INFO - Downloading functools32-3.2.3-2.tar.gz 15:50:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:50:28 INFO - warning: no files found matching '*.txt' 15:50:28 INFO - no previously-included directories found matching 'build' 15:50:28 INFO - no previously-included directories found matching 'dist' 15:50:28 INFO - no previously-included directories found matching '.git*' 15:50:28 INFO - Installing collected packages: jsonschema, functools32 15:50:28 INFO - Running setup.py install for functools32 15:50:28 INFO - warning: no files found matching '*.txt' 15:50:28 INFO - no previously-included directories found matching 'build' 15:50:28 INFO - no previously-included directories found matching 'dist' 15:50:28 INFO - no previously-included directories found matching '.git*' 15:50:28 INFO - Successfully installed jsonschema functools32 15:50:28 INFO - Cleaning up... 15:50:28 INFO - Return code: 0 15:50:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:50:28 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')]} 15:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:28 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')]} 15:50:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:28 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 0x7f88a0577f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5930>, '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 0x10c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', '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 15:50:28 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 15:50:28 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 15:50:28 INFO - Using env: {'DISPLAY': ':0', 15:50:28 INFO - 'HOME': '/home/cltbld', 15:50:28 INFO - 'LANG': 'en_US.UTF-8', 15:50:28 INFO - 'LANGUAGE': 'en_US:en', 15:50:28 INFO - 'LOGNAME': 'cltbld', 15:50:28 INFO - 'MAIL': '/var/mail/cltbld', 15:50:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:28 INFO - 'MOZ_NO_REMOTE': '1', 15:50:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:28 INFO - 'NO_EM_RESTART': '1', 15:50:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:28 INFO - 'PWD': '/builds/slave/test', 15:50:28 INFO - 'SHELL': '/bin/bash', 15:50:28 INFO - 'SHLVL': '1', 15:50:28 INFO - 'TERM': 'linux', 15:50:28 INFO - 'TMOUT': '86400', 15:50:28 INFO - 'USER': 'cltbld', 15:50:28 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', 15:50:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:28 INFO - '_': '/tools/buildbot/bin/python'} 15:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:50:29 INFO - Cleaning up... 15:50:29 INFO - Return code: 0 15:50:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:29 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 0x7f88a0577f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5930>, '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 0x10c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', '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 15:50:29 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 15:50:29 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 15:50:29 INFO - Using env: {'DISPLAY': ':0', 15:50:29 INFO - 'HOME': '/home/cltbld', 15:50:29 INFO - 'LANG': 'en_US.UTF-8', 15:50:29 INFO - 'LANGUAGE': 'en_US:en', 15:50:29 INFO - 'LOGNAME': 'cltbld', 15:50:29 INFO - 'MAIL': '/var/mail/cltbld', 15:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:29 INFO - 'MOZ_NO_REMOTE': '1', 15:50:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:29 INFO - 'NO_EM_RESTART': '1', 15:50:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:29 INFO - 'PWD': '/builds/slave/test', 15:50:29 INFO - 'SHELL': '/bin/bash', 15:50:29 INFO - 'SHLVL': '1', 15:50:29 INFO - 'TERM': 'linux', 15:50:29 INFO - 'TMOUT': '86400', 15:50:29 INFO - 'USER': 'cltbld', 15:50:29 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', 15:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:29 INFO - '_': '/tools/buildbot/bin/python'} 15:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:29 INFO - Downloading/unpacking blobuploader==1.2.4 15:50:29 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 15:50:29 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 15:50:29 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 15:50:29 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 15:50:29 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 15:50:29 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 15:50:31 INFO - Downloading blobuploader-1.2.4.tar.gz 15:50:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:50:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:50:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:31 INFO - Downloading docopt-0.6.1.tar.gz 15:50:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:50:32 INFO - Installing collected packages: blobuploader, requests, docopt 15:50:32 INFO - Running setup.py install for blobuploader 15:50:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:50:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:50:32 INFO - Running setup.py install for requests 15:50:32 INFO - Running setup.py install for docopt 15:50:32 INFO - Successfully installed blobuploader requests docopt 15:50:32 INFO - Cleaning up... 15:50:32 INFO - Return code: 0 15:50:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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')]} 15:50:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:32 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 0x7f88a0577f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5930>, '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 0x10c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', '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 15:50:32 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 15:50:32 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 15:50:32 INFO - Using env: {'DISPLAY': ':0', 15:50:32 INFO - 'HOME': '/home/cltbld', 15:50:32 INFO - 'LANG': 'en_US.UTF-8', 15:50:32 INFO - 'LANGUAGE': 'en_US:en', 15:50:32 INFO - 'LOGNAME': 'cltbld', 15:50:32 INFO - 'MAIL': '/var/mail/cltbld', 15:50:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:32 INFO - 'MOZ_NO_REMOTE': '1', 15:50:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:32 INFO - 'NO_EM_RESTART': '1', 15:50:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:32 INFO - 'PWD': '/builds/slave/test', 15:50:32 INFO - 'SHELL': '/bin/bash', 15:50:32 INFO - 'SHLVL': '1', 15:50:32 INFO - 'TERM': 'linux', 15:50:32 INFO - 'TMOUT': '86400', 15:50:32 INFO - 'USER': 'cltbld', 15:50:32 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', 15:50:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:32 INFO - '_': '/tools/buildbot/bin/python'} 15:50:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:50:32 INFO - Running setup.py (path:/tmp/pip-hNCHOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:50:32 INFO - Running setup.py (path:/tmp/pip-9Nelkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:50:33 INFO - Running setup.py (path:/tmp/pip-1E4tH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:50:33 INFO - Running setup.py (path:/tmp/pip-nmD0iR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:50:33 INFO - Running setup.py (path:/tmp/pip-Z5A5l4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:50:33 INFO - Running setup.py (path:/tmp/pip-Jm1Nvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:50:33 INFO - Running setup.py (path:/tmp/pip-PD7_cK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:50:33 INFO - Running setup.py (path:/tmp/pip-8Hr0Vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:50:33 INFO - Running setup.py (path:/tmp/pip-7N26y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:50:33 INFO - Running setup.py (path:/tmp/pip-aF2oRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:50:33 INFO - Running setup.py (path:/tmp/pip-dPphgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:50:33 INFO - Running setup.py (path:/tmp/pip-2SopTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:50:33 INFO - Running setup.py (path:/tmp/pip-h2POEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:50:33 INFO - Running setup.py (path:/tmp/pip-5C0ea_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:33 INFO - Running setup.py (path:/tmp/pip-y4XH72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:50:33 INFO - Running setup.py (path:/tmp/pip-bri_sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:50:34 INFO - Running setup.py (path:/tmp/pip-IvVnSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:50:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:50:34 INFO - Running setup.py install for manifestparser 15:50:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:50:34 INFO - Running setup.py install for mozcrash 15:50:34 INFO - Running setup.py install for mozdebug 15:50:34 INFO - Running setup.py install for mozdevice 15:50:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:50:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:50:34 INFO - Running setup.py install for mozfile 15:50:34 INFO - Running setup.py install for mozhttpd 15:50:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:50:34 INFO - Running setup.py install for mozinfo 15:50:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:50:34 INFO - Running setup.py install for mozInstall 15:50:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:50:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:50:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:50:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:50:34 INFO - Running setup.py install for mozleak 15:50:34 INFO - Running setup.py install for mozlog 15:50:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:50:35 INFO - Running setup.py install for moznetwork 15:50:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:50:35 INFO - Running setup.py install for mozprocess 15:50:35 INFO - Running setup.py install for mozprofile 15:50:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:50:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:50:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:50:35 INFO - Running setup.py install for mozrunner 15:50:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:50:35 INFO - Running setup.py install for mozscreenshot 15:50:35 INFO - Running setup.py install for moztest 15:50:35 INFO - Running setup.py install for mozversion 15:50:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:50:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:50:35 INFO - Cleaning up... 15:50:35 INFO - Return code: 0 15:50:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:50:35 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')]} 15:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:35 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')]} 15:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:35 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 0x7f88a0577f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5930>, '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 0x10c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', '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 15:50:35 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 15:50:35 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 15:50:35 INFO - Using env: {'DISPLAY': ':0', 15:50:35 INFO - 'HOME': '/home/cltbld', 15:50:35 INFO - 'LANG': 'en_US.UTF-8', 15:50:35 INFO - 'LANGUAGE': 'en_US:en', 15:50:35 INFO - 'LOGNAME': 'cltbld', 15:50:35 INFO - 'MAIL': '/var/mail/cltbld', 15:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:35 INFO - 'MOZ_NO_REMOTE': '1', 15:50:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:35 INFO - 'NO_EM_RESTART': '1', 15:50:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:35 INFO - 'PWD': '/builds/slave/test', 15:50:35 INFO - 'SHELL': '/bin/bash', 15:50:35 INFO - 'SHLVL': '1', 15:50:35 INFO - 'TERM': 'linux', 15:50:35 INFO - 'TMOUT': '86400', 15:50:35 INFO - 'USER': 'cltbld', 15:50:35 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', 15:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:35 INFO - '_': '/tools/buildbot/bin/python'} 15:50:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:50:36 INFO - Running setup.py (path:/tmp/pip-WcxbMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:50:36 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)) 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:50:36 INFO - Running setup.py (path:/tmp/pip-fAzW7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:50:36 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)) 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:50:36 INFO - Running setup.py (path:/tmp/pip-4rtuBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:50:36 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)) 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:50:36 INFO - Running setup.py (path:/tmp/pip-ocowrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:50:36 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)) 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:50:36 INFO - Running setup.py (path:/tmp/pip-AsHKaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:50:36 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)) 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:50:36 INFO - Running setup.py (path:/tmp/pip-CVKj50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:50:36 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)) 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:50:36 INFO - Running setup.py (path:/tmp/pip-6iIZ9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:50:36 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)) 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:50:36 INFO - Running setup.py (path:/tmp/pip-CZ0fvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:50:36 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)) 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:50:36 INFO - Running setup.py (path:/tmp/pip-qTidfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:50:36 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)) 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:50:36 INFO - Running setup.py (path:/tmp/pip-d9AIkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:50:36 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)) 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:50:36 INFO - Running setup.py (path:/tmp/pip-akFjAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:50:36 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)) 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:50:36 INFO - Running setup.py (path:/tmp/pip-0npWQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:50:37 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)) 15:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:50:37 INFO - Running setup.py (path:/tmp/pip-ZzCDXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:50:37 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)) 15:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:50:37 INFO - Running setup.py (path:/tmp/pip-rsyT1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:50:37 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)) 15:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:37 INFO - Running setup.py (path:/tmp/pip-dbS4e1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:37 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)) 15:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:50:37 INFO - Running setup.py (path:/tmp/pip-qPqCFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:50:37 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)) 15:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:50:37 INFO - Running setup.py (path:/tmp/pip-aG9hbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:50:37 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)) 15:50:37 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)) 15:50:37 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)) 15:50:37 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)) 15:50:37 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)) 15:50:37 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)) 15:50:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:39 INFO - Downloading blessings-1.6.tar.gz 15:50:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:50:39 INFO - Installing collected packages: blessings 15:50:39 INFO - Running setup.py install for blessings 15:50:39 INFO - Successfully installed blessings 15:50:39 INFO - Cleaning up... 15:50:39 INFO - Return code: 0 15:50:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:50:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:50:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:50:39 INFO - Reading from file tmpfile_stdout 15:50:39 INFO - Current package versions: 15:50:39 INFO - argparse == 1.2.1 15:50:39 INFO - blessings == 1.6 15:50:39 INFO - blobuploader == 1.2.4 15:50:39 INFO - docopt == 0.6.1 15:50:39 INFO - functools32 == 3.2.3-2 15:50:39 INFO - jsonschema == 2.5.1 15:50:39 INFO - manifestparser == 1.1 15:50:39 INFO - mozInstall == 1.12 15:50:39 INFO - mozcrash == 0.17 15:50:39 INFO - mozdebug == 0.1 15:50:39 INFO - mozdevice == 0.48 15:50:39 INFO - mozfile == 1.2 15:50:39 INFO - mozhttpd == 0.7 15:50:39 INFO - mozinfo == 0.9 15:50:39 INFO - mozleak == 0.1 15:50:39 INFO - mozlog == 3.4 15:50:39 INFO - moznetwork == 0.27 15:50:39 INFO - mozprocess == 0.23 15:50:39 INFO - mozprofile == 0.28 15:50:39 INFO - mozrunner == 6.12 15:50:39 INFO - mozscreenshot == 0.1 15:50:39 INFO - mozsystemmonitor == 0.3 15:50:39 INFO - moztest == 0.7 15:50:39 INFO - mozversion == 1.4 15:50:39 INFO - psutil == 3.1.1 15:50:39 INFO - requests == 1.2.3 15:50:39 INFO - wsgiref == 0.1.2 15:50:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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')]} 15:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:39 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 0x7f88a0577f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5930>, '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 0x10c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', '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 15:50:39 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 15:50:39 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 15:50:39 INFO - Using env: {'DISPLAY': ':0', 15:50:39 INFO - 'HOME': '/home/cltbld', 15:50:39 INFO - 'LANG': 'en_US.UTF-8', 15:50:39 INFO - 'LANGUAGE': 'en_US:en', 15:50:39 INFO - 'LOGNAME': 'cltbld', 15:50:39 INFO - 'MAIL': '/var/mail/cltbld', 15:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:39 INFO - 'MOZ_NO_REMOTE': '1', 15:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:39 INFO - 'NO_EM_RESTART': '1', 15:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:39 INFO - 'PWD': '/builds/slave/test', 15:50:39 INFO - 'SHELL': '/bin/bash', 15:50:39 INFO - 'SHLVL': '1', 15:50:39 INFO - 'TERM': 'linux', 15:50:39 INFO - 'TMOUT': '86400', 15:50:39 INFO - 'USER': 'cltbld', 15:50:39 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', 15:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:39 INFO - '_': '/tools/buildbot/bin/python'} 15:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:39 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)) 15:50:39 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)) 15:50:39 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)) 15:50:39 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)) 15:50:39 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)) 15:50:39 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)) 15:50:39 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)) 15:50:39 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)) 15:50:39 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)) 15:50:39 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)) 15:50:39 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)) 15:50:39 INFO - Cleaning up... 15:50:39 INFO - Return code: 0 15:50:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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')]} 15:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88a0577f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5930>, '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 0x10c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', '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 15:50:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:50:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:50:39 INFO - Using env: {'DISPLAY': ':0', 15:50:39 INFO - 'HOME': '/home/cltbld', 15:50:39 INFO - 'LANG': 'en_US.UTF-8', 15:50:39 INFO - 'LANGUAGE': 'en_US:en', 15:50:39 INFO - 'LOGNAME': 'cltbld', 15:50:39 INFO - 'MAIL': '/var/mail/cltbld', 15:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:39 INFO - 'MOZ_NO_REMOTE': '1', 15:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:39 INFO - 'NO_EM_RESTART': '1', 15:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:39 INFO - 'PWD': '/builds/slave/test', 15:50:39 INFO - 'SHELL': '/bin/bash', 15:50:39 INFO - 'SHLVL': '1', 15:50:39 INFO - 'TERM': 'linux', 15:50:39 INFO - 'TMOUT': '86400', 15:50:39 INFO - 'USER': 'cltbld', 15:50:39 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', 15:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:39 INFO - '_': '/tools/buildbot/bin/python'} 15:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:50:40 INFO - Cleaning up... 15:50:40 INFO - Return code: 0 15:50:40 INFO - Running post-action listener: _resource_record_post_action 15:50:40 INFO - Running post-action listener: _start_resource_monitoring 15:50:40 INFO - Starting resource monitoring. 15:50:40 INFO - [mozharness: 2016-10-06 22:50:40.244537Z] Finished create-virtualenv step (success) 15:50:40 INFO - [mozharness: 2016-10-06 22:50:40.245088Z] Running install step. 15:50:40 INFO - Running pre-action listener: _resource_record_pre_action 15:50:40 INFO - Running main action method: install 15:50:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:50:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:50:40 INFO - Reading from file tmpfile_stdout 15:50:40 INFO - Detecting whether we're running mozinstall >=1.0... 15:50:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:50:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:50:40 INFO - Reading from file tmpfile_stdout 15:50:40 INFO - Output received: 15:50:40 INFO - Usage: mozinstall [options] installer 15:50:40 INFO - Options: 15:50:40 INFO - -h, --help show this help message and exit 15:50:40 INFO - -d DEST, --destination=DEST 15:50:40 INFO - Directory to install application into. [default: 15:50:40 INFO - "/builds/slave/test"] 15:50:40 INFO - --app=APP Application being installed. [default: firefox] 15:50:40 INFO - mkdir: /builds/slave/test/build/application 15:50:40 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'] 15:50:40 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 15:50:57 INFO - Reading from file tmpfile_stdout 15:50:57 INFO - Output received: 15:50:57 INFO - /builds/slave/test/build/application/firefox/firefox 15:50:57 INFO - Running post-action listener: _resource_record_post_action 15:50:57 INFO - [mozharness: 2016-10-06 22:50:57.555014Z] Finished install step (success) 15:50:57 INFO - [mozharness: 2016-10-06 22:50:57.555290Z] Running run-tests step. 15:50:57 INFO - Running pre-action listener: _resource_record_pre_action 15:50:57 INFO - Running main action method: run_tests 15:50:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:50:57 INFO - Python 2.7.3 15:50:57 INFO - Return code: 0 15:50:57 INFO - grabbing minidump binary from tooltool 15:50:57 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')]} 15:50:57 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 0x10c5930>, '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 0x10c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:50:57 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 15:50:57 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 15:50:57 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 15:50:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:50:57 INFO - Return code: 0 15:50:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:50:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:50:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:50:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:50:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:50:57 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/1475782213/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 15:50:57 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/1475782213/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 15:50:57 INFO - Using env: {'DISPLAY': ':0', 15:50:57 INFO - 'HOME': '/home/cltbld', 15:50:57 INFO - 'LANG': 'en_US.UTF-8', 15:50:57 INFO - 'LANGUAGE': 'en_US:en', 15:50:57 INFO - 'LOGNAME': 'cltbld', 15:50:57 INFO - 'MAIL': '/var/mail/cltbld', 15:50:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:50:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:57 INFO - 'MOZ_NO_REMOTE': '1', 15:50:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:57 INFO - 'NO_EM_RESTART': '1', 15:50:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:57 INFO - 'PWD': '/builds/slave/test', 15:50:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:50:57 INFO - 'SHELL': '/bin/bash', 15:50:57 INFO - 'SHLVL': '1', 15:50:57 INFO - 'TERM': 'linux', 15:50:57 INFO - 'TMOUT': '86400', 15:50:57 INFO - 'USER': 'cltbld', 15:50:57 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764', 15:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:57 INFO - '_': '/tools/buildbot/bin/python'} 15:50:57 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/1475782213/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 15:50:57 INFO - mozversion application_buildid: 20161006123013 15:50:57 INFO - mozversion application_changeset: ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df 15:50:57 INFO - mozversion application_display_name: Nightly 15:50:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:50:57 INFO - mozversion application_name: Firefox 15:50:57 INFO - mozversion application_remotingname: firefox 15:50:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:50:57 INFO - mozversion application_vendor: Mozilla 15:50:57 INFO - mozversion application_version: 52.0a1 15:50:57 INFO - mozversion platform_buildid: 20161006123013 15:50:57 INFO - mozversion platform_changeset: ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df 15:50:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:50:57 INFO - mozversion platform_version: 52.0a1 15:50:57 INFO - using testdate: 1475794257 15:50:57 INFO - actual date: 1475794257 15:50:57 INFO - starting webserver on 'localhost:58137' 15:50:57 INFO - SUITE-START | Running 2 tests 15:50:57 INFO - TEST-START | dromaeo_css 15:50:57 INFO - operating with platform_type : linux_ 15:50:57 INFO - Initialising browser for dromaeo_css test... 15:50:57 INFO - TEST-INFO | started process 21644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN0KY4k/profile http://localhost:58137/getInfo.html) 15:51:02 INFO - PROCESS | 21644 | __metrics Screen width/height:1600/1200 15:51:02 INFO - PROCESS | 21644 | colorDepth:24 15:51:02 INFO - PROCESS | 21644 | Browser inner width/height: 1024/697 15:51:02 INFO - PROCESS | 21644 | __metrics 15:51:03 INFO - PROCESS | 21644 | 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" 15:51:03 INFO - PROCESS | 21644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:51:03 INFO - PROCESS | 21644 | console.error: PushService: 15:51:03 INFO - PROCESS | 21644 | stateChangeProcessEnqueue: Error transitioning state 15:51:03 INFO - PROCESS | 21644 | UnknownError 15:51:04 INFO - TEST-INFO | 21644: exit 0 15:51:04 INFO - Browser initialized. 15:51:04 INFO - Running cycle 1/1 for dromaeo_css test... 15:51:04 INFO - TEST-INFO | started process 21728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN0KY4k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:51:16 INFO - PROCESS | 21728 | RSS: Main: 173154304 15:51:16 INFO - PROCESS | 21728 | 15:52:07 INFO - PROCESS | 21728 | 1475794327836 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] 15:54:17 INFO - PROCESS | 21728 | Cycle 1(1): loaded http://localhost:58137/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58137/tests/dromaeo/cssquery-ext.html) 15:54:19 INFO - PROCESS | 21728 | RSS: Main: 373207040 15:54:19 INFO - PROCESS | 21728 | 15:57:22 INFO - PROCESS | 21728 | Cycle 1(1): loaded http://localhost:58137/tests/dromaeo/cssquery-ext.html (next: http://localhost:58137/tests/dromaeo/cssquery-jquery.html) 15:57:22 INFO - PROCESS | 21728 | RSS: Main: 278999040 15:57:22 INFO - PROCESS | 21728 | 16:00:24 INFO - PROCESS | 21728 | Cycle 1(1): loaded http://localhost:58137/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58137/tests/dromaeo/cssquery-mootools.html) 16:00:25 INFO - PROCESS | 21728 | RSS: Main: 248340480 16:00:25 INFO - PROCESS | 21728 | 16:03:27 INFO - PROCESS | 21728 | Cycle 1(1): loaded http://localhost:58137/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58137/tests/dromaeo/cssquery-prototype.html) 16:03:27 INFO - PROCESS | 21728 | RSS: Main: 244121600 16:03:27 INFO - PROCESS | 21728 | 16:06:30 INFO - PROCESS | 21728 | Cycle 1(1): loaded http://localhost:58137/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58137/tests/dromaeo/cssquery-yui.html) 16:06:31 INFO - PROCESS | 21728 | RSS: Main: 216846336 16:06:31 INFO - PROCESS | 21728 | 16:09:34 INFO - PROCESS | 21728 | Cycle 1(1): loaded http://localhost:58137/tests/dromaeo/cssquery-yui.html (next: http://localhost:58137/tests/dromaeo/cssquery-dojo.html) 16:09:34 INFO - PROCESS | 21728 | RSS: Main: 311128064 16:09:34 INFO - PROCESS | 21728 | 16:09:34 INFO - PROCESS | 21728 | __start_tp_report 16:09:34 INFO - PROCESS | 21728 | _x_x_mozilla_page_load 16:09:34 INFO - PROCESS | 21728 | _x_x_mozilla_page_load_details 16:09:34 INFO - PROCESS | 21728 | |i|pagename|runs| 16:09:34 INFO - PROCESS | 21728 | |0;dojo.html;2950.557416387542;2981.8210907345556;2986.372861699043;3003.864826082826;3006.2484378905274;5080.720560369178;5141.742912854356;5162.948370516294;5165.81919632813;5241.554467870235;5137.511936366049;5204.895902081966;5227.529522342998;5291.894162116755;5309.283246761686;4714.033623107255;4729.716217026989;4762.547557981995;4783.067301876135;4795.736234507101;4808.687435316693;4812.855614331558;4826.7586620669;4844.806207751686;4939.654224204307;4799.232122860326;4828.082664293791;4832.4684284728655;4841.540053694894;4904.975475122637;4749.715017098985;4789.976050119727;4805.687630304019;4842.975785121052;4847.442544107437;4762.618990480753;4776.713397196179;4790.089882922233;4831.879203019917;4865.19724245499;5258.579313654898;5275.182346736262;5315.574754019669;5318.228856815779;5322.627416080876;5516.172574113875;5571.526420254283;5585.609007369486;5638.859028524279;5648.717564121818;5672.12082127271;5703.4011428799795;5721.456461636138;5784.595078344518;5788.363280039192;5308.389535203462;5314.043472175045;5314.362276526765;5316.175992721134;5317.787288508455;5679.630823996427;5811.070228763378;5811.767529298781;5826.126081087786;5888.146218798251;5449.3188351456065;5462.153366228241;5476.67139971603;5499.395066542677;5558.027345214571;5524.116141417354;5562.610617256753;5569.136783798437;5577;5578.776848926079;5503.514051206152;5565;5565.081761509306;5568.638038527482;5602.85992850182;5412.404635490093;5477.452254774491;5478.315210598676;5547.472990065938;5622.100463925753;4236.68224883135;4277.807498662568;4285.61429471349;4296.978515107467;4300.075483771005;3826.234753049401;3828.157805282833;3833.674137698327;3873.748206366577;3875.844966201377;5286.117018645843;5295.761690723926;5303.337082864642;5306.814261500829;5365.22204280385;5461.508464238238;5474.863128421742;5522.088855338904;5612.607117501817;5631.465010823965;5249.895002099936;5287.709175995357;5292.867678308073;5298.81454149103;5300.231466437422;4807.351007613927;4873.658843880894;4878.902421951541;4879.609631229493;4883.072216278895;5722.856928576819;5796.536277097738;5849.590528662953;5851.64890106595;5853.678047707332;5535.363433205233;5589.189567512606;5600.579956503197;5602.635828671123;5604.8318550443555;5727.083666613488;5728.856778580569;5731.971340143439;5735.54115670737;5741.25363702716;5442.401335853132;5471.534919531725;5500.697461639648;5512;5516.227728117987;5659.688717120598;5663.9716801415725;5669.574781891292;5670.149477578231;5731.19763233156;5497.065498865282;5509.173623956439;5510.118381059011;5516.3380394351325;5516.420775818481;5311.097113490793;5361.624686271924;5364.409914909279;5448.700321482356;5485.782580548841;5410.3507579090765;5432.674039557481;5436.130219164915;5436.6194366393975;5466.972665136649;5482.533984611193;5503.7798488060025;5506.697131657797;5516.531094856982;5521.116621340727;5334.710374482417;5377.758000889891;5380.515753582196;5383.757730902041;5386.865328366822 16:09:34 INFO - PROCESS | 21728 | |1;ext.html;539.3153405771702;570.389683039148;607.2166904692946;615.3907631444871;618.6690120785381;30403.08790736276;33863.66136338636;33916.66083339166;33954.83022584883;45411.31883021758;43484.347734784;43787.34318985218;43856.56143438564;43932;43938.56061439385;8820.426672266314;8968.865467018;8979.146981036823;8983.730488085368;8987.775305617346;7856.882146767803;8025.3980951428875;8806.119388061206;8915.732528024137;10319.896801032006;10762.300450470733;10825.133989280877;10828.458577071155;10834.512446939907;10844;10741;10797;10803.5678572857;10806.35161890289;10810.891891081068;10563.524641391155;10579.365238085662;10618.25672202946;10630.362178269328;10636;40685.1862962742;40936.79531602353;40978.38532422016;40982.79508602468;41102.38346424806;3434.5191673165778;3532.2052538178705;3628.7299445194235;3813.427985802124;3834.750741201813;30089.398212035638;31130.37739245225;31150.688493115005;31150.68849311523;31311.06066817976;4279.229738647043;4422.04925940921;4429.955700442986;4435.733855968652;4576.519465456113;230236;233461;233557;233614;233935.9999999983;55373.446265536826;55400.16899746507;55496.72251638716;55814.441855580924;55823;58917.70541147267;58963.705181473815;59190.70404648035;59194;59211.40788592145;17329.393471228446;17614.823851761317;17614.91192544029;17626.2068206931;17634.82365176332;13692.863071369358;13763.105398149088;13767.586972390844;13773.517926872712;13777.931110344383;14214.715705685829;14526.273686315642;14535;15069.321880515403;15646.530604081896;4866.430640489176;5664.26364572603;5677.489025987681;5772.6536407815665;5848.912266316009;966.3332300712486;1076.3541874875168;1078.1751959750798;1097.5390336058874;1107.9224454288124;31187;31304.53043204354;31510.842445787624;31735.682643173735;32094.19764505906;1123.7582471369183;1141.9086473082134;1166.9542494090417;1167.3521195736278;1183.7395772929942;16125.677486450206;16716.916415417843;16821.32714691423;16857.38821320885;16957.321707131825;500993;506351;506928;507761;507795;47396;48474;52862.73568632209;55603;55959;1315.4738104757982;1362.7206422683325;1372.2658377767846;1378.0353752373378;1391.7703578909366;30450.84774576113;33187.66812331846;33271.50092748562;33281.83359083189;33416.33167336688;49733.75133124311;49900;50206.49793502018;50240;50242.748786255834;396650;404213;407001;428702;611491;27086.18741437681;27123.321916951445;27159.456810864067;27510.862445687642;27512.862435687694;44967.7751611253;45418;45715.31427028531;45891.08217835558;46406.53593464022;38443.80778096092;38853.611463885;39081.609183908935;39368.73256616143;40410;39277;39441.802790985865;39595.20809583735;40102.59897400989;41175.17649646931;37667.43498847465;37905.43141852819;39106.4134037984;39642;39795;32703;35827;36187;36317.0920726984;36359;26696.866515667298;26707.599386009613;27335.316617083936;27598.5860212101;27602.723972760014 16:09:34 INFO - PROCESS | 21728 | |2;jquery.html;356.28209158545553;378.7690502937697;379.28504768511345;385.1296070879812;413.0685304638043;14005.719885602282;17611.119444027794;18207.27170913162;19035.619287614238;19186.520336991547;18631.17870722434;19361.322353717624;19459.318923837633;19604.509887252825;19675.606487870235;5511.476409741078;5800.8259752207505;5805.680687562182;5818.854528636797;5826.300843898738;5564.443555644423;5692.715364231793;5752.395998420168;5778.248827652399;5794.5943783935145;5741.110127930177;5747.224124743168;5748.82753517393;5750.597458177929;5751.1373294006025;5492.780288788444;5704.600677952545;5729.1119876419225;5740.512056475204;5747.6551406915305;4992.076465853793;5001.799928002875;5028.446870844205;5058.848234552969;5066.69599824008;22688.43278918024;22806.885965570233;22840.77159228403;22871.199508017307;22882.65676014861;2161.8162456191244;2225.8219342452567;2286.0969916882905;2378.6669866218745;2802.957955630667;6904.102466679299;12324.32216228107;14249.71500569993;14530.491432799907;14844.480443184544;1614.5882799885953;1676.6227598790297;1682.4616122840696;1715.5968347438343;1732.4542769027842;48833;54067.459325406635;78102;79203.60398197972;79982;10024.097831195228;10214.744631384276;10286.382817031003;10524.263301568817;10804.945975270073;14117.2235527047;14141.363638636287;14167.929160354131;14178.220197889215;14207.71584568303;7737.574433406104;8077.636506357228;8118.10700822909;8239.303596949801;8300.460470069425;7777.922220777833;7858.607069646495;7931.762047138595;8121.796955076052;8175.386845986574;6358.300586935434;6506.154199953976;6506.674666266667;6570.277269500351;6683.331666833278;1853.3328001919567;1859.4235786906102;1948.814862588052;1960.5196726802026;1967.8979771327815;853.6414705823569;956.8134213828375;968.7142293023575;981.347403976362;999.5951639585979;19693.06138772251;19930.70103948413;20060.69908951367;20080.59838803216;20131.39605811828;985.5515740338129;1004.1013293102632;1024.9743756406;1053.1259054984343;1106.2753896198003;10753;11275.210735248618;11552.133589980616;11557.30656160633;11615.825762613567;454963;454976;461103.3337999731;461181;474564;77002;77360.61319693366;78745;78950.6052469734;83240.16759832445;1014.7513859104566;1036.7149034015706;1045.9529321180412;1048.8584041154347;1063.1813503602184;17189.914050429667;17341.479755607354;17867;17940.461786146436;18211.726824097914;38022.429663555624;38279.808600956814;39324.803375982934;39583.80208098941;39818.402723958585;49804;50197.24704129514;51639.74180129075;56919.71540142273;59317.406825932914;7608.125065617525;7979.601019948863;8070.556119413489;8218.712345067894;8322.417430779788;10162.644307449204;13053.477860885838;13109.27898965566;13158.80261796093;13313.267770272729;10884.510197040994;10986.615468458565;11179.66461006171;11368.715782105513;11891.227070240408;10991.780164396827;11151.10791136691;11154.498047587716;11158.776824463628;11317.151213658844;10786;11085.39030353306;11338.376389298337;11347.262427942158;11836;8112.75661730149;8238.670453181805;8306.127856574973;8360.83278334442;8746.562671866508;8676.08901065379;10487.423191724529;10540.947295263475;10895.891041089488;11028.338299702044 16:09:34 INFO - PROCESS | 21728 | |3;mootools.html;1334.977509073754;1468.4199741102266;1502.8797696184304;1624.9593760155994;1789.248515623438;7822.569758663279;8682.088380720028;9055.637774489029;9075.591598378072;9292.44245345278;8940.552972351388;9014.86477702835;9015.864762028576;9025.864612030808;9028.68399606014;2305.446692793726;2331.265651319829;2331.5803155432013;2332.125452955142;2334.579775640384;2233.586786444505;2294.4263934016494;2303.2744685424123;2305.873176975266;2309.8036666883336;2224.2993457060975;2236.0385034435267;2237.6643503474447;2303.09027933966;2306.938808148254;2208.712867327253;2231.8102961248314;2240.2943072932057;2246.932592022242;2246.9662955055687;2162.3945295317335;2246.618074927266;2302.4474126209757;2305.147095574648;2309.3880121767743;8953.23897468716;9028.50343231122;9032.593533291018;9036.54817259141;9140.314476414296;5301.920471192935;5442.727863606804;5442.782288708447;5453.100238460649;5456.017916774979;3532.293541291752;3545.822708864572;3605.675489205958;3616.5479315085613;3619.963800361989;1072.8390741388775;1087.423665457309;1094.7427354571669;1110.766738984814;1119.322809700136;12620.116591838574;12758.36208189596;12771.61685149447;12775.297358645365;12783.61649150527;4136.482939632546;4381.40850985113;4395.406620106245;4484.439445069366;4485.372047913294;9781;9782.070703283176;9792.951035244922;9794.510274486247;9802.901970980342;5092.65044763138;5103.438621751604;5106.463821298785;5107.923381149286;5108.642395032386;4164.354525048622;4295.312749959991;4688.507706690816;4788.138135135709;4805.927911081337;3616.439451884962;3667.6882464990776;3695.8727588085353;3758.567764707039;3762.285165818486;1051.8632577764843;1081.6322450366913;1083.2417307884512;1086.5444096342324;1103.8233882578909;956.1824639932896;963.3882484622176;968.2737946540095;984.6553706202915;1002.9749256268651;5738.454846789548;6105.114758360013;6115.877682446326;6224.502039836802;6254.906176407358;440.87875834145865;441.77027945468177;443.7160217460828;446.28594249201666;477.191160982132;3954.406838974177;4068;4107.6508496777515;4130.463039804806;4133.731307465066;11154.219204655596;11454.59908903201;11481.425928703531;11519.654410367702;11532.36571988532;11169.106471482262;11291.717707057389;11319.151063670257;11363.14776391774;11373.772524549462;7931.603419828985;8277.875831862528;8282.958585207036;8312.293455056268;8473.57632118404;6007.669578173242;6110.419510146529;6124.326324104434;6172.197614310111;6260.123582698517;10238.539265733209;10428.58285668595;10599.576016959236;10604.787904242026;10624.309419887682;10553.63062292816;10569.048785609331;10771.353718776898;10799.622013229498;10821.621243256448;7218.566885986857;7454;7749.845003099794;7906.7627971160955;8043.959780201061;8615;8972.955135224282;8996.865047024168;8997.865032024394;8998.595063222301;7744.728934487492;7853.882191767014;7964.960175199087;8080.111187769223;8089.2315230053055;7630.1606823248285;7730.7680769577;7750.961245193738;7822.608869556386;7855.921440785748;7154.177269613853;7252.347288744038;7262.636868156465;7269.890951635835;7271.745488908075;5233.345831771028;5237.397699264481;5357.1696387060065;5396.1366181410785;5430.972845135749;5229.137192363218;5255.553277971415;5315.973420132875;5394.865128371822;5474.452554744494 16:09:34 INFO - PROCESS | 21728 | |4;prototype.html;331.30866924351193;334.43480517924706;340.4229830437408;341.1981842669726;343.90542600784767;4922.286268491067;5072.442031376546;5097.362829646294;5109.540141387274;5129.179331306992;4940.529735132433;5103.26002729604;5121.795128194877;5128.179491281396;5130.153524668434;4061.1268577255883;4073.4500842386196;4073.9388909166387;4083.448734420845;4087.2234275487713;3794.4877441545314;3815.740805534167;4071.3282308419075;4088.8160032798446;4096.692748043909;4032.213718324928;4033.334499807543;4045.393191021341;4051.5138183417885;4055.614716601918;4022.3765316376007;4029.37544680575;4035.778032208227;4049.7367671101283;4050.946753844007;3603.7117030637487;3607.4408466687705;3613.313470440608;3613.981930090359;3628.673419392241;4846.418429788413;4958.504149585049;4963.858312588089;4980.850574482772;5027.09512287788;4580.5190455002075;4598.747068911209;4600.493945665974;4601.4248218972625;4614.700044497097;5089.770960306795;5312.123499622558;5317.697164194797;5329.813456529003;5339.5194432500875;3875.3411919973673;3878.8642397516232;3879.301725689375;3886.4947556817433;3895.5325360956585;5498.80754173606;5536.723163841792;5539.279893613845;5549.306336707911;5556.888862222773;3781.6596506314563;3977.801109944491;3982.8605998789903;3984.5019372578427;3994.121293315466;4000.3799411091327;4038.8586399475876;4040.9797951010646;4045.4943132108488;4064.5122585289955;4580.908381832344;4581.610563102174;4594.264917613166;4597.540245975376;4605.815767369335;5365.946340536545;5370.382406023357;5408.810691625853;5443.891122177534;5450.446622712587;1316.1642357103308;1338.6118025772416;1348.2045593099922;1352.1413902172192;1400.4608225833128;914.689005738039;934.56075644447;946.9857952130724;978.7944531648434;979.647326962293;5094.541491265803;5124.692518448905;5129.179331306973;5154.355705536808;5163.561097306696;5265.998380922837;5350.5184533392185;5428.647137936022;5481.451854814566;5484.588655850827;5061.291419201315;5084.313617661643;5104.2088476286235;5121.206213036985;5127.231105268751;2864.4127953769425;2873.9712602874124;2879.0566367701717;2886.3649997000625;2897.435000174946;5370.248165256867;5583.162525621189;5589.692566908778;5591.384947655754;5620.381758006616;5511.421300763443;5519.862003449946;5525.944740552623;5544.251526043932;5558.221848941152;5621.662700237999;5634.577406694514;5638.464345887134;5644.802431915027;5659.471942575564;5277.868053298698;5325.760340784752;5377.24718539397;5404.513593776579;5408.72956352173;5352.4915133062295;5361.874006458687;5379.273798037215;5383.407825139153;5401.945980540301;5438.6192966493545;5584.748686309044;5593.944060559343;5620.943790562042;5636.464535869086;3924.3517722556026;3937.3306537888056;3943.467631869661;3952.189801090712;3958.1687845552756;5389.568834493152;5394.946050539601;5398.703071331114;5419.268398766274;5423.2407462954425;5118.283440318432;5242.633015688865;5263.605229607718;5291.682499050069;5321.654092484131;5281.630285879952;5286.97356513215;5310.044192045469;5316.122839731401;5322.855586049018;5081.8475445736685;5195.532402083831;5274.920876186783;5296.417394086724;5313.442088580643;5381.385584324766;5386.78797270611;5394.649347792381;5395.676259424447;5401.351837779334;5130.563902068366;5268.736563171749;5276.5251127398715;5279.234510995807;5289.68261904287 16:09:34 INFO - PROCESS | 21728 | |5;yui.html;737.1927739125662;740.6778051547576;752.5823168141683;787.629813987426;871.3639043498245;14596.124232546055;15057.774133388008;15494.147821869807;15636.765448518281;15699.921500392496;13972.301384930764;14033.228172450512;14135.575932722035;14138.151710897353;14229.78655320171;660.9438197753196;798.9001374828147;819.4427789103407;824.2046425199682;824.4270232188632;685.8936864785941;769.5152054205843;792.5244853088129;802.626778547975;806.7136166660839;849.4266370200121;850.7447765670305;855.2388374346837;855.3499340501232;855.8844555984956;681.9045333653293;708.7413094220624;850.5237067242364;850.5832142250315;850.5959669157132;600.2197143713199;620.5159975219336;623.7847942459844;624.1480379282247;624.684534310175;14916.403343866341;14966.625834354229;14977.475788347356;14979;14982.250887455584;13792.241426721526;14113.153210807384;14232;14324.283785810669;14483.927580362137;12670.736114617786;12750.553730619384;12914.45026596805;13131.540396086186;13330.200187988752;4356.486793933712;4411.404460397869;4420.977895110536;4466.642668586505;4495.64034877209;71722.28277717208;71915.2808471919;72624.27375726229;72809.27190728078;72814;10246.53890574926;10494.580216791242;10557.31377460478;10585.417802020962;10618.787624247472;20709.0680919359;20740.58518829615;20744.896275518528;20748.377548673565;20764.58470830575;8001.719939802196;8013.6794528218215;8026.959865200637;8093.433459657886;8242.776703588752;4371.584699453547;4525.818967241274;4596.701214421052;4644.256918893028;4871.780769865364;3353.4466812975584;3413.8122403268057;3430.9828450858085;3445.5348527948404;3488.4069708149677;632.7279269913889;636.3096040795696;637.9585326953733;647.8088963755704;668.4852663449117;663.9236487803964;695.965201739911;714.2000958926036;716.8172116110359;723.4248772226093;8843.911560884437;8902.910970890338;9105.726828195166;9432.764180895396;9508.714738557854;594.925634295713;651.5862427358661;664.9168853893264;680.5678394219706;696.8362434827811;4209.789510524462;4352.455943007124;4535.342375355555;4573.977130114328;4686.250199967989;64470.35529644737;64963;93027.53486232525;105181;110242;98402;100312;101857;102095;102277.95444091076;66019;87267.56366218255;87562.56218718865;87918.88932772813;88664.5566772162;8451;8795.692150774692;8833.116688331116;8921.330900182382;9050.094990500897;52088.47911520988;52186;52335.73832130815;52427.73786131045;54025.72987135039;45206.54793452023;73746.63126684332;74024;74686.25313746792;77516.83724744247;10560.894391055992;10678.199135064746;10781.730456738644;10809.67570972872;11704.765904682028;11759.941200294286;11894.464749086485;12208.45061972231;12511.186772859735;12937.029722770641;11319.09447244202;11484.598039068593;11547.884521154681;11995.948124011302;12471.189372690746;10496;10817.945910270399;11178.441077945907;11239.943800280946;11582.07343412508;11146.442677866236;11411;11678.474468648761;11763.353015584225;11765.52937882475;8799.250368122837;9047.773805654648;9288.281667891462;9501.192398646193;9899.20806335477;9827.901720982985;9876.308658393844;10018.899811002088;10107.949460252652;10123.493825308558 16:09:34 INFO - PROCESS | 21728 | __end_tp_report 16:09:34 INFO - PROCESS | 21728 | __start_cc_report 16:09:34 INFO - PROCESS | 21728 | _x_x_mozilla_cycle_collect,2012 16:09:34 INFO - PROCESS | 21728 | __end_cc_report 16:09:34 INFO - PROCESS | 21728 | __startTimestamp1475795374549__endTimestamp 16:09:34 INFO - PROCESS | 21728 | 16:09:34 INFO - PROCESS | 21728 | ------- Summary: start ------- 16:09:34 INFO - PROCESS | 21728 | Number of tests: 6 16:09:34 INFO - PROCESS | 21728 | 16:09:34 INFO - PROCESS | 21728 | [#0] dojo.html Cycles:165 Average:5210.55 Median:5386.87 stddev:587.97 (10.9%) stddev-sans-first:562.40 16:09:34 INFO - PROCESS | 21728 | Values: 2950.6 2981.8 2986.4 3003.9 3006.2 5080.7 5141.7 5162.9 5165.8 5241.6 5137.5 5204.9 5227.5 5291.9 5309.3 4714.0 4729.7 4762.5 4783.1 4795.7 4808.7 4812.9 4826.8 4844.8 4939.7 4799.2 4828.1 4832.5 4841.5 4905.0 4749.7 4790.0 4805.7 4843.0 4847.4 4762.6 4776.7 4790.1 4831.9 4865.2 5258.6 5275.2 5315.6 5318.2 5322.6 5516.2 5571.5 5585.6 5638.9 5648.7 5672.1 5703.4 5721.5 5784.6 5788.4 5308.4 5314.0 5314.4 5316.2 5317.8 5679.6 5811.1 5811.8 5826.1 5888.1 5449.3 5462.2 5476.7 5499.4 5558.0 5524.1 5562.6 5569.1 5577.0 5578.8 5503.5 5565.0 5565.1 5568.6 5602.9 5412.4 5477.5 5478.3 5547.5 5622.1 4236.7 4277.8 4285.6 4297.0 4300.1 3826.2 3828.2 3833.7 3873.7 3875.8 5286.1 5295.8 5303.3 5306.8 5365.2 5461.5 5474.9 5522.1 5612.6 5631.5 5249.9 5287.7 5292.9 5298.8 5300.2 4807.4 4873.7 4878.9 4879.6 4883.1 5722.9 5796.5 5849.6 5851.6 5853.7 5535.4 5589.2 5600.6 5602.6 5604.8 5727.1 5728.9 5732.0 5735.5 5741.3 5442.4 5471.5 5500.7 5512.0 5516.2 5659.7 5664.0 5669.6 5670.1 5731.2 5497.1 5509.2 5510.1 5516.3 5516.4 5311.1 5361.6 5364.4 5448.7 5485.8 5410.4 5432.7 5436.1 5436.6 5467.0 5482.5 5503.8 5506.7 5516.5 5521.1 5334.7 5377.8 5380.5 5383.8 5386.9 16:09:34 INFO - PROCESS | 21728 | 16:09:34 INFO - PROCESS | 21728 | [#1] ext.html Cycles:180 Average:55694.99 Median:36338.05 stddev:110633.93 (304.5%) stddev-sans-first:110866.78 16:09:34 INFO - PROCESS | 21728 | Values: 539.3 570.4 607.2 615.4 618.7 30403.1 33863.7 33916.7 33954.8 45411.3 43484.3 43787.3 43856.6 43932.0 43938.6 8820.4 8968.9 8979.1 8983.7 8987.8 7856.9 8025.4 8806.1 8915.7 10319.9 10762.3 10825.1 10828.5 10834.5 10844.0 10741.0 10797.0 10803.6 10806.4 10810.9 10563.5 10579.4 10618.3 10630.4 10636.0 40685.2 40936.8 40978.4 40982.8 41102.4 3434.5 3532.2 3628.7 3813.4 3834.8 30089.4 31130.4 31150.7 31150.7 31311.1 4279.2 4422.0 4430.0 4435.7 4576.5 230236.0 233461.0 233557.0 233614.0 233936.0 55373.4 55400.2 55496.7 55814.4 55823.0 58917.7 58963.7 59190.7 59194.0 59211.4 17329.4 17614.8 17614.9 17626.2 17634.8 13692.9 13763.1 13767.6 13773.5 13777.9 14214.7 14526.3 14535.0 15069.3 15646.5 4866.4 5664.3 5677.5 5772.7 5848.9 966.3 1076.4 1078.2 1097.5 1107.9 31187.0 31304.5 31510.8 31735.7 32094.2 1123.8 1141.9 1167.0 1167.4 1183.7 16125.7 16716.9 16821.3 16857.4 16957.3 500993.0 506351.0 506928.0 507761.0 507795.0 47396.0 48474.0 52862.7 55603.0 55959.0 1315.5 1362.7 1372.3 1378.0 1391.8 30450.8 33187.7 33271.5 33281.8 33416.3 49733.8 49900.0 50206.5 50240.0 50242.7 396650.0 404213.0 407001.0 428702.0 611491.0 27086.2 27123.3 27159.5 27510.9 27512.9 44967.8 45418.0 45715.3 45891.1 46406.5 38443.8 38853.6 39081.6 39368.7 40410.0 39277.0 39441.8 39595.2 40102.6 41175.2 37667.4 37905.4 39106.4 39642.0 39795.0 32703.0 35827.0 36187.0 36317.1 36359.0 26696.9 26707.6 27335.3 27598.6 27602.7 16:09:34 INFO - PROCESS | 21728 | 16:09:34 INFO - PROCESS | 21728 | [#2] jquery.html Cycles:180 Average:27217.62 Median:2590.81 stddev:75738.50 (2923.3%) stddev-sans-first:75924.12 16:09:34 INFO - PROCESS | 21728 | Values: 356.3 378.8 379.3 385.1 413.1 14005.7 17611.1 18207.3 19035.6 19186.5 18631.2 19361.3 19459.3 19604.5 19675.6 5511.5 5800.8 5805.7 5818.9 5826.3 5564.4 5692.7 5752.4 5778.2 5794.6 5741.1 5747.2 5748.8 5750.6 5751.1 5492.8 5704.6 5729.1 5740.5 5747.7 4992.1 5001.8 5028.4 5058.8 5066.7 22688.4 22806.9 22840.8 22871.2 22882.7 2161.8 2225.8 2286.1 2378.7 2803.0 6904.1 12324.3 14249.7 14530.5 14844.5 1614.6 1676.6 1682.5 1715.6 1732.5 48833.0 54067.5 78102.0 79203.6 79982.0 10024.1 10214.7 10286.4 10524.3 10804.9 14117.2 14141.4 14167.9 14178.2 14207.7 7737.6 8077.6 8118.1 8239.3 8300.5 7777.9 7858.6 7931.8 8121.8 8175.4 6358.3 6506.2 6506.7 6570.3 6683.3 1853.3 1859.4 1948.8 1960.5 1967.9 853.6 956.8 968.7 981.3 999.6 19693.1 19930.7 20060.7 20080.6 20131.4 985.6 1004.1 1025.0 1053.1 1106.3 10753.0 11275.2 11552.1 11557.3 11615.8 454963.0 454976.0 461103.3 461181.0 474564.0 77002.0 77360.6 78745.0 78950.6 83240.2 1014.8 1036.7 1046.0 1048.9 1063.2 17189.9 17341.5 17867.0 17940.5 18211.7 38022.4 38279.8 39324.8 39583.8 39818.4 49804.0 50197.2 51639.7 56919.7 59317.4 7608.1 7979.6 8070.6 8218.7 8322.4 10162.6 13053.5 13109.3 13158.8 13313.3 10884.5 10986.6 11179.7 11368.7 11891.2 10991.8 11151.1 11154.5 11158.8 11317.2 10786.0 11085.4 11338.4 11347.3 11836.0 8112.8 8238.7 8306.1 8360.8 8746.6 8676.1 10487.4 10540.9 10895.9 11028.3 16:09:34 INFO - PROCESS | 21728 | 16:09:34 INFO - PROCESS | 21728 | [#3] mootools.html Cycles:180 Average:5869.83 Median:4484.91 stddev:3448.82 (76.9%) stddev-sans-first:3441.66 16:09:34 INFO - PROCESS | 21728 | Values: 1335.0 1468.4 1502.9 1625.0 1789.2 7822.6 8682.1 9055.6 9075.6 9292.4 8940.6 9014.9 9015.9 9025.9 9028.7 2305.4 2331.3 2331.6 2332.1 2334.6 2233.6 2294.4 2303.3 2305.9 2309.8 2224.3 2236.0 2237.7 2303.1 2306.9 2208.7 2231.8 2240.3 2246.9 2247.0 2162.4 2246.6 2302.4 2305.1 2309.4 8953.2 9028.5 9032.6 9036.5 9140.3 5301.9 5442.7 5442.8 5453.1 5456.0 3532.3 3545.8 3605.7 3616.5 3620.0 1072.8 1087.4 1094.7 1110.8 1119.3 12620.1 12758.4 12771.6 12775.3 12783.6 4136.5 4381.4 4395.4 4484.4 4485.4 9781.0 9782.1 9793.0 9794.5 9802.9 5092.7 5103.4 5106.5 5107.9 5108.6 4164.4 4295.3 4688.5 4788.1 4805.9 3616.4 3667.7 3695.9 3758.6 3762.3 1051.9 1081.6 1083.2 1086.5 1103.8 956.2 963.4 968.3 984.7 1003.0 5738.5 6105.1 6115.9 6224.5 6254.9 440.9 441.8 443.7 446.3 477.2 3954.4 4068.0 4107.7 4130.5 4133.7 11154.2 11454.6 11481.4 11519.7 11532.4 11169.1 11291.7 11319.2 11363.1 11373.8 7931.6 8277.9 8283.0 8312.3 8473.6 6007.7 6110.4 6124.3 6172.2 6260.1 10238.5 10428.6 10599.6 10604.8 10624.3 10553.6 10569.0 10771.4 10799.6 10821.6 7218.6 7454.0 7749.8 7906.8 8044.0 8615.0 8973.0 8996.9 8997.9 8998.6 7744.7 7853.9 7965.0 8080.1 8089.2 7630.2 7730.8 7751.0 7822.6 7855.9 7154.2 7252.3 7262.6 7269.9 7271.7 5233.3 5237.4 5357.2 5396.1 5431.0 5229.1 5255.6 5316.0 5394.9 5474.5 16:09:34 INFO - PROCESS | 21728 | 16:09:34 INFO - PROCESS | 21728 | [#4] prototype.html Cycles:180 Average:4502.48 Median:5125.96 stddev:1299.32 (25.3%) stddev-sans-first:1264.68 16:09:34 INFO - PROCESS | 21728 | Values: 331.3 334.4 340.4 341.2 343.9 4922.3 5072.4 5097.4 5109.5 5129.2 4940.5 5103.3 5121.8 5128.2 5130.2 4061.1 4073.5 4073.9 4083.4 4087.2 3794.5 3815.7 4071.3 4088.8 4096.7 4032.2 4033.3 4045.4 4051.5 4055.6 4022.4 4029.4 4035.8 4049.7 4050.9 3603.7 3607.4 3613.3 3614.0 3628.7 4846.4 4958.5 4963.9 4980.9 5027.1 4580.5 4598.7 4600.5 4601.4 4614.7 5089.8 5312.1 5317.7 5329.8 5339.5 3875.3 3878.9 3879.3 3886.5 3895.5 5498.8 5536.7 5539.3 5549.3 5556.9 3781.7 3977.8 3982.9 3984.5 3994.1 4000.4 4038.9 4041.0 4045.5 4064.5 4580.9 4581.6 4594.3 4597.5 4605.8 5365.9 5370.4 5408.8 5443.9 5450.4 1316.2 1338.6 1348.2 1352.1 1400.5 914.7 934.6 947.0 978.8 979.6 5094.5 5124.7 5129.2 5154.4 5163.6 5266.0 5350.5 5428.6 5481.5 5484.6 5061.3 5084.3 5104.2 5121.2 5127.2 2864.4 2874.0 2879.1 2886.4 2897.4 5370.2 5583.2 5589.7 5591.4 5620.4 5511.4 5519.9 5525.9 5544.3 5558.2 5621.7 5634.6 5638.5 5644.8 5659.5 5277.9 5325.8 5377.2 5404.5 5408.7 5352.5 5361.9 5379.3 5383.4 5401.9 5438.6 5584.7 5593.9 5620.9 5636.5 3924.4 3937.3 3943.5 3952.2 3958.2 5389.6 5394.9 5398.7 5419.3 5423.2 5118.3 5242.6 5263.6 5291.7 5321.7 5281.6 5287.0 5310.0 5316.1 5322.9 5081.8 5195.5 5274.9 5296.4 5313.4 5381.4 5386.8 5394.6 5395.7 5401.4 5130.6 5268.7 5276.5 5279.2 5289.7 16:09:34 INFO - PROCESS | 21728 | 16:09:34 INFO - PROCESS | 21728 | [#5] yui.html Cycles:180 Average:19312.62 Median:52137.24 stddev:27720.02 (53.2%) stddev-sans-first:27762.70 16:09:34 INFO - PROCESS | 21728 | Values: 737.2 740.7 752.6 787.6 871.4 14596.1 15057.8 15494.1 15636.8 15699.9 13972.3 14033.2 14135.6 14138.2 14229.8 660.9 798.9 819.4 824.2 824.4 685.9 769.5 792.5 802.6 806.7 849.4 850.7 855.2 855.3 855.9 681.9 708.7 850.5 850.6 850.6 600.2 620.5 623.8 624.1 624.7 14916.4 14966.6 14977.5 14979.0 14982.3 13792.2 14113.2 14232.0 14324.3 14483.9 12670.7 12750.6 12914.5 13131.5 13330.2 4356.5 4411.4 4421.0 4466.6 4495.6 71722.3 71915.3 72624.3 72809.3 72814.0 10246.5 10494.6 10557.3 10585.4 10618.8 20709.1 20740.6 20744.9 20748.4 20764.6 8001.7 8013.7 8027.0 8093.4 8242.8 4371.6 4525.8 4596.7 4644.3 4871.8 3353.4 3413.8 3431.0 3445.5 3488.4 632.7 636.3 638.0 647.8 668.5 663.9 696.0 714.2 716.8 723.4 8843.9 8902.9 9105.7 9432.8 9508.7 594.9 651.6 664.9 680.6 696.8 4209.8 4352.5 4535.3 4574.0 4686.3 64470.4 64963.0 93027.5 105181.0 110242.0 98402.0 100312.0 101857.0 102095.0 102278.0 66019.0 87267.6 87562.6 87918.9 88664.6 8451.0 8795.7 8833.1 8921.3 9050.1 52088.5 52186.0 52335.7 52427.7 54025.7 45206.5 73746.6 74024.0 74686.3 77516.8 10560.9 10678.2 10781.7 10809.7 11704.8 11759.9 11894.5 12208.5 12511.2 12937.0 11319.1 11484.6 11547.9 11995.9 12471.2 10496.0 10817.9 11178.4 11239.9 11582.1 11146.4 11411.0 11678.5 11763.4 11765.5 8799.3 9047.8 9288.3 9501.2 9899.2 9827.9 9876.3 10018.9 10107.9 10123.5 16:09:34 INFO - PROCESS | 21728 | -------- Summary: end -------- 16:09:34 INFO - PROCESS | 21728 | 16:09:35 INFO - TEST-INFO | 21728: exit 0 16:09:35 INFO - TEST-OK | dromaeo_css | took 1117678ms 16:09:35 INFO - TEST-START | kraken 16:09:35 INFO - operating with platform_type : linux_ 16:09:35 INFO - Initialising browser for kraken test... 16:09:35 INFO - TEST-INFO | started process 22032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuYLfF8/profile http://localhost:58137/getInfo.html) 16:09:39 INFO - PROCESS | 22032 | __metrics Screen width/height:1600/1200 16:09:39 INFO - PROCESS | 22032 | colorDepth:24 16:09:39 INFO - PROCESS | 22032 | Browser inner width/height: 1024/697 16:09:39 INFO - PROCESS | 22032 | __metrics 16:09:40 INFO - PROCESS | 22032 | 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" 16:09:40 INFO - PROCESS | 22032 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:09:40 INFO - PROCESS | 22032 | console.error: PushService: 16:09:40 INFO - PROCESS | 22032 | stateChangeProcessEnqueue: Error transitioning state 16:09:40 INFO - PROCESS | 22032 | UnknownError 16:09:41 INFO - TEST-INFO | 22032: exit 0 16:09:41 INFO - Browser initialized. 16:09:41 INFO - Running cycle 1/1 for kraken test... 16:09:41 INFO - TEST-INFO | started process 22110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuYLfF8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:09:53 INFO - PROCESS | 22110 | RSS: Main: 173408256 16:09:53 INFO - PROCESS | 22110 | 16:09:56 INFO - PROCESS | 22110 | Cycle 1(1): loaded http://localhost:58137/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58137/tests/kraken/driver.html?testName=audio-beat-detection) 16:09:57 INFO - PROCESS | 22110 | RSS: Main: 232157184 16:09:57 INFO - PROCESS | 22110 | 16:09:59 INFO - PROCESS | 22110 | Cycle 1(1): loaded http://localhost:58137/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58137/tests/kraken/driver.html?testName=audio-dft) 16:10:00 INFO - PROCESS | 22110 | RSS: Main: 217214976 16:10:00 INFO - PROCESS | 22110 | 16:10:03 INFO - PROCESS | 22110 | Cycle 1(1): loaded http://localhost:58137/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58137/tests/kraken/driver.html?testName=audio-fft) 16:10:04 INFO - PROCESS | 22110 | RSS: Main: 299896832 16:10:04 INFO - PROCESS | 22110 | 16:10:06 INFO - PROCESS | 22110 | Cycle 1(1): loaded http://localhost:58137/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58137/tests/kraken/driver.html?testName=audio-oscillator) 16:10:06 INFO - PROCESS | 22110 | RSS: Main: 208748544 16:10:06 INFO - PROCESS | 22110 | 16:10:08 INFO - PROCESS | 22110 | Cycle 1(1): loaded http://localhost:58137/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58137/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:10:09 INFO - PROCESS | 22110 | RSS: Main: 213024768 16:10:09 INFO - PROCESS | 22110 | 16:10:12 INFO - PROCESS | 22110 | Cycle 1(1): loaded http://localhost:58137/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58137/tests/kraken/driver.html?testName=imaging-darkroom) 16:10:13 INFO - PROCESS | 22110 | RSS: Main: 249466880 16:10:13 INFO - PROCESS | 22110 | 16:10:16 INFO - PROCESS | 22110 | Cycle 1(1): loaded http://localhost:58137/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58137/tests/kraken/driver.html?testName=imaging-desaturate) 16:10:17 INFO - PROCESS | 22110 | RSS: Main: 248197120 16:10:17 INFO - PROCESS | 22110 | 16:10:19 INFO - PROCESS | 22110 | Cycle 1(1): loaded http://localhost:58137/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58137/tests/kraken/driver.html?testName=json-parse-financial) 16:10:20 INFO - PROCESS | 22110 | RSS: Main: 248586240 16:10:20 INFO - PROCESS | 22110 | 16:10:21 INFO - PROCESS | 22110 | Cycle 1(1): loaded http://localhost:58137/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58137/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:10:22 INFO - PROCESS | 22110 | RSS: Main: 210653184 16:10:22 INFO - PROCESS | 22110 | 16:10:24 INFO - PROCESS | 22110 | Cycle 1(1): loaded http://localhost:58137/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58137/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:10:24 INFO - PROCESS | 22110 | RSS: Main: 218132480 16:10:24 INFO - PROCESS | 22110 | 16:10:26 INFO - PROCESS | 22110 | Cycle 1(1): loaded http://localhost:58137/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58137/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:10:27 INFO - PROCESS | 22110 | RSS: Main: 226996224 16:10:27 INFO - PROCESS | 22110 | 16:10:30 INFO - PROCESS | 22110 | Cycle 1(1): loaded http://localhost:58137/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58137/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:10:30 INFO - PROCESS | 22110 | RSS: Main: 236531712 16:10:30 INFO - PROCESS | 22110 | 16:10:33 INFO - PROCESS | 22110 | Cycle 1(1): loaded http://localhost:58137/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58137/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:10:34 INFO - PROCESS | 22110 | RSS: Main: 233086976 16:10:34 INFO - PROCESS | 22110 | 16:10:36 INFO - PROCESS | 22110 | Cycle 1(1): loaded http://localhost:58137/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58137/tests/kraken/driver.html?testName=ai-astar) 16:10:36 INFO - PROCESS | 22110 | RSS: Main: 284090368 16:10:36 INFO - PROCESS | 22110 | 16:10:36 INFO - PROCESS | 22110 | __start_tp_report 16:10:36 INFO - PROCESS | 22110 | _x_x_mozilla_page_load 16:10:36 INFO - PROCESS | 22110 | _x_x_mozilla_page_load_details 16:10:36 INFO - PROCESS | 22110 | |i|pagename|runs| 16:10:36 INFO - PROCESS | 22110 | |0;ai-astar;109;113;111;112;113;112;111;112;111;111 16:10:36 INFO - PROCESS | 22110 | |1;audio-beat-detection;150;121;122;173;124;128;121;120;152;123 16:10:36 INFO - PROCESS | 22110 | |2;audio-dft;161;160;160;161;164;160;161;162;159;160 16:10:36 INFO - PROCESS | 22110 | |3;audio-fft;76;76;78;115;75;76;75;76;98;75 16:10:36 INFO - PROCESS | 22110 | |4;audio-oscillator;83;84;111;82;82;82;107;83;83;111 16:10:36 INFO - PROCESS | 22110 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;117;117 16:10:36 INFO - PROCESS | 22110 | |6;imaging-darkroom;146;146;145;147;147;147;146;147;145;146 16:10:36 INFO - PROCESS | 22110 | |7;imaging-desaturate;96;95;94;95;95;95;95;94;95;95 16:10:36 INFO - PROCESS | 22110 | |8;json-parse-financial;52;52;52;52;53;54;54;52;53;53 16:10:36 INFO - PROCESS | 22110 | |9;json-stringify-tinderbox;60;61;60;61;60;60;60;61;60;61 16:10:36 INFO - PROCESS | 22110 | |10;stanford-crypto-aes;80;79;80;80;82;85;79;80;80;79 16:10:36 INFO - PROCESS | 22110 | |11;stanford-crypto-ccm;144;132;132;130;131;142;134;136;167;130 16:10:36 INFO - PROCESS | 22110 | |12;stanford-crypto-pbkdf2;170;171;164;166;168;167;166;166;168;171 16:10:36 INFO - PROCESS | 22110 | |13;stanford-crypto-sha256-iterative;69;75;71;66;67;68;65;67;68;70 16:10:36 INFO - PROCESS | 22110 | __end_tp_report 16:10:36 INFO - PROCESS | 22110 | __start_cc_report 16:10:36 INFO - PROCESS | 22110 | _x_x_mozilla_cycle_collect,1641 16:10:36 INFO - PROCESS | 22110 | __end_cc_report 16:10:36 INFO - PROCESS | 22110 | __startTimestamp1475795436295__endTimestamp 16:10:36 INFO - PROCESS | 22110 | 16:10:36 INFO - PROCESS | 22110 | ------- Summary: start ------- 16:10:36 INFO - PROCESS | 22110 | Number of tests: 14 16:10:36 INFO - PROCESS | 22110 | 16:10:36 INFO - PROCESS | 22110 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:1.18 (1.1%) stddev-sans-first:0.83 16:10:36 INFO - PROCESS | 22110 | Values: 109.0 113.0 111.0 112.0 113.0 112.0 111.0 112.0 111.0 111.0 16:10:36 INFO - PROCESS | 22110 | 16:10:36 INFO - PROCESS | 22110 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:126.00 stddev:18.36 (14.6%) stddev-sans-first:18.46 16:10:36 INFO - PROCESS | 22110 | Values: 150.0 121.0 122.0 173.0 124.0 128.0 121.0 120.0 152.0 123.0 16:10:36 INFO - PROCESS | 22110 | 16:10:36 INFO - PROCESS | 22110 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.40 (0.9%) stddev-sans-first:1.48 16:10:36 INFO - PROCESS | 22110 | Values: 161.0 160.0 160.0 161.0 164.0 160.0 161.0 162.0 159.0 160.0 16:10:36 INFO - PROCESS | 22110 | 16:10:36 INFO - PROCESS | 22110 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:13.55 (17.8%) stddev-sans-first:14.20 16:10:36 INFO - PROCESS | 22110 | Values: 76.0 76.0 78.0 115.0 75.0 76.0 75.0 76.0 98.0 75.0 16:10:36 INFO - PROCESS | 22110 | 16:10:36 INFO - PROCESS | 22110 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:82.50 stddev:13.08 (15.9%) stddev-sans-first:13.56 16:10:36 INFO - PROCESS | 22110 | Values: 83.0 84.0 111.0 82.0 82.0 82.0 107.0 83.0 83.0 111.0 16:10:36 INFO - PROCESS | 22110 | 16:10:36 INFO - PROCESS | 22110 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:10:36 INFO - PROCESS | 22110 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 16:10:36 INFO - PROCESS | 22110 | 16:10:36 INFO - PROCESS | 22110 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 16:10:36 INFO - PROCESS | 22110 | Values: 146.0 146.0 145.0 147.0 147.0 147.0 146.0 147.0 145.0 146.0 16:10:36 INFO - PROCESS | 22110 | 16:10:36 INFO - PROCESS | 22110 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 16:10:36 INFO - PROCESS | 22110 | Values: 96.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 16:10:36 INFO - PROCESS | 22110 | 16:10:36 INFO - PROCESS | 22110 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:0.82 (1.6%) stddev-sans-first:0.83 16:10:36 INFO - PROCESS | 22110 | Values: 52.0 52.0 52.0 52.0 53.0 54.0 54.0 52.0 53.0 53.0 16:10:36 INFO - PROCESS | 22110 | 16:10:36 INFO - PROCESS | 22110 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 16:10:36 INFO - PROCESS | 22110 | Values: 60.0 61.0 60.0 61.0 60.0 60.0 60.0 61.0 60.0 61.0 16:10:36 INFO - PROCESS | 22110 | 16:10:36 INFO - PROCESS | 22110 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:1.84 (2.3%) stddev-sans-first:1.94 16:10:36 INFO - PROCESS | 22110 | Values: 80.0 79.0 80.0 80.0 82.0 85.0 79.0 80.0 80.0 79.0 16:10:36 INFO - PROCESS | 22110 | 16:10:36 INFO - PROCESS | 22110 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:135.00 stddev:11.36 (8.4%) stddev-sans-first:11.83 16:10:36 INFO - PROCESS | 22110 | Values: 144.0 132.0 132.0 130.0 131.0 142.0 134.0 136.0 167.0 130.0 16:10:36 INFO - PROCESS | 22110 | 16:10:36 INFO - PROCESS | 22110 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:168.00 stddev:2.36 (1.4%) stddev-sans-first:2.35 16:10:36 INFO - PROCESS | 22110 | Values: 170.0 171.0 164.0 166.0 168.0 167.0 166.0 166.0 168.0 171.0 16:10:36 INFO - PROCESS | 22110 | 16:10:36 INFO - PROCESS | 22110 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:2.88 (4.2%) stddev-sans-first:3.05 16:10:36 INFO - PROCESS | 22110 | Values: 69.0 75.0 71.0 66.0 67.0 68.0 65.0 67.0 68.0 70.0 16:10:36 INFO - PROCESS | 22110 | -------- Summary: end -------- 16:10:36 INFO - PROCESS | 22110 | 16:10:37 INFO - TEST-INFO | 22110: exit 0 16:10:37 INFO - TEST-OK | kraken | took 62066ms 16:10:37 INFO - SUITE-END | took 1179s 16:10:37 INFO - Completed test suite (00:19:40) 16:10:37 INFO - javascript benchmark 16:10:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2950.557416387542, 2981.8210907345556, 2986.372861699043, 3003.864826082826, 3006.2484378905274, 5080.720560369178, 5141.742912854356, 5162.948370516294, 5165.81919632813, 5241.554467870235, 5137.511936366049, 5204.895902081966, 5227.529522342998, 5291.894162116755, 5309.283246761686, 4714.033623107255, 4729.716217026989, 4762.547557981995, 4783.067301876135, 4795.736234507101, 4808.687435316693, 4812.855614331558, 4826.7586620669, 4844.806207751686, 4939.654224204307, 4799.232122860326, 4828.082664293791, 4832.4684284728655, 4841.540053694894, 4904.975475122637, 4749.715017098985, 4789.976050119727, 4805.687630304019, 4842.975785121052, 4847.442544107437, 4762.618990480753, 4776.713397196179, 4790.089882922233, 4831.879203019917, 4865.19724245499, 5258.579313654898, 5275.182346736262, 5315.574754019669, 5318.228856815779, 5322.627416080876, 5516.172574113875, 5571.526420254283, 5585.609007369486, 5638.859028524279, 5648.717564121818, 5672.12082127271, 5703.4011428799795, 5721.456461636138, 5784.595078344518, 5788.363280039192, 5308.389535203462, 5314.043472175045, 5314.362276526765, 5316.175992721134, 5317.787288508455, 5679.630823996427, 5811.070228763378, 5811.767529298781, 5826.126081087786, 5888.146218798251, 5449.3188351456065, 5462.153366228241, 5476.67139971603, 5499.395066542677, 5558.027345214571, 5524.116141417354, 5562.610617256753, 5569.136783798437, 5577.0, 5578.776848926079, 5503.514051206152, 5565.0, 5565.081761509306, 5568.638038527482, 5602.85992850182, 5412.404635490093, 5477.452254774491, 5478.315210598676, 5547.472990065938, 5622.100463925753, 4236.68224883135, 4277.807498662568, 4285.61429471349, 4296.978515107467, 4300.075483771005, 3826.234753049401, 3828.157805282833, 3833.674137698327, 3873.748206366577, 3875.844966201377, 5286.117018645843, 5295.761690723926, 5303.337082864642, 5306.814261500829, 5365.22204280385, 5461.508464238238, 5474.863128421742, 5522.088855338904, 5612.607117501817, 5631.465010823965, 5249.895002099936, 5287.709175995357, 5292.867678308073, 5298.81454149103, 5300.231466437422, 4807.351007613927, 4873.658843880894, 4878.902421951541, 4879.609631229493, 4883.072216278895, 5722.856928576819, 5796.536277097738, 5849.590528662953, 5851.64890106595, 5853.678047707332, 5535.363433205233, 5589.189567512606, 5600.579956503197, 5602.635828671123, 5604.8318550443555, 5727.083666613488, 5728.856778580569, 5731.971340143439, 5735.54115670737, 5741.25363702716, 5442.401335853132, 5471.534919531725, 5500.697461639648, 5512.0, 5516.227728117987, 5659.688717120598, 5663.9716801415725, 5669.574781891292, 5670.149477578231, 5731.19763233156, 5497.065498865282, 5509.173623956439, 5510.118381059011, 5516.3380394351325, 5516.420775818481, 5311.097113490793, 5361.624686271924, 5364.409914909279, 5448.700321482356, 5485.782580548841, 5410.3507579090765, 5432.674039557481, 5436.130219164915, 5436.6194366393975, 5466.972665136649, 5482.533984611193, 5503.7798488060025, 5506.697131657797, 5516.531094856982, 5521.116621340727, 5334.710374482417, 5377.758000889891, 5380.515753582196, 5383.757730902041, 5386.865328366822], "value": 5170.526852539876, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.3153405771702, 570.389683039148, 607.2166904692946, 615.3907631444871, 618.6690120785381, 30403.08790736276, 33863.66136338636, 33916.66083339166, 33954.83022584883, 45411.31883021758, 43484.347734784, 43787.34318985218, 43856.56143438564, 43932.0, 43938.56061439385, 8820.426672266314, 8968.865467018, 8979.146981036823, 8983.730488085368, 8987.775305617346, 7856.882146767803, 8025.3980951428875, 8806.119388061206, 8915.732528024137, 10319.896801032006, 10762.300450470733, 10825.133989280877, 10828.458577071155, 10834.512446939907, 10844.0, 10741.0, 10797.0, 10803.5678572857, 10806.35161890289, 10810.891891081068, 10563.524641391155, 10579.365238085662, 10618.25672202946, 10630.362178269328, 10636.0, 40685.1862962742, 40936.79531602353, 40978.38532422016, 40982.79508602468, 41102.38346424806, 3434.5191673165778, 3532.2052538178705, 3628.7299445194235, 3813.427985802124, 3834.750741201813, 30089.398212035638, 31130.37739245225, 31150.688493115005, 31150.68849311523, 31311.06066817976, 4279.229738647043, 4422.04925940921, 4429.955700442986, 4435.733855968652, 4576.519465456113, 230236.0, 233461.0, 233557.0, 233614.0, 233935.9999999983, 55373.446265536826, 55400.16899746507, 55496.72251638716, 55814.441855580924, 55823.0, 58917.70541147267, 58963.705181473815, 59190.70404648035, 59194.0, 59211.40788592145, 17329.393471228446, 17614.823851761317, 17614.91192544029, 17626.2068206931, 17634.82365176332, 13692.863071369358, 13763.105398149088, 13767.586972390844, 13773.517926872712, 13777.931110344383, 14214.715705685829, 14526.273686315642, 14535.0, 15069.321880515403, 15646.530604081896, 4866.430640489176, 5664.26364572603, 5677.489025987681, 5772.6536407815665, 5848.912266316009, 966.3332300712486, 1076.3541874875168, 1078.1751959750798, 1097.5390336058874, 1107.9224454288124, 31187.0, 31304.53043204354, 31510.842445787624, 31735.682643173735, 32094.19764505906, 1123.7582471369183, 1141.9086473082134, 1166.9542494090417, 1167.3521195736278, 1183.7395772929942, 16125.677486450206, 16716.916415417843, 16821.32714691423, 16857.38821320885, 16957.321707131825, 500993.0, 506351.0, 506928.0, 507761.0, 507795.0, 47396.0, 48474.0, 52862.73568632209, 55603.0, 55959.0, 1315.4738104757982, 1362.7206422683325, 1372.2658377767846, 1378.0353752373378, 1391.7703578909366, 30450.84774576113, 33187.66812331846, 33271.50092748562, 33281.83359083189, 33416.33167336688, 49733.75133124311, 49900.0, 50206.49793502018, 50240.0, 50242.748786255834, 396650.0, 404213.0, 407001.0, 428702.0, 611491.0, 27086.18741437681, 27123.321916951445, 27159.456810864067, 27510.862445687642, 27512.862435687694, 44967.7751611253, 45418.0, 45715.31427028531, 45891.08217835558, 46406.53593464022, 38443.80778096092, 38853.611463885, 39081.609183908935, 39368.73256616143, 40410.0, 39277.0, 39441.802790985865, 39595.20809583735, 40102.59897400989, 41175.17649646931, 37667.43498847465, 37905.43141852819, 39106.4134037984, 39642.0, 39795.0, 32703.0, 35827.0, 36187.0, 36317.0920726984, 36359.0, 26696.866515667298, 26707.599386009613, 27335.316617083936, 27598.5860212101, 27602.723972760014], "value": 19631.02099061315, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.28209158545553, 378.7690502937697, 379.28504768511345, 385.1296070879812, 413.0685304638043, 14005.719885602282, 17611.119444027794, 18207.27170913162, 19035.619287614238, 19186.520336991547, 18631.17870722434, 19361.322353717624, 19459.318923837633, 19604.509887252825, 19675.606487870235, 5511.476409741078, 5800.8259752207505, 5805.680687562182, 5818.854528636797, 5826.300843898738, 5564.443555644423, 5692.715364231793, 5752.395998420168, 5778.248827652399, 5794.5943783935145, 5741.110127930177, 5747.224124743168, 5748.82753517393, 5750.597458177929, 5751.1373294006025, 5492.780288788444, 5704.600677952545, 5729.1119876419225, 5740.512056475204, 5747.6551406915305, 4992.076465853793, 5001.799928002875, 5028.446870844205, 5058.848234552969, 5066.69599824008, 22688.43278918024, 22806.885965570233, 22840.77159228403, 22871.199508017307, 22882.65676014861, 2161.8162456191244, 2225.8219342452567, 2286.0969916882905, 2378.6669866218745, 2802.957955630667, 6904.102466679299, 12324.32216228107, 14249.71500569993, 14530.491432799907, 14844.480443184544, 1614.5882799885953, 1676.6227598790297, 1682.4616122840696, 1715.5968347438343, 1732.4542769027842, 48833.0, 54067.459325406635, 78102.0, 79203.60398197972, 79982.0, 10024.097831195228, 10214.744631384276, 10286.382817031003, 10524.263301568817, 10804.945975270073, 14117.2235527047, 14141.363638636287, 14167.929160354131, 14178.220197889215, 14207.71584568303, 7737.574433406104, 8077.636506357228, 8118.10700822909, 8239.303596949801, 8300.460470069425, 7777.922220777833, 7858.607069646495, 7931.762047138595, 8121.796955076052, 8175.386845986574, 6358.300586935434, 6506.154199953976, 6506.674666266667, 6570.277269500351, 6683.331666833278, 1853.3328001919567, 1859.4235786906102, 1948.814862588052, 1960.5196726802026, 1967.8979771327815, 853.6414705823569, 956.8134213828375, 968.7142293023575, 981.347403976362, 999.5951639585979, 19693.06138772251, 19930.70103948413, 20060.69908951367, 20080.59838803216, 20131.39605811828, 985.5515740338129, 1004.1013293102632, 1024.9743756406, 1053.1259054984343, 1106.2753896198003, 10753.0, 11275.210735248618, 11552.133589980616, 11557.30656160633, 11615.825762613567, 454963.0, 454976.0, 461103.3337999731, 461181.0, 474564.0, 77002.0, 77360.61319693366, 78745.0, 78950.6052469734, 83240.16759832445, 1014.7513859104566, 1036.7149034015706, 1045.9529321180412, 1048.8584041154347, 1063.1813503602184, 17189.914050429667, 17341.479755607354, 17867.0, 17940.461786146436, 18211.726824097914, 38022.429663555624, 38279.808600956814, 39324.803375982934, 39583.80208098941, 39818.402723958585, 49804.0, 50197.24704129514, 51639.74180129075, 56919.71540142273, 59317.406825932914, 7608.125065617525, 7979.601019948863, 8070.556119413489, 8218.712345067894, 8322.417430779788, 10162.644307449204, 13053.477860885838, 13109.27898965566, 13158.80261796093, 13313.267770272729, 10884.510197040994, 10986.615468458565, 11179.66461006171, 11368.715782105513, 11891.227070240408, 10991.780164396827, 11151.10791136691, 11154.498047587716, 11158.776824463628, 11317.151213658844, 10786.0, 11085.39030353306, 11338.376389298337, 11347.262427942158, 11836.0, 8112.75661730149, 8238.670453181805, 8306.127856574973, 8360.83278334442, 8746.562671866508, 8676.08901065379, 10487.423191724529, 10540.947295263475, 10895.891041089488, 11028.338299702044], "value": 9029.91754347799, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.977509073754, 1468.4199741102266, 1502.8797696184304, 1624.9593760155994, 1789.248515623438, 7822.569758663279, 8682.088380720028, 9055.637774489029, 9075.591598378072, 9292.44245345278, 8940.552972351388, 9014.86477702835, 9015.864762028576, 9025.864612030808, 9028.68399606014, 2305.446692793726, 2331.265651319829, 2331.5803155432013, 2332.125452955142, 2334.579775640384, 2233.586786444505, 2294.4263934016494, 2303.2744685424123, 2305.873176975266, 2309.8036666883336, 2224.2993457060975, 2236.0385034435267, 2237.6643503474447, 2303.09027933966, 2306.938808148254, 2208.712867327253, 2231.8102961248314, 2240.2943072932057, 2246.932592022242, 2246.9662955055687, 2162.3945295317335, 2246.618074927266, 2302.4474126209757, 2305.147095574648, 2309.3880121767743, 8953.23897468716, 9028.50343231122, 9032.593533291018, 9036.54817259141, 9140.314476414296, 5301.920471192935, 5442.727863606804, 5442.782288708447, 5453.100238460649, 5456.017916774979, 3532.293541291752, 3545.822708864572, 3605.675489205958, 3616.5479315085613, 3619.963800361989, 1072.8390741388775, 1087.423665457309, 1094.7427354571669, 1110.766738984814, 1119.322809700136, 12620.116591838574, 12758.36208189596, 12771.61685149447, 12775.297358645365, 12783.61649150527, 4136.482939632546, 4381.40850985113, 4395.406620106245, 4484.439445069366, 4485.372047913294, 9781.0, 9782.070703283176, 9792.951035244922, 9794.510274486247, 9802.901970980342, 5092.65044763138, 5103.438621751604, 5106.463821298785, 5107.923381149286, 5108.642395032386, 4164.354525048622, 4295.312749959991, 4688.507706690816, 4788.138135135709, 4805.927911081337, 3616.439451884962, 3667.6882464990776, 3695.8727588085353, 3758.567764707039, 3762.285165818486, 1051.8632577764843, 1081.6322450366913, 1083.2417307884512, 1086.5444096342324, 1103.8233882578909, 956.1824639932896, 963.3882484622176, 968.2737946540095, 984.6553706202915, 1002.9749256268651, 5738.454846789548, 6105.114758360013, 6115.877682446326, 6224.502039836802, 6254.906176407358, 440.87875834145865, 441.77027945468177, 443.7160217460828, 446.28594249201666, 477.191160982132, 3954.406838974177, 4068.0, 4107.6508496777515, 4130.463039804806, 4133.731307465066, 11154.219204655596, 11454.59908903201, 11481.425928703531, 11519.654410367702, 11532.36571988532, 11169.106471482262, 11291.717707057389, 11319.151063670257, 11363.14776391774, 11373.772524549462, 7931.603419828985, 8277.875831862528, 8282.958585207036, 8312.293455056268, 8473.57632118404, 6007.669578173242, 6110.419510146529, 6124.326324104434, 6172.197614310111, 6260.123582698517, 10238.539265733209, 10428.58285668595, 10599.576016959236, 10604.787904242026, 10624.309419887682, 10553.63062292816, 10569.048785609331, 10771.353718776898, 10799.622013229498, 10821.621243256448, 7218.566885986857, 7454.0, 7749.845003099794, 7906.7627971160955, 8043.959780201061, 8615.0, 8972.955135224282, 8996.865047024168, 8997.865032024394, 8998.595063222301, 7744.728934487492, 7853.882191767014, 7964.960175199087, 8080.111187769223, 8089.2315230053055, 7630.1606823248285, 7730.7680769577, 7750.961245193738, 7822.608869556386, 7855.921440785748, 7154.177269613853, 7252.347288744038, 7262.636868156465, 7269.890951635835, 7271.745488908075, 5233.345831771028, 5237.397699264481, 5357.1696387060065, 5396.1366181410785, 5430.972845135749, 5229.137192363218, 5255.553277971415, 5315.973420132875, 5394.865128371822, 5474.452554744494], "value": 4555.210553976876, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.30866924351193, 334.43480517924706, 340.4229830437408, 341.1981842669726, 343.90542600784767, 4922.286268491067, 5072.442031376546, 5097.362829646294, 5109.540141387274, 5129.179331306992, 4940.529735132433, 5103.26002729604, 5121.795128194877, 5128.179491281396, 5130.153524668434, 4061.1268577255883, 4073.4500842386196, 4073.9388909166387, 4083.448734420845, 4087.2234275487713, 3794.4877441545314, 3815.740805534167, 4071.3282308419075, 4088.8160032798446, 4096.692748043909, 4032.213718324928, 4033.334499807543, 4045.393191021341, 4051.5138183417885, 4055.614716601918, 4022.3765316376007, 4029.37544680575, 4035.778032208227, 4049.7367671101283, 4050.946753844007, 3603.7117030637487, 3607.4408466687705, 3613.313470440608, 3613.981930090359, 3628.673419392241, 4846.418429788413, 4958.504149585049, 4963.858312588089, 4980.850574482772, 5027.09512287788, 4580.5190455002075, 4598.747068911209, 4600.493945665974, 4601.4248218972625, 4614.700044497097, 5089.770960306795, 5312.123499622558, 5317.697164194797, 5329.813456529003, 5339.5194432500875, 3875.3411919973673, 3878.8642397516232, 3879.301725689375, 3886.4947556817433, 3895.5325360956585, 5498.80754173606, 5536.723163841792, 5539.279893613845, 5549.306336707911, 5556.888862222773, 3781.6596506314563, 3977.801109944491, 3982.8605998789903, 3984.5019372578427, 3994.121293315466, 4000.3799411091327, 4038.8586399475876, 4040.9797951010646, 4045.4943132108488, 4064.5122585289955, 4580.908381832344, 4581.610563102174, 4594.264917613166, 4597.540245975376, 4605.815767369335, 5365.946340536545, 5370.382406023357, 5408.810691625853, 5443.891122177534, 5450.446622712587, 1316.1642357103308, 1338.6118025772416, 1348.2045593099922, 1352.1413902172192, 1400.4608225833128, 914.689005738039, 934.56075644447, 946.9857952130724, 978.7944531648434, 979.647326962293, 5094.541491265803, 5124.692518448905, 5129.179331306973, 5154.355705536808, 5163.561097306696, 5265.998380922837, 5350.5184533392185, 5428.647137936022, 5481.451854814566, 5484.588655850827, 5061.291419201315, 5084.313617661643, 5104.2088476286235, 5121.206213036985, 5127.231105268751, 2864.4127953769425, 2873.9712602874124, 2879.0566367701717, 2886.3649997000625, 2897.435000174946, 5370.248165256867, 5583.162525621189, 5589.692566908778, 5591.384947655754, 5620.381758006616, 5511.421300763443, 5519.862003449946, 5525.944740552623, 5544.251526043932, 5558.221848941152, 5621.662700237999, 5634.577406694514, 5638.464345887134, 5644.802431915027, 5659.471942575564, 5277.868053298698, 5325.760340784752, 5377.24718539397, 5404.513593776579, 5408.72956352173, 5352.4915133062295, 5361.874006458687, 5379.273798037215, 5383.407825139153, 5401.945980540301, 5438.6192966493545, 5584.748686309044, 5593.944060559343, 5620.943790562042, 5636.464535869086, 3924.3517722556026, 3937.3306537888056, 3943.467631869661, 3952.189801090712, 3958.1687845552756, 5389.568834493152, 5394.946050539601, 5398.703071331114, 5419.268398766274, 5423.2407462954425, 5118.283440318432, 5242.633015688865, 5263.605229607718, 5291.682499050069, 5321.654092484131, 5281.630285879952, 5286.97356513215, 5310.044192045469, 5316.122839731401, 5322.855586049018, 5081.8475445736685, 5195.532402083831, 5274.920876186783, 5296.417394086724, 5313.442088580643, 5381.385584324766, 5386.78797270611, 5394.649347792381, 5395.676259424447, 5401.351837779334, 5130.563902068366, 5268.736563171749, 5276.5251127398715, 5279.234510995807, 5289.68261904287], "value": 4094.222894323338, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.1927739125662, 740.6778051547576, 752.5823168141683, 787.629813987426, 871.3639043498245, 14596.124232546055, 15057.774133388008, 15494.147821869807, 15636.765448518281, 15699.921500392496, 13972.301384930764, 14033.228172450512, 14135.575932722035, 14138.151710897353, 14229.78655320171, 660.9438197753196, 798.9001374828147, 819.4427789103407, 824.2046425199682, 824.4270232188632, 685.8936864785941, 769.5152054205843, 792.5244853088129, 802.626778547975, 806.7136166660839, 849.4266370200121, 850.7447765670305, 855.2388374346837, 855.3499340501232, 855.8844555984956, 681.9045333653293, 708.7413094220624, 850.5237067242364, 850.5832142250315, 850.5959669157132, 600.2197143713199, 620.5159975219336, 623.7847942459844, 624.1480379282247, 624.684534310175, 14916.403343866341, 14966.625834354229, 14977.475788347356, 14979.0, 14982.250887455584, 13792.241426721526, 14113.153210807384, 14232.0, 14324.283785810669, 14483.927580362137, 12670.736114617786, 12750.553730619384, 12914.45026596805, 13131.540396086186, 13330.200187988752, 4356.486793933712, 4411.404460397869, 4420.977895110536, 4466.642668586505, 4495.64034877209, 71722.28277717208, 71915.2808471919, 72624.27375726229, 72809.27190728078, 72814.0, 10246.53890574926, 10494.580216791242, 10557.31377460478, 10585.417802020962, 10618.787624247472, 20709.0680919359, 20740.58518829615, 20744.896275518528, 20748.377548673565, 20764.58470830575, 8001.719939802196, 8013.6794528218215, 8026.959865200637, 8093.433459657886, 8242.776703588752, 4371.584699453547, 4525.818967241274, 4596.701214421052, 4644.256918893028, 4871.780769865364, 3353.4466812975584, 3413.8122403268057, 3430.9828450858085, 3445.5348527948404, 3488.4069708149677, 632.7279269913889, 636.3096040795696, 637.9585326953733, 647.8088963755704, 668.4852663449117, 663.9236487803964, 695.965201739911, 714.2000958926036, 716.8172116110359, 723.4248772226093, 8843.911560884437, 8902.910970890338, 9105.726828195166, 9432.764180895396, 9508.714738557854, 594.925634295713, 651.5862427358661, 664.9168853893264, 680.5678394219706, 696.8362434827811, 4209.789510524462, 4352.455943007124, 4535.342375355555, 4573.977130114328, 4686.250199967989, 64470.35529644737, 64963.0, 93027.53486232525, 105181.0, 110242.0, 98402.0, 100312.0, 101857.0, 102095.0, 102277.95444091076, 66019.0, 87267.56366218255, 87562.56218718865, 87918.88932772813, 88664.5566772162, 8451.0, 8795.692150774692, 8833.116688331116, 8921.330900182382, 9050.094990500897, 52088.47911520988, 52186.0, 52335.73832130815, 52427.73786131045, 54025.72987135039, 45206.54793452023, 73746.63126684332, 74024.0, 74686.25313746792, 77516.83724744247, 10560.894391055992, 10678.199135064746, 10781.730456738644, 10809.67570972872, 11704.765904682028, 11759.941200294286, 11894.464749086485, 12208.45061972231, 12511.186772859735, 12937.029722770641, 11319.09447244202, 11484.598039068593, 11547.884521154681, 11995.948124011302, 12471.189372690746, 10496.0, 10817.945910270399, 11178.441077945907, 11239.943800280946, 11582.07343412508, 11146.442677866236, 11411.0, 11678.474468648761, 11763.353015584225, 11765.52937882475, 8799.250368122837, 9047.773805654648, 9288.281667891462, 9501.192398646193, 9899.20806335477, 9827.901720982985, 9876.308658393844, 10018.899811002088, 10107.949460252652, 10123.493825308558], "value": 7148.353448670945, "unit": "score"}], "name": "dromaeo_css", "value": 7044.480677776257, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 111.0, 112.0, 113.0, 112.0, 111.0, 112.0, 111.0, 111.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 122.0, 173.0, 124.0, 128.0, 121.0, 120.0, 152.0, 123.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 164.0, 160.0, 161.0, 162.0, 159.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 115.0, 75.0, 76.0, 75.0, 76.0, 98.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 111.0, 82.0, 82.0, 82.0, 107.0, 83.0, 83.0, 111.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 147.0, 147.0, 147.0, 146.0, 147.0, 145.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 52.0, 53.0, 54.0, 54.0, 52.0, 53.0, 53.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 60.0, 60.0, 60.0, 61.0, 60.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 80.0, 80.0, 82.0, 85.0, 79.0, 80.0, 80.0, 79.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 132.0, 132.0, 130.0, 131.0, 142.0, 134.0, 136.0, 167.0, 130.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 164.0, 166.0, 168.0, 167.0, 166.0, 166.0, 168.0, 171.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 75.0, 71.0, 66.0, 67.0, 68.0, 65.0, 67.0, 68.0, 70.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1504.0, "alertThreshold": 2.0}]} 16:10:38 INFO - Return code: 0 16:10:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:10:38 INFO - # TBPL SUCCESS # 16:10:38 INFO - Running post-action listener: _resource_record_post_action 16:10:38 INFO - [mozharness: 2016-10-06 23:10:38.099460Z] Finished run-tests step (success) 16:10:38 INFO - Running post-run listener: _resource_record_post_run 16:10:38 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392912896; Read time: 8; Write time: 263020 16:10:38 INFO - TinderboxPrint: CPU usage
13.0% 16:10:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:10:38 INFO - TinderboxPrint: I/O write bytes / time
392,912,896 / 263,020 16:10:38 INFO - TinderboxPrint: CPU idle
8,304.6 (86.9%) 16:10:38 INFO - TinderboxPrint: CPU user
1,196.2 (12.5%) 16:10:38 INFO - TinderboxPrint: Swap in / out
0 / 0 16:10:38 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103882752; Read time: 0; Write time: 84556 16:10:38 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 289030144; Read time: 0; Write time: 178464 16:10:38 INFO - Running post-run listener: _upload_blobber_files 16:10:38 INFO - Blob upload gear active. 16:10:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:10:38 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 16:10:38 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'] 16:10:38 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 16:10:39 INFO - (blobuploader) - INFO - Open directory for files ... 16:10:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:10:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:10:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:10:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:10:39 INFO - (blobuploader) - INFO - Done attempting. 16:10:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:10:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:10:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:10:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:10:40 INFO - (blobuploader) - INFO - Done attempting. 16:10:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:10:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:10:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:10:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:10:44 INFO - (blobuploader) - INFO - Done attempting. 16:10:44 INFO - (blobuploader) - INFO - Iteration through files over. 16:10:44 INFO - Return code: 0 16:10:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:10:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:10:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/951e8cfab4aeb5f214a6c24dacbd9c9517e6c07a0f82b63ec3ff349ba09d0d0db98ec2397a6294aa960932124758d90d17fbcec0a5da0ffb2e9fb245e0efaf39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f592a421332027dab86d75c4044741a336f3aba8dffcb4d2b3ec311aeca9ff60e92fe0ddf8454f4e561a5c00a32cb3e0082c69f0da67bd4695dba62c27b61da4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c0fad790a2b4121481e6c58bea03d138320a247eb83aac10a54a38b9b9ca2a8df72116f8bb02b3759c0de511870122ef14ba568037cfd998035e45c4d2cc649"} 16:10:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:10:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:10:44 INFO - Contents: 16:10:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/951e8cfab4aeb5f214a6c24dacbd9c9517e6c07a0f82b63ec3ff349ba09d0d0db98ec2397a6294aa960932124758d90d17fbcec0a5da0ffb2e9fb245e0efaf39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f592a421332027dab86d75c4044741a336f3aba8dffcb4d2b3ec311aeca9ff60e92fe0ddf8454f4e561a5c00a32cb3e0082c69f0da67bd4695dba62c27b61da4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c0fad790a2b4121481e6c58bea03d138320a247eb83aac10a54a38b9b9ca2a8df72116f8bb02b3759c0de511870122ef14ba568037cfd998035e45c4d2cc649"} 16:10:44 INFO - Running post-run listener: copy_logs_to_upload_dir 16:10:44 INFO - Copying logs to upload dir... 16:10:44 INFO - mkdir: /builds/slave/test/build/upload/logs 16:10:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.226628 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-06 16:10:43.752267) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 16:10:43.756099) ========= 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=db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764 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/951e8cfab4aeb5f214a6c24dacbd9c9517e6c07a0f82b63ec3ff349ba09d0d0db98ec2397a6294aa960932124758d90d17fbcec0a5da0ffb2e9fb245e0efaf39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f592a421332027dab86d75c4044741a336f3aba8dffcb4d2b3ec311aeca9ff60e92fe0ddf8454f4e561a5c00a32cb3e0082c69f0da67bd4695dba62c27b61da4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c0fad790a2b4121481e6c58bea03d138320a247eb83aac10a54a38b9b9ca2a8df72116f8bb02b3759c0de511870122ef14ba568037cfd998035e45c4d2cc649"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011382 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/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/951e8cfab4aeb5f214a6c24dacbd9c9517e6c07a0f82b63ec3ff349ba09d0d0db98ec2397a6294aa960932124758d90d17fbcec0a5da0ffb2e9fb245e0efaf39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f592a421332027dab86d75c4044741a336f3aba8dffcb4d2b3ec311aeca9ff60e92fe0ddf8454f4e561a5c00a32cb3e0082c69f0da67bd4695dba62c27b61da4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c0fad790a2b4121481e6c58bea03d138320a247eb83aac10a54a38b9b9ca2a8df72116f8bb02b3759c0de511870122ef14ba568037cfd998035e45c4d2cc649"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 16:10:43.782391) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 16:10:43.782818) ========= 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=db7e7c15f3ca076d53731445000001ba-1475794203.133537-1811934764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 16:10:43.864836) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 16:10:43.865209) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 16:10:43.865604) ========= ========= Total master_lag: 0.18 =========