builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1475609089.61 results: success (0) buildid: 20161004093018 builduid: 854db343f79e4dac95f67368a01e3989 revision: 47615f092e09d8d37d883ca72e35891b242a5d4a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 12:24:49.612250) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 12:24:49.612846) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 12:24:49.613159) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 12:24:49.628769) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 12:24:49.629224) ========= 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=7de08804244eb36560b44971000001c3-1475609089.266249-1680016937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 12:24:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-10-04 12:24:50 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117772 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 12:24:49.760946) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 12:24:49.761283) ========= 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=7de08804244eb36560b44971000001c3-1475609089.266249-1680016937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014346 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 12:24:49.811359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 12:24:49.811730) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 47615f092e09d8d37d883ca72e35891b242a5d4a --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 47615f092e09d8d37d883ca72e35891b242a5d4a --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=7de08804244eb36560b44971000001c3-1475609089.266249-1680016937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 12:24:50,202 truncating revision to first 12 chars 2016-10-04 12:24:50,202 Setting DEBUG logging. 2016-10-04 12:24:50,202 attempt 1/10 2016-10-04 12:24:50,202 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/47615f092e09?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 12:24:50,528 unpacking tar archive at: fx-team-47615f092e09/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649584 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 12:24:50.475085) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 12:24:50.475526) ========= script_repo_revision: 47615f092e09d8d37d883ca72e35891b242a5d4a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 12:24:50.475974) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 12:24:50.476312) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 12:24:50.486936) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-04 12:24:50.487392) ========= /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=7de08804244eb36560b44971000001c3-1475609089.266249-1680016937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:24:50 INFO - MultiFileLogger online at 20161004 12:24:50 in /builds/slave/test 12:24:50 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 12:24:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:24:50 INFO - {'append_to_log': False, 12:24:50 INFO - 'base_work_dir': '/builds/slave/test', 12:24:50 INFO - 'blob_upload_branch': 'Fx-Team', 12:24:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:24:50 INFO - 'branch': 'Fx-Team', 12:24:50 INFO - 'buildbot_json_path': 'buildprops.json', 12:24:50 INFO - 'config_files': ('talos/linux_config.py',), 12:24:50 INFO - 'default_actions': ('clobber', 12:24:50 INFO - 'read-buildbot-config', 12:24:50 INFO - 'download-and-extract', 12:24:50 INFO - 'populate-webroot', 12:24:50 INFO - 'create-virtualenv', 12:24:50 INFO - 'install', 12:24:50 INFO - 'run-tests'), 12:24:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:24:50 INFO - 'download_minidump_stackwalk': True, 12:24:50 INFO - 'download_symbols': 'ondemand', 12:24:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:24:50 INFO - 'tooltool.py': '/tools/tooltool.py', 12:24:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:24:50 INFO - '/tools/misc-python/virtualenv.py')}, 12:24:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:24:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:24:50 INFO - 'installer_path': 'installer.exe', 12:24:50 INFO - 'log_level': 'info', 12:24:50 INFO - 'log_name': 'talos', 12:24:50 INFO - 'log_to_console': True, 12:24:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:24:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:24:50 INFO - 'opt_config_files': (), 12:24:50 INFO - 'pip_index': False, 12:24:50 INFO - 'sps_profile': False, 12:24:50 INFO - 'sps_profile_interval': 0, 12:24:50 INFO - 'suite': 'dromaeojs', 12:24:50 INFO - 'system_bits': '32', 12:24:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:24:50 INFO - 'title': 'talos-linux64-ix-003', 12:24:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:24:50 INFO - 'use_talos_json': True, 12:24:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:24:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:24:50 INFO - 'work_dir': 'build'} 12:24:50 INFO - [mozharness: 2016-10-04 19:24:50.975532Z] Running clobber step. 12:24:50 INFO - Running pre-action listener: _resource_record_pre_action 12:24:50 INFO - Running main action method: clobber 12:24:50 INFO - rmtree: /builds/slave/test/build 12:24:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:24:52 INFO - Running post-action listener: _resource_record_post_action 12:24:52 INFO - [mozharness: 2016-10-04 19:24:52.013627Z] Finished clobber step (success) 12:24:52 INFO - [mozharness: 2016-10-04 19:24:52.013726Z] Running read-buildbot-config step. 12:24:52 INFO - Running pre-action listener: _resource_record_pre_action 12:24:52 INFO - Running main action method: read_buildbot_config 12:24:52 INFO - Using buildbot properties: 12:24:52 INFO - { 12:24:52 INFO - "project": "", 12:24:52 INFO - "product": "firefox", 12:24:52 INFO - "script_repo_revision": "production", 12:24:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:24:52 INFO - "repository": "", 12:24:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 12:24:52 INFO - "buildid": "20161004093018", 12:24:52 INFO - "pgo_build": "True", 12:24:52 INFO - "basedir": "/builds/slave/test", 12:24:52 INFO - "buildnumber": 500, 12:24:52 INFO - "slavename": "talos-linux64-ix-003", 12:24:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:24:52 INFO - "platform": "ubuntu64_hw", 12:24:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:24:52 INFO - "branch": "fx-team", 12:24:52 INFO - "repo_path": "integration/fx-team", 12:24:52 INFO - "revision": "47615f092e09d8d37d883ca72e35891b242a5d4a", 12:24:52 INFO - "stage_platform": "linux64-pgo", 12:24:52 INFO - "builduid": "854db343f79e4dac95f67368a01e3989", 12:24:52 INFO - "slavebuilddir": "test" 12:24:52 INFO - } 12:24:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:24:52 INFO - Running post-action listener: _resource_record_post_action 12:24:52 INFO - [mozharness: 2016-10-04 19:24:52.016159Z] Finished read-buildbot-config step (success) 12:24:52 INFO - [mozharness: 2016-10-04 19:24:52.016248Z] Running download-and-extract step. 12:24:52 INFO - Running pre-action listener: _resource_record_pre_action 12:24:52 INFO - Running main action method: download_and_extract 12:24:52 INFO - mkdir: /builds/slave/test/build/tests 12:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:52 INFO - trying https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:24:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:24:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:24:52 INFO - Downloaded 1361 bytes. 12:24:52 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:24:52 INFO - Using the following test package requirements: 12:24:52 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:24:52 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:24:52 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:24:52 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:52 INFO - u'jsshell-linux-x86_64.zip'], 12:24:52 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:24:52 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:24:52 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:24:52 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:24:52 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:24:52 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:24:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:24:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:24:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:24:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:24:53 INFO - Http code: 200 12:24:53 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 12:24:53 INFO - x-amz-cf-id: X5vcxfZXYn_CjAWkVJZba7z6h6qkUYMmWdlLlSXoSFF3UWcUGBGdIg== 12:24:53 INFO - x-amz-version-id: XP8blm33GaPG0kIAc08FR2pPp2d1bgdg 12:24:53 INFO - Expected file size: 21992427 12:24:53 INFO - Obtained file size: 21992427 12:24:57 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 12:24:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:24:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:24:57 INFO - Fetch https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:24:58 INFO - Http code: 200 12:24:58 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 12:24:58 INFO - x-amz-cf-id: dsRiJDNAmInicg3BfqIMjO0ah-bZTgeLxtr7WB_eKSOEz-hlEMketQ== 12:24:58 INFO - x-amz-version-id: XP8blm33GaPG0kIAc08FR2pPp2d1bgdg 12:24:58 INFO - Expected file size: 21992427 12:24:58 INFO - Obtained file size: 21992427 12:25:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:25:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:25:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:25:04 INFO - Http code: 200 12:25:04 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 12:25:04 INFO - x-amz-cf-id: 1XgKzI1VKxd2zuAFSoBYIb0yEEQCq6aAT5AvPPqdJr8wSvDjI0OLYA== 12:25:04 INFO - x-amz-version-id: jTcMG_.Md0K.TbtWxt5NZqVKon20H_6m 12:25:04 INFO - Expected file size: 14409006 12:25:04 INFO - Obtained file size: 14409006 12:25:04 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')]} 12:25:04 INFO - trying https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:25:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:25:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:25:05 INFO - Downloaded 59705253 bytes. 12:25:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:25:05 INFO - mkdir: /builds/slave/test/properties 12:25:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:25:05 INFO - Writing to file /builds/slave/test/properties/build_url 12:25:05 INFO - Contents: 12:25:05 INFO - build_url:https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:25:06 INFO - Running post-action listener: _resource_record_post_action 12:25:06 INFO - Running post-action listener: set_extra_try_arguments 12:25:06 INFO - [mozharness: 2016-10-04 19:25:06.519422Z] Finished download-and-extract step (success) 12:25:06 INFO - [mozharness: 2016-10-04 19:25:06.519722Z] Running populate-webroot step. 12:25:06 INFO - Running pre-action listener: _resource_record_pre_action 12:25:06 INFO - Running main action method: populate_webroot 12:25:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:25:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:25:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:25:06 INFO - '--tppagecycles', 12:25:06 INFO - '7'], 12:25:06 INFO - 'tests': ['tsvgm']}}, 12:25:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:25:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:25:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:25:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:25:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:25:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:25:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:06 INFO - 'talos_options': ['--disable-e10s'], 12:25:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:25:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:25:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:06 INFO - 'talos_options': ['--disable-e10s'], 12:25:06 INFO - 'tests': ['damp', 'tps']}, 12:25:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:06 INFO - 'tests': ['damp', 'tps']}, 12:25:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:25:06 INFO - 'tests': ['dromaeo_dom']}, 12:25:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:25:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:25:06 INFO - 'tests': ['basic_compositor_video']}, 12:25:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:25:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:25:06 INFO - 'tests': ['a11yr', 12:25:06 INFO - 'ts_paint', 12:25:06 INFO - 'tpaint', 12:25:06 INFO - 'sessionrestore', 12:25:06 INFO - 'sessionrestore_no_auto_restore', 12:25:06 INFO - 'tabpaint']}, 12:25:06 INFO - 'other-e10s': {'tests': ['a11yr', 12:25:06 INFO - 'ts_paint', 12:25:06 INFO - 'tpaint', 12:25:06 INFO - 'sessionrestore', 12:25:06 INFO - 'sessionrestore_no_auto_restore', 12:25:06 INFO - 'tabpaint']}, 12:25:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:25:06 INFO - 'ts_paint', 12:25:06 INFO - 'tpaint', 12:25:06 INFO - 'sessionrestore', 12:25:06 INFO - 'sessionrestore_no_auto_restore', 12:25:06 INFO - 'tabpaint']}, 12:25:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:25:06 INFO - 'ts_paint', 12:25:06 INFO - 'tpaint', 12:25:06 INFO - 'sessionrestore', 12:25:06 INFO - 'sessionrestore_no_auto_restore', 12:25:06 INFO - 'tabpaint']}, 12:25:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:25:06 INFO - 'tests': ['a11yr', 12:25:06 INFO - 'ts_paint', 12:25:06 INFO - 'tpaint', 12:25:06 INFO - 'sessionrestore', 12:25:06 INFO - 'sessionrestore_no_auto_restore', 12:25:06 INFO - 'tabpaint']}, 12:25:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:25:06 INFO - 'tests': ['a11yr', 12:25:06 INFO - 'ts_paint', 12:25:06 INFO - 'tpaint', 12:25:06 INFO - 'sessionrestore', 12:25:06 INFO - 'sessionrestore_no_auto_restore', 12:25:06 INFO - 'tabpaint']}, 12:25:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:25:06 INFO - 'tests': ['tsvgx', 12:25:06 INFO - 'tsvgr_opacity', 12:25:06 INFO - 'tart', 12:25:06 INFO - 'tscrollx', 12:25:06 INFO - 'cart']}, 12:25:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:25:06 INFO - 'tsvgr_opacity', 12:25:06 INFO - 'tart', 12:25:06 INFO - 'tscrollx', 12:25:06 INFO - 'cart']}, 12:25:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:06 INFO - 'talos_options': ['--disable-e10s'], 12:25:06 INFO - 'tests': ['tp5o']}, 12:25:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:06 INFO - 'tests': ['tp5o']}, 12:25:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:06 INFO - 'talos_options': ['--disable-e10s', 12:25:06 INFO - '--xperf_path', 12:25:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:25:06 INFO - 'tests': ['tp5n']}, 12:25:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:06 INFO - 'talos_options': ['--xperf_path', 12:25:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:25:06 INFO - 'tests': ['tp5n']}}, 12:25:06 INFO - 'talos.zip': {'path': '', 12:25:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:25:06 INFO - Running post-action listener: _resource_record_post_action 12:25:06 INFO - [mozharness: 2016-10-04 19:25:06.537623Z] Finished populate-webroot step (success) 12:25:06 INFO - [mozharness: 2016-10-04 19:25:06.537716Z] Running create-virtualenv step. 12:25:06 INFO - Running pre-action listener: _resource_record_pre_action 12:25:06 INFO - Running main action method: create_virtualenv 12:25:06 INFO - Creating virtualenv /builds/slave/test/build/venv 12:25:06 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 12:25:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:25:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:25:06 INFO - Using real prefix '/usr' 12:25:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:25:07 INFO - Installing distribute.............................................................................................................................................................................................done. 12:25:09 INFO - Installing pip.................done. 12:25:09 INFO - Return code: 0 12:25:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:25:09 INFO - Reading from file tmpfile_stdout 12:25:09 INFO - Output received: 12:25:09 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) 12:25:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:25:09 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')]} 12:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:09 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')]} 12:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:09 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 0x7f4d9fe49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e790>, '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 0x1f0f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fb20>, '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': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', '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 12:25:09 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 12:25:09 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 12:25:09 INFO - Using env: {'DISPLAY': ':0', 12:25:09 INFO - 'HOME': '/home/cltbld', 12:25:09 INFO - 'LANG': 'en_US.UTF-8', 12:25:09 INFO - 'LANGUAGE': 'en_US:en', 12:25:09 INFO - 'LOGNAME': 'cltbld', 12:25:09 INFO - 'MAIL': '/var/mail/cltbld', 12:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:09 INFO - 'MOZ_NO_REMOTE': '1', 12:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:09 INFO - 'NO_EM_RESTART': '1', 12:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:09 INFO - 'PWD': '/builds/slave/test', 12:25:09 INFO - 'SHELL': '/bin/bash', 12:25:09 INFO - 'SHLVL': '1', 12:25:09 INFO - 'TERM': 'linux', 12:25:09 INFO - 'TMOUT': '86400', 12:25:09 INFO - 'USER': 'cltbld', 12:25:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', 12:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:09 INFO - '_': '/tools/buildbot/bin/python'} 12:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:09 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 12:25:09 INFO - Cleaning up... 12:25:09 INFO - Return code: 0 12:25:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:25:09 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')]} 12:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:09 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')]} 12:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:09 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 0x7f4d9fe49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e790>, '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 0x1f0f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fb20>, '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': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', '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 12:25:09 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 12:25:09 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 12:25:09 INFO - Using env: {'DISPLAY': ':0', 12:25:09 INFO - 'HOME': '/home/cltbld', 12:25:09 INFO - 'LANG': 'en_US.UTF-8', 12:25:09 INFO - 'LANGUAGE': 'en_US:en', 12:25:09 INFO - 'LOGNAME': 'cltbld', 12:25:09 INFO - 'MAIL': '/var/mail/cltbld', 12:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:09 INFO - 'MOZ_NO_REMOTE': '1', 12:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:09 INFO - 'NO_EM_RESTART': '1', 12:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:09 INFO - 'PWD': '/builds/slave/test', 12:25:09 INFO - 'SHELL': '/bin/bash', 12:25:09 INFO - 'SHLVL': '1', 12:25:09 INFO - 'TERM': 'linux', 12:25:09 INFO - 'TMOUT': '86400', 12:25:09 INFO - 'USER': 'cltbld', 12:25:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', 12:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:09 INFO - '_': '/tools/buildbot/bin/python'} 12:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:09 INFO - Downloading/unpacking psutil>=3.1.1 12:25:09 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 12:25:09 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 12:25:09 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 12:25:09 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 12:25:09 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 12:25:09 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 12:25:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:25:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:25:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:25:11 INFO - Installing collected packages: psutil 12:25:11 INFO - Running setup.py install for psutil 12:25:11 INFO - building 'psutil._psutil_linux' extension 12:25:11 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 12:25:12 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 12:25:12 INFO - building 'psutil._psutil_posix' extension 12:25:12 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 12:25:12 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 12:25:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:25:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:25:12 INFO - Successfully installed psutil 12:25:12 INFO - Cleaning up... 12:25:12 INFO - Return code: 0 12:25:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:25:12 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')]} 12:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:12 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')]} 12:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:12 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 0x7f4d9fe49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e790>, '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 0x1f0f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fb20>, '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': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', '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 12:25:12 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 12:25:12 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 12:25:12 INFO - Using env: {'DISPLAY': ':0', 12:25:12 INFO - 'HOME': '/home/cltbld', 12:25:12 INFO - 'LANG': 'en_US.UTF-8', 12:25:12 INFO - 'LANGUAGE': 'en_US:en', 12:25:12 INFO - 'LOGNAME': 'cltbld', 12:25:12 INFO - 'MAIL': '/var/mail/cltbld', 12:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:12 INFO - 'MOZ_NO_REMOTE': '1', 12:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:12 INFO - 'NO_EM_RESTART': '1', 12:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:12 INFO - 'PWD': '/builds/slave/test', 12:25:12 INFO - 'SHELL': '/bin/bash', 12:25:12 INFO - 'SHLVL': '1', 12:25:12 INFO - 'TERM': 'linux', 12:25:12 INFO - 'TMOUT': '86400', 12:25:12 INFO - 'USER': 'cltbld', 12:25:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', 12:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:12 INFO - '_': '/tools/buildbot/bin/python'} 12:25:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:25:12 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 12:25:12 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 12:25:12 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 12:25:12 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 12:25:12 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 12:25:12 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 12:25:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:25:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:25:14 INFO - Installing collected packages: mozsystemmonitor 12:25:14 INFO - Running setup.py install for mozsystemmonitor 12:25:14 INFO - Successfully installed mozsystemmonitor 12:25:14 INFO - Cleaning up... 12:25:14 INFO - Return code: 0 12:25:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:25:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:25:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d9fe49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e790>, '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 0x1f0f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fb20>, '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': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', '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 12:25:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:25:14 INFO - Using env: {'DISPLAY': ':0', 12:25:14 INFO - 'HOME': '/home/cltbld', 12:25:14 INFO - 'LANG': 'en_US.UTF-8', 12:25:14 INFO - 'LANGUAGE': 'en_US:en', 12:25:14 INFO - 'LOGNAME': 'cltbld', 12:25:14 INFO - 'MAIL': '/var/mail/cltbld', 12:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:14 INFO - 'MOZ_NO_REMOTE': '1', 12:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:14 INFO - 'NO_EM_RESTART': '1', 12:25:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:14 INFO - 'PWD': '/builds/slave/test', 12:25:14 INFO - 'SHELL': '/bin/bash', 12:25:14 INFO - 'SHLVL': '1', 12:25:14 INFO - 'TERM': 'linux', 12:25:14 INFO - 'TMOUT': '86400', 12:25:14 INFO - 'USER': 'cltbld', 12:25:14 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', 12:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:14 INFO - '_': '/tools/buildbot/bin/python'} 12:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:14 INFO - Downloading/unpacking jsonschema==2.5.1 12:25:14 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 12:25:14 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 12:25:14 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 12:25:14 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 12:25:14 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 12:25:14 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 12:25:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:25:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:25:16 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 12:25:16 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 12:25:16 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 12:25:16 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 12:25:16 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 12:25:16 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 12:25:17 INFO - Downloading functools32-3.2.3-2.tar.gz 12:25:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:25:17 INFO - warning: no files found matching '*.txt' 12:25:17 INFO - no previously-included directories found matching 'build' 12:25:17 INFO - no previously-included directories found matching 'dist' 12:25:17 INFO - no previously-included directories found matching '.git*' 12:25:17 INFO - Installing collected packages: jsonschema, functools32 12:25:17 INFO - Running setup.py install for functools32 12:25:17 INFO - warning: no files found matching '*.txt' 12:25:17 INFO - no previously-included directories found matching 'build' 12:25:17 INFO - no previously-included directories found matching 'dist' 12:25:17 INFO - no previously-included directories found matching '.git*' 12:25:17 INFO - Successfully installed jsonschema functools32 12:25:17 INFO - Cleaning up... 12:25:17 INFO - Return code: 0 12:25:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:25: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')]} 12:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25: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')]} 12:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:17 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 0x7f4d9fe49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e790>, '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 0x1f0f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fb20>, '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': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', '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 12:25:17 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 12:25:17 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 12:25:17 INFO - Using env: {'DISPLAY': ':0', 12:25:17 INFO - 'HOME': '/home/cltbld', 12:25:17 INFO - 'LANG': 'en_US.UTF-8', 12:25:17 INFO - 'LANGUAGE': 'en_US:en', 12:25:17 INFO - 'LOGNAME': 'cltbld', 12:25:17 INFO - 'MAIL': '/var/mail/cltbld', 12:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:17 INFO - 'MOZ_NO_REMOTE': '1', 12:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:17 INFO - 'NO_EM_RESTART': '1', 12:25:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:17 INFO - 'PWD': '/builds/slave/test', 12:25:17 INFO - 'SHELL': '/bin/bash', 12:25:17 INFO - 'SHLVL': '1', 12:25:17 INFO - 'TERM': 'linux', 12:25:17 INFO - 'TMOUT': '86400', 12:25:17 INFO - 'USER': 'cltbld', 12:25:17 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', 12:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:17 INFO - '_': '/tools/buildbot/bin/python'} 12:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:25:17 INFO - Cleaning up... 12:25:17 INFO - Return code: 0 12:25:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:25: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')]} 12:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25: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')]} 12:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:17 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 0x7f4d9fe49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e790>, '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 0x1f0f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fb20>, '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': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', '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 12:25:17 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 12:25:17 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 12:25:17 INFO - Using env: {'DISPLAY': ':0', 12:25:17 INFO - 'HOME': '/home/cltbld', 12:25:17 INFO - 'LANG': 'en_US.UTF-8', 12:25:17 INFO - 'LANGUAGE': 'en_US:en', 12:25:17 INFO - 'LOGNAME': 'cltbld', 12:25:17 INFO - 'MAIL': '/var/mail/cltbld', 12:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:17 INFO - 'MOZ_NO_REMOTE': '1', 12:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:17 INFO - 'NO_EM_RESTART': '1', 12:25:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:17 INFO - 'PWD': '/builds/slave/test', 12:25:17 INFO - 'SHELL': '/bin/bash', 12:25:17 INFO - 'SHLVL': '1', 12:25:17 INFO - 'TERM': 'linux', 12:25:17 INFO - 'TMOUT': '86400', 12:25:17 INFO - 'USER': 'cltbld', 12:25:17 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', 12:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:17 INFO - '_': '/tools/buildbot/bin/python'} 12:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:17 INFO - Downloading/unpacking blobuploader==1.2.4 12:25:17 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 12:25:17 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 12:25:17 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 12:25:17 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 12:25:17 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 12:25:17 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 12:25:19 INFO - Downloading blobuploader-1.2.4.tar.gz 12:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:25:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:25:19 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 12:25:19 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 12:25:19 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 12:25:19 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 12:25:19 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 12:25:19 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 12:25:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:25:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:25:20 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 12:25:20 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 12:25:20 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 12:25:20 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 12:25:20 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 12:25:20 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 12:25:20 INFO - Downloading docopt-0.6.1.tar.gz 12:25:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:25:20 INFO - Installing collected packages: blobuploader, requests, docopt 12:25:20 INFO - Running setup.py install for blobuploader 12:25:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:25:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:25:20 INFO - Running setup.py install for requests 12:25:21 INFO - Running setup.py install for docopt 12:25:21 INFO - Successfully installed blobuploader requests docopt 12:25:21 INFO - Cleaning up... 12:25:21 INFO - Return code: 0 12:25:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:25: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')]} 12:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25: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')]} 12:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:21 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 0x7f4d9fe49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e790>, '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 0x1f0f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fb20>, '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': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', '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 12:25:21 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 12:25:21 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 12:25:21 INFO - Using env: {'DISPLAY': ':0', 12:25:21 INFO - 'HOME': '/home/cltbld', 12:25:21 INFO - 'LANG': 'en_US.UTF-8', 12:25:21 INFO - 'LANGUAGE': 'en_US:en', 12:25:21 INFO - 'LOGNAME': 'cltbld', 12:25:21 INFO - 'MAIL': '/var/mail/cltbld', 12:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:21 INFO - 'MOZ_NO_REMOTE': '1', 12:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:21 INFO - 'NO_EM_RESTART': '1', 12:25:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:21 INFO - 'PWD': '/builds/slave/test', 12:25:21 INFO - 'SHELL': '/bin/bash', 12:25:21 INFO - 'SHLVL': '1', 12:25:21 INFO - 'TERM': 'linux', 12:25:21 INFO - 'TMOUT': '86400', 12:25:21 INFO - 'USER': 'cltbld', 12:25:21 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', 12:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:21 INFO - '_': '/tools/buildbot/bin/python'} 12:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:25:21 INFO - Running setup.py (path:/tmp/pip-e_XQXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:25:21 INFO - Running setup.py (path:/tmp/pip-89KkfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:25:21 INFO - Running setup.py (path:/tmp/pip-kHU7qE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:25:21 INFO - Running setup.py (path:/tmp/pip-5bX7hD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:25:21 INFO - Running setup.py (path:/tmp/pip-EQIuJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:25:21 INFO - Running setup.py (path:/tmp/pip-ICrcaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:25:21 INFO - Running setup.py (path:/tmp/pip-RGa4q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:25:21 INFO - Running setup.py (path:/tmp/pip-cWGj4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:25:21 INFO - Running setup.py (path:/tmp/pip-vsx7X8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:25:22 INFO - Running setup.py (path:/tmp/pip-0NDV9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:25:22 INFO - Running setup.py (path:/tmp/pip-iKka6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:25:22 INFO - Running setup.py (path:/tmp/pip-i6wM_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:25:22 INFO - Running setup.py (path:/tmp/pip-8ddPTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:25:22 INFO - Running setup.py (path:/tmp/pip-DxLd1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:25:22 INFO - Running setup.py (path:/tmp/pip-zxCLYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:25:22 INFO - Running setup.py (path:/tmp/pip-JlJa0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:25:22 INFO - Running setup.py (path:/tmp/pip-d58Gtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:25:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:25:22 INFO - Running setup.py install for manifestparser 12:25:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:25:22 INFO - Running setup.py install for mozcrash 12:25:22 INFO - Running setup.py install for mozdebug 12:25:23 INFO - Running setup.py install for mozdevice 12:25:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:25:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:25:23 INFO - Running setup.py install for mozfile 12:25:23 INFO - Running setup.py install for mozhttpd 12:25:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:25:23 INFO - Running setup.py install for mozinfo 12:25:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:25:23 INFO - Running setup.py install for mozInstall 12:25:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:25:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:25:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:25:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:25:23 INFO - Running setup.py install for mozleak 12:25:23 INFO - Running setup.py install for mozlog 12:25:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:25:23 INFO - Running setup.py install for moznetwork 12:25:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:25:23 INFO - Running setup.py install for mozprocess 12:25:24 INFO - Running setup.py install for mozprofile 12:25:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:25:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:25:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:25:24 INFO - Running setup.py install for mozrunner 12:25:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:25:24 INFO - Running setup.py install for mozscreenshot 12:25:24 INFO - Running setup.py install for moztest 12:25:24 INFO - Running setup.py install for mozversion 12:25:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:25:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:25:24 INFO - Cleaning up... 12:25:24 INFO - Return code: 0 12:25:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:25: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')]} 12:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25: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')]} 12:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:24 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 0x7f4d9fe49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e790>, '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 0x1f0f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fb20>, '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': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', '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 12:25:24 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 12:25:24 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 12:25:24 INFO - Using env: {'DISPLAY': ':0', 12:25:24 INFO - 'HOME': '/home/cltbld', 12:25:24 INFO - 'LANG': 'en_US.UTF-8', 12:25:24 INFO - 'LANGUAGE': 'en_US:en', 12:25:24 INFO - 'LOGNAME': 'cltbld', 12:25:24 INFO - 'MAIL': '/var/mail/cltbld', 12:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:24 INFO - 'MOZ_NO_REMOTE': '1', 12:25:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:24 INFO - 'NO_EM_RESTART': '1', 12:25:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:24 INFO - 'PWD': '/builds/slave/test', 12:25:24 INFO - 'SHELL': '/bin/bash', 12:25:24 INFO - 'SHLVL': '1', 12:25:24 INFO - 'TERM': 'linux', 12:25:24 INFO - 'TMOUT': '86400', 12:25:24 INFO - 'USER': 'cltbld', 12:25:24 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', 12:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:24 INFO - '_': '/tools/buildbot/bin/python'} 12:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:25:24 INFO - Running setup.py (path:/tmp/pip-SmoKwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:25:24 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)) 12:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:25:24 INFO - Running setup.py (path:/tmp/pip-ube7cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:25:24 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)) 12:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:25:24 INFO - Running setup.py (path:/tmp/pip-Ae88Eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:25:25 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)) 12:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:25:25 INFO - Running setup.py (path:/tmp/pip-TbmuNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:25:25 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)) 12:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:25:25 INFO - Running setup.py (path:/tmp/pip-HIjBrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:25:25 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)) 12:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:25:25 INFO - Running setup.py (path:/tmp/pip-9YuuNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:25:25 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)) 12:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:25:25 INFO - Running setup.py (path:/tmp/pip-WL2EJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:25:25 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)) 12:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:25:25 INFO - Running setup.py (path:/tmp/pip-W8zEyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:25:25 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)) 12:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:25:25 INFO - Running setup.py (path:/tmp/pip-X59yum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:25:25 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)) 12:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:25:25 INFO - Running setup.py (path:/tmp/pip-Z4v__a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:25:25 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)) 12:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:25:25 INFO - Running setup.py (path:/tmp/pip-ZEdMVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:25:25 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)) 12:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:25:25 INFO - Running setup.py (path:/tmp/pip-IksO7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:25:25 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)) 12:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:25:25 INFO - Running setup.py (path:/tmp/pip-o30Ego-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:25:25 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)) 12:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:25:25 INFO - Running setup.py (path:/tmp/pip-ZngY86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:25:25 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)) 12:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:25:25 INFO - Running setup.py (path:/tmp/pip-0m1E54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:25:25 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)) 12:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:25:25 INFO - Running setup.py (path:/tmp/pip-2c7dyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:25:25 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)) 12:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:25:25 INFO - Running setup.py (path:/tmp/pip-PFwEFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:25:26 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)) 12:25:26 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)) 12:25:26 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)) 12:25:26 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)) 12:25:26 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)) 12:25:26 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)) 12:25:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:25: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 12:25: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 12:25: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 12:25: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 12:25: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 12:25: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 12:25:27 INFO - Downloading blessings-1.6.tar.gz 12:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:25:28 INFO - Installing collected packages: blessings 12:25:28 INFO - Running setup.py install for blessings 12:25:28 INFO - Successfully installed blessings 12:25:28 INFO - Cleaning up... 12:25:28 INFO - Return code: 0 12:25:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:25:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:25:28 INFO - Reading from file tmpfile_stdout 12:25:28 INFO - Current package versions: 12:25:28 INFO - argparse == 1.2.1 12:25:28 INFO - blessings == 1.6 12:25:28 INFO - blobuploader == 1.2.4 12:25:28 INFO - docopt == 0.6.1 12:25:28 INFO - functools32 == 3.2.3-2 12:25:28 INFO - jsonschema == 2.5.1 12:25:28 INFO - manifestparser == 1.1 12:25:28 INFO - mozInstall == 1.12 12:25:28 INFO - mozcrash == 0.17 12:25:28 INFO - mozdebug == 0.1 12:25:28 INFO - mozdevice == 0.48 12:25:28 INFO - mozfile == 1.2 12:25:28 INFO - mozhttpd == 0.7 12:25:28 INFO - mozinfo == 0.9 12:25:28 INFO - mozleak == 0.1 12:25:28 INFO - mozlog == 3.4 12:25:28 INFO - moznetwork == 0.27 12:25:28 INFO - mozprocess == 0.23 12:25:28 INFO - mozprofile == 0.28 12:25:28 INFO - mozrunner == 6.12 12:25:28 INFO - mozscreenshot == 0.1 12:25:28 INFO - mozsystemmonitor == 0.3 12:25:28 INFO - moztest == 0.7 12:25:28 INFO - mozversion == 1.4 12:25:28 INFO - psutil == 3.1.1 12:25:28 INFO - requests == 1.2.3 12:25:28 INFO - wsgiref == 0.1.2 12:25:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:25: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')]} 12:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25: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')]} 12:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:28 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 0x7f4d9fe49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e790>, '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 0x1f0f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fb20>, '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': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', '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 12:25:28 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 12:25:28 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 12:25:28 INFO - Using env: {'DISPLAY': ':0', 12:25:28 INFO - 'HOME': '/home/cltbld', 12:25:28 INFO - 'LANG': 'en_US.UTF-8', 12:25:28 INFO - 'LANGUAGE': 'en_US:en', 12:25:28 INFO - 'LOGNAME': 'cltbld', 12:25:28 INFO - 'MAIL': '/var/mail/cltbld', 12:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:28 INFO - 'MOZ_NO_REMOTE': '1', 12:25:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:28 INFO - 'NO_EM_RESTART': '1', 12:25:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:28 INFO - 'PWD': '/builds/slave/test', 12:25:28 INFO - 'SHELL': '/bin/bash', 12:25:28 INFO - 'SHLVL': '1', 12:25:28 INFO - 'TERM': 'linux', 12:25:28 INFO - 'TMOUT': '86400', 12:25:28 INFO - 'USER': 'cltbld', 12:25:28 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', 12:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:28 INFO - '_': '/tools/buildbot/bin/python'} 12:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:28 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)) 12:25:28 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)) 12:25:28 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)) 12:25:28 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)) 12:25:28 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)) 12:25:28 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)) 12:25:28 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)) 12:25:28 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)) 12:25:28 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)) 12:25:28 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)) 12:25:28 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)) 12:25:28 INFO - Cleaning up... 12:25:28 INFO - Return code: 0 12:25:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:25: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')]} 12:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25: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')]} 12:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d9fe49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e790>, '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 0x1f0f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fb20>, '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': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', '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 12:25: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', 'jsonschema'] in /builds/slave/test/build 12:25: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 jsonschema 12:25:28 INFO - Using env: {'DISPLAY': ':0', 12:25:28 INFO - 'HOME': '/home/cltbld', 12:25:28 INFO - 'LANG': 'en_US.UTF-8', 12:25:28 INFO - 'LANGUAGE': 'en_US:en', 12:25:28 INFO - 'LOGNAME': 'cltbld', 12:25:28 INFO - 'MAIL': '/var/mail/cltbld', 12:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:28 INFO - 'MOZ_NO_REMOTE': '1', 12:25:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:28 INFO - 'NO_EM_RESTART': '1', 12:25:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:28 INFO - 'PWD': '/builds/slave/test', 12:25:28 INFO - 'SHELL': '/bin/bash', 12:25:28 INFO - 'SHLVL': '1', 12:25:28 INFO - 'TERM': 'linux', 12:25:28 INFO - 'TMOUT': '86400', 12:25:28 INFO - 'USER': 'cltbld', 12:25:28 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', 12:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:28 INFO - '_': '/tools/buildbot/bin/python'} 12:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:25:28 INFO - Cleaning up... 12:25:28 INFO - Return code: 0 12:25:28 INFO - Running post-action listener: _resource_record_post_action 12:25:28 INFO - Running post-action listener: _start_resource_monitoring 12:25:28 INFO - Starting resource monitoring. 12:25:28 INFO - [mozharness: 2016-10-04 19:25:28.921671Z] Finished create-virtualenv step (success) 12:25:28 INFO - [mozharness: 2016-10-04 19:25:28.922139Z] Running install step. 12:25:28 INFO - Running pre-action listener: _resource_record_pre_action 12:25:28 INFO - Running main action method: install 12:25:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:25:29 INFO - Reading from file tmpfile_stdout 12:25:29 INFO - Detecting whether we're running mozinstall >=1.0... 12:25:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:25:29 INFO - Reading from file tmpfile_stdout 12:25:29 INFO - Output received: 12:25:29 INFO - Usage: mozinstall [options] installer 12:25:29 INFO - Options: 12:25:29 INFO - -h, --help show this help message and exit 12:25:29 INFO - -d DEST, --destination=DEST 12:25:29 INFO - Directory to install application into. [default: 12:25:29 INFO - "/builds/slave/test"] 12:25:29 INFO - --app=APP Application being installed. [default: firefox] 12:25:29 INFO - mkdir: /builds/slave/test/build/application 12:25:29 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'] 12:25:29 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 12:25:46 INFO - Reading from file tmpfile_stdout 12:25:46 INFO - Output received: 12:25:46 INFO - /builds/slave/test/build/application/firefox/firefox 12:25:46 INFO - Running post-action listener: _resource_record_post_action 12:25:46 INFO - [mozharness: 2016-10-04 19:25:46.465890Z] Finished install step (success) 12:25:46 INFO - [mozharness: 2016-10-04 19:25:46.466138Z] Running run-tests step. 12:25:46 INFO - Running pre-action listener: _resource_record_pre_action 12:25:46 INFO - Running main action method: run_tests 12:25:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:25:46 INFO - Python 2.7.3 12:25:46 INFO - Return code: 0 12:25:46 INFO - grabbing minidump binary from tooltool 12:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:25:46 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 0x1f0e790>, '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 0x1f0f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:25:46 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 12:25:46 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 12:25:46 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 12:25:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:25:46 INFO - Return code: 0 12:25:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:25:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:25:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:25:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:25:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:25:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 12:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 12:25:46 INFO - Using env: {'DISPLAY': ':0', 12:25:46 INFO - 'HOME': '/home/cltbld', 12:25:46 INFO - 'LANG': 'en_US.UTF-8', 12:25:46 INFO - 'LANGUAGE': 'en_US:en', 12:25:46 INFO - 'LOGNAME': 'cltbld', 12:25:46 INFO - 'MAIL': '/var/mail/cltbld', 12:25:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:25:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:46 INFO - 'MOZ_NO_REMOTE': '1', 12:25:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:46 INFO - 'NO_EM_RESTART': '1', 12:25:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:46 INFO - 'PWD': '/builds/slave/test', 12:25:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:25:46 INFO - 'SHELL': '/bin/bash', 12:25:46 INFO - 'SHLVL': '1', 12:25:46 INFO - 'TERM': 'linux', 12:25:46 INFO - 'TMOUT': '86400', 12:25:46 INFO - 'USER': 'cltbld', 12:25:46 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475609089.266249-1680016937', 12:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:46 INFO - '_': '/tools/buildbot/bin/python'} 12:25:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 12:25:46 INFO - mozversion application_buildid: 20161004093018 12:25:46 INFO - mozversion application_changeset: 47615f092e09d8d37d883ca72e35891b242a5d4a 12:25:46 INFO - mozversion application_display_name: Nightly 12:25:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:25:46 INFO - mozversion application_name: Firefox 12:25:46 INFO - mozversion application_remotingname: firefox 12:25:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:25:46 INFO - mozversion application_vendor: Mozilla 12:25:46 INFO - mozversion application_version: 52.0a1 12:25:46 INFO - mozversion platform_buildid: 20161004093018 12:25:46 INFO - mozversion platform_changeset: 47615f092e09d8d37d883ca72e35891b242a5d4a 12:25:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:25:46 INFO - mozversion platform_version: 52.0a1 12:25:46 INFO - using testdate: 1475609146 12:25:46 INFO - actual date: 1475609146 12:25:46 INFO - starting webserver on 'localhost:53884' 12:25:46 INFO - SUITE-START | Running 2 tests 12:25:46 INFO - TEST-START | dromaeo_css 12:25:46 INFO - operating with platform_type : linux_ 12:25:46 INFO - Initialising browser for dromaeo_css test... 12:25:46 INFO - TEST-INFO | started process 8232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdsQv9g/profile http://localhost:53884/getInfo.html) 12:25:51 INFO - PROCESS | 8232 | __metrics Screen width/height:1600/1200 12:25:51 INFO - PROCESS | 8232 | colorDepth:24 12:25:51 INFO - PROCESS | 8232 | Browser inner width/height: 1024/697 12:25:51 INFO - PROCESS | 8232 | __metrics 12:25:51 INFO - PROCESS | 8232 | 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" 12:25:51 INFO - PROCESS | 8232 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:25:52 INFO - PROCESS | 8232 | console.error: PushService: 12:25:52 INFO - PROCESS | 8232 | stateChangeProcessEnqueue: Error transitioning state 12:25:52 INFO - PROCESS | 8232 | UnknownError 12:25:53 INFO - TEST-INFO | 8232: exit 0 12:25:53 INFO - Browser initialized. 12:25:53 INFO - Running cycle 1/1 for dromaeo_css test... 12:25:53 INFO - TEST-INFO | started process 8313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdsQv9g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:26:05 INFO - PROCESS | 8313 | RSS: Main: 173150208 12:26:05 INFO - PROCESS | 8313 | 12:26:56 INFO - PROCESS | 8313 | 1475609216677 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] 12:29:06 INFO - PROCESS | 8313 | Cycle 1(1): loaded http://localhost:53884/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53884/tests/dromaeo/cssquery-ext.html) 12:29:08 INFO - PROCESS | 8313 | RSS: Main: 322633728 12:29:08 INFO - PROCESS | 8313 | 12:32:10 INFO - PROCESS | 8313 | Cycle 1(1): loaded http://localhost:53884/tests/dromaeo/cssquery-ext.html (next: http://localhost:53884/tests/dromaeo/cssquery-jquery.html) 12:32:11 INFO - PROCESS | 8313 | RSS: Main: 283561984 12:32:11 INFO - PROCESS | 8313 | 12:35:13 INFO - PROCESS | 8313 | Cycle 1(1): loaded http://localhost:53884/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53884/tests/dromaeo/cssquery-mootools.html) 12:35:13 INFO - PROCESS | 8313 | RSS: Main: 277377024 12:35:13 INFO - PROCESS | 8313 | 12:38:15 INFO - PROCESS | 8313 | Cycle 1(1): loaded http://localhost:53884/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53884/tests/dromaeo/cssquery-prototype.html) 12:38:16 INFO - PROCESS | 8313 | RSS: Main: 239857664 12:38:16 INFO - PROCESS | 8313 | 12:41:19 INFO - PROCESS | 8313 | Cycle 1(1): loaded http://localhost:53884/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53884/tests/dromaeo/cssquery-yui.html) 12:41:19 INFO - PROCESS | 8313 | RSS: Main: 215658496 12:41:19 INFO - PROCESS | 8313 | 12:44:23 INFO - PROCESS | 8313 | Cycle 1(1): loaded http://localhost:53884/tests/dromaeo/cssquery-yui.html (next: http://localhost:53884/tests/dromaeo/cssquery-dojo.html) 12:44:23 INFO - PROCESS | 8313 | RSS: Main: 307589120 12:44:23 INFO - PROCESS | 8313 | 12:44:23 INFO - PROCESS | 8313 | __start_tp_report 12:44:23 INFO - PROCESS | 8313 | _x_x_mozilla_page_load 12:44:23 INFO - PROCESS | 8313 | _x_x_mozilla_page_load_details 12:44:23 INFO - PROCESS | 8313 | |i|pagename|runs| 12:44:23 INFO - PROCESS | 8313 | |0;dojo.html;2890.913272601822;2920.7371336579704;2926.8975585854487;2971.0344138155106;2974.7025297470254;4943;5056.938043010972;5083.5933125349975;5086.160783470727;5139.357580302462;5087.949120508793;5122.948770512294;5169.224616307556;5196.766145523451;5205.011047900896;4607.17070927233;4611.123886461562;4623.537646235383;4644.883877903046;4788.257820037899;4795.448523419816;4843.39457567804;4850.53919877611;4872.829450969217;4874.683145595543;4663.556962088596;4707.835225767116;4760.809567617292;4819.903601927959;4834.661573689861;4685.4377474702915;4752.097101550728;4754.952450475485;4769.689970151963;4827.25177597473;4722.574968252839;4741.288806678991;4743.881402964919;4749.430068391781;4769.499202583714;5205.193195054772;5222.63441559091;5226.189940559219;5229.398619158807;5278.340207474066;5344.732763361816;5385.892282154374;5386.892262154735;5463.590230732711;5483.75323110461;5483.7806487740445;5485.369182544018;5491.28613280271;5492.917606235909;5493.615446918678;5069.163588007974;5098.362704661918;5103.566196873233;5106.4638212987475;5137.51193636604;5572.777088916398;5616.185653080281;5616.6068375213345;5667;5682.289713785777;5391.110466772939;5397.622166448311;5399.217113518518;5401.108817045222;5401.648892822032;5381.784728610812;5421;5453.863653408617;5461.481159289861;5533.612647114744;5348.812791552355;5402.675839449567;5450.5639548836;5487.6981766002455;5548.528375088163;5465.152901300305;5472.042392581362;5477.808276710296;5482.890342193134;5542.528885044736;4225.788710564521;4264.978675106605;4270.765107919095;4279.957200428018;4323.978380108079;3776.735628505978;3806.2958352704836;3811.866584669523;3819.102510909934;3843.404272337792;5257.868553286198;5271.288376069258;5272.578193744491;5273.499017593323;5327.733613319396;5538.16927460876;5541.251930989265;5546.306711661043;5549.084401073858;5549.139883318092;5073.670211436245;5118.667286626432;5150.098732721759;5171.301874247004;5196.92204616931;4755.95244047562;4756.5956893664425;4758;4796.184648609745;4803.255495398219;5665.376808550974;5700.344460387026;5710.942890571041;5713.314402271754;5741.196232527366;5396.78412863481;5398.973005134949;5450.482204190595;5496.780128794803;5505.284313039279;5692.943070569241;5735.25441692594;5765.884682306414;5840.591158618856;5844.561657875592;5398.568114550905;5445.945540544544;5446.237526746179;5465.59008074388;5473.288472498709;5504.22940788282;5512.228288039598;5514.420985796433;5533.197686335539;5570.972145139248;5227.973860130675;5247.291615631841;5306.097963346318;5317.7341132943975;5341.893162136813;5315.123004704181;5359.14253719403;5359.490848369399;5368.892622147613;5412.8646783829145;5375.1131063374105;5377.811776587957;5381.165919282517;5386.057439947915;5444.700541470257;5305.045091883498;5335.519803217729;5375.247465354775;5383.273258110262;5398.892022159456;5361.758720857492;5363.651362661414;5406.297181366397;5419.458054194549;5426.348838139448 12:44:23 INFO - PROCESS | 8313 | |1;ext.html;556.8494397960453;581.299534061456;599.5653151465189;606.0485038489571;607.7325976570312;31396.843015784918;41454.7927260364;42249.57750422495;42261.366079508756;42315.15369692604;43349.56650433494;43503.34744978828;43584.128317433635;43859.12281754363;43913.34129988053;7894.763157105296;8086.676532938704;8817.95591022044;8984.730458086235;8986.460812351279;10457.58169673212;10712.78574428511;10723.463826808667;11094.889051109507;11114.6109886154;8138.715144969928;8169;8174.6730130794695;8176.591170441484;8184;10709.410982395964;10786;10794.352338859693;10796.2442629016;10800.945995270013;10630.362178269328;10706.250562460631;10706.78586428267;10708.1433485321;10712.78574428515;41997.37003944943;42310.57689423097;42331.36502952458;42368;42454.787726061484;3327.750418718606;3336.7664263501565;3356.127406874206;3389.9491507627404;3450.430678937972;29946;32266.677333226602;32334.514982275286;32433.43232244451;34041.6595834041;4366.235908715962;4382.189294980439;4397.934030989538;4477.417935668343;4516.616087632555;134630;135933;135941;136165.31917340448;136301;58863.41136588665;59223.70388148118;59267.999999999134;59378.70310648505;59412;34804.65195348065;35595;35725.821370892976;38286.23427531434;38481.42277865834;17028.148592570324;17238.741418878726;17239.396621118452;17242.827571724374;17250.65498690044;11782.705432364088;12082.939585302192;12826.294553799444;13118.212907225598;13189.340532973312;18771.436856894314;18801.623967520845;18841.717374239397;18879.339223127125;18984.43046708601;6984.930150698428;7080.857014433443;7110.484842125287;7147.392471639865;7175.533590316717;907.5235501361838;949.4398305000083;966.2511553546058;1038.89611038897;1126.3129491010477;31119.533207001914;31192.376152477278;31461.685383146334;31500.80516903597;31574.210644733605;1027.6505987964129;1049.2445439283704;1104.9889501104885;1114.1977776001265;1196.4137572589543;15735.763963540556;16472.341106355612;16624.168791560616;16633.25150368212;16729.247183876756;555468;563658;564813;564915;566188;38838.80580597135;38857;38960.61039389626;39022.414663780066;39216;1189.8815113793007;1231.6058861164342;1312.7505773902737;1338.9732205356033;1344.1867670059669;28065.859670701517;31364.215894602818;31760.523592146597;31973.20066998344;32537;47521.762391187825;48100.27849582329;48134;48178.518214817406;48196.18038196152;370216;371964;372202;372366;373271;27504.58743118895;28152.43695126127;28348.43303133967;28481.857590711912;29885;44549;44668.776656117814;44898;45871.541284586725;46598;38258.80870595629;38489.80889189046;39096.41355379728;39724;40168;37999;38528.42207366836;38910;39980.400293996194;40250.39624405577;37551.81224093971;37708;37735.81132094322;37820.24359512849;38829;33351.83324083364;34709.47935780915;35112;35587.644123558435;35643.28713425769;26416.8679156603;26805.11325857779;26865.462690746466;26974.667649930674;27193.72806271912 12:44:23 INFO - PROCESS | 8313 | |2;jquery.html;360.79434722208333;374.1936127644926;404.64593480704383;405.5640186799192;416.4523651398411;13745.45018199272;18970.146343414544;19124.521886952833;19761;19888.303909363174;18426;18645.347412840554;18975.810241897576;19160.904195479005;19163.520911977208;5553.4724201200825;5838.386969368219;5851.093080572518;5854.356020837705;5855.765769369242;5652.547796176296;5654.406287339832;5685.602007859451;5687.914681279784;5707.686077265748;5674.716264186794;5677.9716101419435;5682.232898558704;5684.914726279109;5687.374388817227;5443.401225865172;5544.390117087117;5573.136163894583;5579.469950354751;5668.093105103184;4959.355283813081;4967.254911763228;4968.975155124202;4970.453250142481;4972.602191824645;22539.661905071436;22840.428989275235;22975.655365169536;23058.884705576365;23179.870717453265;2346.9647955280516;2407.590709579376;2465.815063870199;2711.3086163028497;2848.017433985272;14027.649308767363;14531.636709082251;14596.562103136817;14800.259987000714;15159.09045457276;1908.8568357373113;1909.217220939422;1913.5598812273115;1926.9614607707767;2023.929162479321;82468;86043;86144;87117;89860.55069724676;10418.030861204521;10471.47642617866;10593.675790526184;10873.184511161695;10928.617498387519;15111.54665360041;15197.31612077437;15198.088114713153;15222.543323700307;15243.23783810805;7597.734079307198;7739.496932699469;7781.494202876795;7970.6413211405625;8027.117017128111;7627.618619069024;7677.309042186118;7774.961125194338;7843.294103530709;8178.906714497737;6418.518611104186;6433.228012638513;6490.825573432859;6597.703103360361;6694.464442844561;1940.185122248659;1945.4844466216464;1959.913580185301;1969.3796454117194;1972.9185709076776;865.7619154732373;950.7195377363694;982.7297493189287;992.0129471176226;1020.0513522424217;19263.8073619262;19649.508762281057;19857.106430210388;19874.403767886986;19968;953.2421724728857;965.2374624047064;984.4339504784778;1073.2111897755144;1089.6948854320804;10481.266311358284;11119.944400277947;11127.326522860418;11382.260153090188;11387.259828111311;410197;413025;417010;417228;425207;77491;78789;80689.59655201687;84486.577567113;84757.57621211854;977.3940157102784;1012.427978192319;1045.2421994054403;1045.9633912813015;1053.115383078218;16508.33966641321;16772.664546709242;17327;17727.73408398901;17897.73153402726;39562.80218598888;40554.79722601368;40863.7956810214;40895;42044;51509.48490515197;52922;53228.20157697715;53631;54143.18785218146;8087.47431416956;8237.588120594066;8496.192861678132;8570.914290857261;8705;12752.48990040388;13480.595582132551;13501.662458438617;13664.316784160554;13755.931220343835;11251.38117403518;11402.543898244308;11654.359010254517;11770.52917883275;12166.270023798601;11590.826137608112;11612.941935290608;11724.941375293069;11786.823197652213;12114.454849531969;11520.596779112691;11583.305001699924;11690.298582085103;11865.940670296593;12312.753744924872;7569;7924.7018364673595;8602.827943441222;8716.520591367536;8786.428882122642;11055.115590752559;11308.7738245233;11367.317960922372;11390.430478475877;12090.637280881587 12:44:23 INFO - PROCESS | 8313 | |3;mootools.html;1335.6994676197862;1464.611877852369;1483;1612.9032258064517;1772.3353742346612;8025.91974080259;8764.824703505927;9222.90777092229;9234.538273086344;9508.857367139499;9298.070192980698;9380.71857844264;9386.85919711205;9389.483578403186;9400.20098291646;2307.1348244408346;2309.6304591265402;2322.5587138443725;2329.9417514562188;2344.132670911765;2266.9659955100688;2283.3834864586634;2298.276043046435;2320.860748355104;2321.2455951815728;2230.6765518999737;2249.977500224993;2261.9886900565557;2290.2442194075998;2304.44693273614;2215.3907675389237;2236.8434209605252;2243.9439014024615;2250.797428231459;2263.4001989472804;2183.344996501043;2212.7565967743535;2224.421650370899;2229.6098182818105;2238.2278114050628;8983.056779038172;9042.457452552868;9054.77363065922;9197.862032069457;9535.952320238424;4986.052649996489;5051.116054690415;5077.796888124471;5095.082885080684;5103.7192954387865;3227.467467867799;3331.233816222258;3387.728981681484;3416.4533674611944;3436.742244331685;1090.3893819461127;1128.2835399521282;1137.8520792297031;1157.8321143434239;1161.7792619402287;12769.936150319189;12879.098463107492;12917.741645167138;13026.413811378416;13043.41304641284;4180.352045432963;4348.152110338517;4426.667999900021;4460.910781784346;4493.955060449353;10098.8485172721;10125.594976201017;10128.949355253177;10129.797404051878;10134.23993200513;5152.92270615941;5155.819546315861;5158.097332966716;5158.4067832199025;5161.767720452589;4041.1513582148077;4276.764777937244;4366.973761166123;4418.248897687401;4842.83050093245;3366.444536651425;3673.430618254175;3684.9447258291148;3703;3757.342465068602;1060.390275591538;1090.8472813806075;1100.5927806711568;1109.7225693576606;1116.3580940958982;961.1829944547079;965.1506674126723;965.6041023180603;967.2068903499063;977.4770497783652;5987.640741555433;6030.33666296707;6044.879102417927;6111.84720381994;6153;443.58967954641827;444.6198500282277;445.20753059554045;453.2136742751324;455.731118640004;4292.313229883203;4304.268274393361;4312.331588603772;4343.283358245854;4358.193734159191;11294.7176320591;11627;11704.765904681859;11715.589954351728;11742.060635149168;10863.83704244437;11397.202195846212;11408.65774026764;11657.125715571367;11802.232854864405;8439.662413503514;8637.784055398539;8650.307975361957;8651.95674021626;8652.3510736695;6087.66517841523;6156.199694039746;6271.43557079865;6290.528210384148;6397.232332120176;10601.653322137887;10776.245662803529;10781.676549703521;10925.945370273097;10937.234393592373;9521.666741664008;10095.798084038131;10635.787284254426;10655.840162397726;11039.448027598428;7443.36731377839;8086.070101938352;8310.916890831015;8311.293540049164;8313.916860831556;8636.438631488933;8690.435121717068;8715.825683486422;8950.283977281932;8969.461832290084;7718.53688778675;7734.92265077342;7896.368290536858;7925.603719814101;8019.157988411366;7465.29079737424;7690.884636730341;7798;7814.33578145864;7920.5247685139075;6960.8955865663065;7056.188538318159;7105.857882842418;7127.964360178166;7141.071660684078;4980.302757613865;5123.436421993503;5175.068487672104;5183.300254465599;5198.9740051299505;5116.104681680766;5168.664036837594;5256.9211461827335;5322.121849894879;5445.809396671098 12:44:23 INFO - PROCESS | 8313 | |4;prototype.html;306.9493533566963;309.1590872825913;321.46636583271766;323.2839261036803;323.5082674335012;4987.202047672373;5134.127198376275;5184.948150518494;5197.610179236558;5206.895862082756;5004.7747851346685;5109.540141387283;5121.283020377141;5126.2054381570915;5150.768215430306;4082.2856000199995;4088.1619268050126;4102.958970410287;4109.4246805447265;4119.073208528087;3837;3862.2275544890995;4104.363823607331;4113.8971525711795;4116.506019277691;4042.292598795214;4046.817893194813;4048.57489963554;4052.9189416211657;4067.6745860331102;4035.1122752994293;4044.170944956292;4046.6964977626503;4048.1701251243426;4061.918761624766;3549.9172752310533;3564.41187204111;3564.8752293669595;3576.7675101118602;3582.301451217014;4986.825461108844;4995.426440671177;5014.297998280207;5024.67339622927;5054.444011158769;4541.613962813165;4554.043650833329;4559.521250268707;4562.4753153387455;4572.382728331666;5349.362433545188;5359.303290572239;5364;5367.838964831061;5413.918791218135;3683.650053244937;3827.502424684801;3839.865604703822;3840.135969406889;3874.4382064600477;5568.52667523261;5577.9163312550345;5589.608727389084;5593.216949627055;5613.214150019001;3928.175083232496;3934.055826601595;3953.446517487554;3968.797317488764;3969.1069509360163;3797.411401232813;3959.6436320731273;3973.2252210818615;4017.5781542938157;4020.979895100506;4549.475925564972;4559.635229181657;4570.794314255866;4574.794134263966;4585.197590421662;5436.374816896028;5441.700706461103;5445.782168713286;5459.3994660587305;5475.233467314579;1248.5380409248637;1284.5035533603434;1299.5581502289267;1361.4486133116104;1374.9037567370187;869.3653632848057;871.3421366867974;890.8040231149137;891.1445012787797;895.8611415230649;4682.84589089016;4687.414073240845;4692.498400511871;4700.109432698866;4703.506131856174;4897.510248975074;4904.5340692634145;4909.877253068702;4917.286993385939;4954.9009019819405;4496.065942300487;4656.720596764205;4663.417072865892;4676.719396836201;4696.694714843524;2570.3317137544;2628.172125780373;2629.961779620771;2630.842149471038;2632.7498887605648;5109.591232701375;5125.051865404912;5129.563722157802;5163.108659150887;5215.426303106655;5021.1923707465285;5038.571721403649;5043.092243396224;5045.369328833895;5303.7348132593215;5840.240768700041;5851.034579294454;5854.326752423441;5856.355800861902;5860.531157507389;5555.8888822224135;5580.38615752275;5583.944160558342;5591.832245032656;5661.065924122474;5455.763137113764;5551.417101204477;5586.38549759518;5600.891505214645;5607.41122182165;5842.130518234294;5852.561057920758;5853.326867410302;5856.975029369928;5872.354041055395;4045.8988525287104;4072.3077076896407;4074.6943979201087;4081.2449696806184;4089.6484521400907;5340.584745042489;5554.222408862682;5598.916016259678;5604.355499117653;5645.604807663424;5259.342582177228;5383;5406.810761623325;5422.945770542244;5439.48324909133;5429.294191755047;5462.170172991933;5493.23094766741;5506.669599824023;5515.255440515479;5267.236250743544;5430.294061771944;5450.400455949763;5492.945070549244;5502.477264659851;5459.235707001102;5480;5491.533219676372;5510.421405752339;5530.391656917816;5317.813876514303;5352.839414817562;5383.596230282823;5390.973045134906;5401.4868587484125 12:44:23 INFO - PROCESS | 8313 | |5;yui.html;662.5693299355419;685.5372623479153;699.7550857199977;725.2747252747251;777.6889244302279;14746.483873064431;15875.36498540057;15916.124613146272;15929.920350398246;15932;15125.394984200619;15161.54515364538;15188.696226075472;15196.772048419283;15231.08613483189;637.5664548107285;651.3421444341202;758.1281526244808;762.3063012658469;780.7618676303725;778.2723153851139;784.6978913118434;790.0124843945068;790.9723159689412;791.3827214772487;847.3729440214228;847.7075408983891;848.4485084694936;849.1254008371387;849.2484151525882;671.8018184635545;690.0408432279136;837.5100566168799;838.266516797805;838.6100463284572;507.2163507381105;507.88318686701894;583.1456915618639;598.3537779198455;603.1525706382539;13223.537176198786;13740.381682824196;13813.723725525533;13836.861631383657;13986.090904091201;13897.722045559032;14400.351984160738;14746.336414861356;14834.851651483455;14955.925220373829;13227.272500012496;13363;13501.59495215145;13696.52062177819;14205.715885682332;4490.8877278067985;4615.446146462413;4627.213373726441;4637.814487420499;4761.119192949315;79890.60054699748;80299.5985020077;80316.19683803145;81090.59454702689;83934.58032709858;11026.834597481044;11056.668299951014;11447.771044579062;11518.481668324945;11908.76182476363;22459.775402246094;22475.887620561793;22484.437889052577;22488.55022899533;22620;8326.209010144026;8399.874001889977;8431.662733490715;8449.408541402043;8678.392512524062;4493.483249426293;4571.839985600488;4634.026854360554;4669.836555720533;4910.926336104962;3424.8116353600294;3556.822158892045;3561.857525698943;3569.303985722759;3571.053670777246;598.2910251352162;602.9969850150721;606.7663949379432;619.510586636552;624.1605041219552;522.1932114882464;547.2393373211239;603.7253049862302;609.4575827513517;633.9746410143542;8731.694390696295;8762.255208307366;9013.684521041863;9089.181973622273;9103.499307538017;639.405353021685;653.5359894474976;657.5167252069725;666.2438132719302;706.4913262451028;4212.831486740557;4439.733615983051;4505.549445055468;4511.932321015187;4600.723956562617;113803;116763.41618291855;119140;120059.19911201339;123060;82706.58646706727;84409;84443;105890.47054764676;106214.46892765487;58513;65625;79768.60115699384;92521.5373923126;94206.52896735609;8002.639881205476;8002.879956800769;8493.853329800644;9429.434233945985;9476.810463790547;47838.76080619574;48112.5188748122;48733.756331219534;49530;49883.76685380527;75266.24733752593;76159.23840761521;76580.61709691415;77660.61169694115;78992.60503697675;12353.567625133077;12476.500939962663;12522.812157817822;12701.36493175356;13015.804762928754;13950;14501.20243386624;15165.165915874733;15316.310766015778;15430.151341676315;12508.312042837731;12793.936030319788;13662.248576328397;13792;13923.930380348034;12404.441800119197;12727.281816954963;12904.935475322563;13204.640112921603;14454.638634034232;13115.606531804062;13209.405576748877;13475;13556.93221533886;13680.863191367958;11441.542338306375;11630.825537617111;11807.468663910317;11813.173077884465;12036.338001410006;10522.842157367493;10547.261691681508;10770.497940846126;11240.83138752903;11404.82892756626 12:44:23 INFO - PROCESS | 8313 | __end_tp_report 12:44:23 INFO - PROCESS | 8313 | __start_cc_report 12:44:23 INFO - PROCESS | 8313 | _x_x_mozilla_cycle_collect,1409 12:44:23 INFO - PROCESS | 8313 | __end_cc_report 12:44:23 INFO - PROCESS | 8313 | __startTimestamp1475610263280__endTimestamp 12:44:23 INFO - PROCESS | 8313 | 12:44:23 INFO - PROCESS | 8313 | ------- Summary: start ------- 12:44:23 INFO - PROCESS | 8313 | Number of tests: 6 12:44:23 INFO - PROCESS | 8313 | 12:44:23 INFO - PROCESS | 8313 | [#0] dojo.html Cycles:165 Average:5124.27 Median:5341.89 stddev:569.68 (10.7%) stddev-sans-first:543.82 12:44:23 INFO - PROCESS | 8313 | Values: 2890.9 2920.7 2926.9 2971.0 2974.7 4943.0 5056.9 5083.6 5086.2 5139.4 5087.9 5122.9 5169.2 5196.8 5205.0 4607.2 4611.1 4623.5 4644.9 4788.3 4795.4 4843.4 4850.5 4872.8 4874.7 4663.6 4707.8 4760.8 4819.9 4834.7 4685.4 4752.1 4755.0 4769.7 4827.3 4722.6 4741.3 4743.9 4749.4 4769.5 5205.2 5222.6 5226.2 5229.4 5278.3 5344.7 5385.9 5386.9 5463.6 5483.8 5483.8 5485.4 5491.3 5492.9 5493.6 5069.2 5098.4 5103.6 5106.5 5137.5 5572.8 5616.2 5616.6 5667.0 5682.3 5391.1 5397.6 5399.2 5401.1 5401.6 5381.8 5421.0 5453.9 5461.5 5533.6 5348.8 5402.7 5450.6 5487.7 5548.5 5465.2 5472.0 5477.8 5482.9 5542.5 4225.8 4265.0 4270.8 4280.0 4324.0 3776.7 3806.3 3811.9 3819.1 3843.4 5257.9 5271.3 5272.6 5273.5 5327.7 5538.2 5541.3 5546.3 5549.1 5549.1 5073.7 5118.7 5150.1 5171.3 5196.9 4756.0 4756.6 4758.0 4796.2 4803.3 5665.4 5700.3 5710.9 5713.3 5741.2 5396.8 5399.0 5450.5 5496.8 5505.3 5692.9 5735.3 5765.9 5840.6 5844.6 5398.6 5445.9 5446.2 5465.6 5473.3 5504.2 5512.2 5514.4 5533.2 5571.0 5228.0 5247.3 5306.1 5317.7 5341.9 5315.1 5359.1 5359.5 5368.9 5412.9 5375.1 5377.8 5381.2 5386.1 5444.7 5305.0 5335.5 5375.2 5383.3 5398.9 5361.8 5363.7 5406.3 5419.5 5426.3 12:44:23 INFO - PROCESS | 8313 | 12:44:23 INFO - PROCESS | 8313 | [#1] ext.html Cycles:180 Average:51636.53 Median:202970.91 stddev:106463.19 (52.5%) stddev-sans-first:106692.77 12:44:23 INFO - PROCESS | 8313 | Values: 556.8 581.3 599.6 606.0 607.7 31396.8 41454.8 42249.6 42261.4 42315.2 43349.6 43503.3 43584.1 43859.1 43913.3 7894.8 8086.7 8818.0 8984.7 8986.5 10457.6 10712.8 10723.5 11094.9 11114.6 8138.7 8169.0 8174.7 8176.6 8184.0 10709.4 10786.0 10794.4 10796.2 10800.9 10630.4 10706.3 10706.8 10708.1 10712.8 41997.4 42310.6 42331.4 42368.0 42454.8 3327.8 3336.8 3356.1 3389.9 3450.4 29946.0 32266.7 32334.5 32433.4 34041.7 4366.2 4382.2 4397.9 4477.4 4516.6 134630.0 135933.0 135941.0 136165.3 136301.0 58863.4 59223.7 59268.0 59378.7 59412.0 34804.7 35595.0 35725.8 38286.2 38481.4 17028.1 17238.7 17239.4 17242.8 17250.7 11782.7 12082.9 12826.3 13118.2 13189.3 18771.4 18801.6 18841.7 18879.3 18984.4 6984.9 7080.9 7110.5 7147.4 7175.5 907.5 949.4 966.3 1038.9 1126.3 31119.5 31192.4 31461.7 31500.8 31574.2 1027.7 1049.2 1105.0 1114.2 1196.4 15735.8 16472.3 16624.2 16633.3 16729.2 555468.0 563658.0 564813.0 564915.0 566188.0 38838.8 38857.0 38960.6 39022.4 39216.0 1189.9 1231.6 1312.8 1339.0 1344.2 28065.9 31364.2 31760.5 31973.2 32537.0 47521.8 48100.3 48134.0 48178.5 48196.2 370216.0 371964.0 372202.0 372366.0 373271.0 27504.6 28152.4 28348.4 28481.9 29885.0 44549.0 44668.8 44898.0 45871.5 46598.0 38258.8 38489.8 39096.4 39724.0 40168.0 37999.0 38528.4 38910.0 39980.4 40250.4 37551.8 37708.0 37735.8 37820.2 38829.0 33351.8 34709.5 35112.0 35587.6 35643.3 26416.9 26805.1 26865.5 26974.7 27193.7 12:44:23 INFO - PROCESS | 8313 | 12:44:23 INFO - PROCESS | 8313 | [#2] jquery.html Cycles:180 Average:26753.47 Median:2779.66 stddev:68930.48 (2479.8%) stddev-sans-first:69095.36 12:44:23 INFO - PROCESS | 8313 | Values: 360.8 374.2 404.6 405.6 416.5 13745.5 18970.1 19124.5 19761.0 19888.3 18426.0 18645.3 18975.8 19160.9 19163.5 5553.5 5838.4 5851.1 5854.4 5855.8 5652.5 5654.4 5685.6 5687.9 5707.7 5674.7 5678.0 5682.2 5684.9 5687.4 5443.4 5544.4 5573.1 5579.5 5668.1 4959.4 4967.3 4969.0 4970.5 4972.6 22539.7 22840.4 22975.7 23058.9 23179.9 2347.0 2407.6 2465.8 2711.3 2848.0 14027.6 14531.6 14596.6 14800.3 15159.1 1908.9 1909.2 1913.6 1927.0 2023.9 82468.0 86043.0 86144.0 87117.0 89860.6 10418.0 10471.5 10593.7 10873.2 10928.6 15111.5 15197.3 15198.1 15222.5 15243.2 7597.7 7739.5 7781.5 7970.6 8027.1 7627.6 7677.3 7775.0 7843.3 8178.9 6418.5 6433.2 6490.8 6597.7 6694.5 1940.2 1945.5 1959.9 1969.4 1972.9 865.8 950.7 982.7 992.0 1020.1 19263.8 19649.5 19857.1 19874.4 19968.0 953.2 965.2 984.4 1073.2 1089.7 10481.3 11119.9 11127.3 11382.3 11387.3 410197.0 413025.0 417010.0 417228.0 425207.0 77491.0 78789.0 80689.6 84486.6 84757.6 977.4 1012.4 1045.2 1046.0 1053.1 16508.3 16772.7 17327.0 17727.7 17897.7 39562.8 40554.8 40863.8 40895.0 42044.0 51509.5 52922.0 53228.2 53631.0 54143.2 8087.5 8237.6 8496.2 8570.9 8705.0 12752.5 13480.6 13501.7 13664.3 13755.9 11251.4 11402.5 11654.4 11770.5 12166.3 11590.8 11612.9 11724.9 11786.8 12114.5 11520.6 11583.3 11690.3 11865.9 12312.8 7569.0 7924.7 8602.8 8716.5 8786.4 11055.1 11308.8 11367.3 11390.4 12090.6 12:44:23 INFO - PROCESS | 8313 | 12:44:23 INFO - PROCESS | 8313 | [#3] mootools.html Cycles:180 Average:5902.20 Median:2435.13 stddev:3516.53 (144.4%) stddev-sans-first:3509.65 12:44:23 INFO - PROCESS | 8313 | Values: 1335.7 1464.6 1483.0 1612.9 1772.3 8025.9 8764.8 9222.9 9234.5 9508.9 9298.1 9380.7 9386.9 9389.5 9400.2 2307.1 2309.6 2322.6 2329.9 2344.1 2267.0 2283.4 2298.3 2320.9 2321.2 2230.7 2250.0 2262.0 2290.2 2304.4 2215.4 2236.8 2243.9 2250.8 2263.4 2183.3 2212.8 2224.4 2229.6 2238.2 8983.1 9042.5 9054.8 9197.9 9536.0 4986.1 5051.1 5077.8 5095.1 5103.7 3227.5 3331.2 3387.7 3416.5 3436.7 1090.4 1128.3 1137.9 1157.8 1161.8 12769.9 12879.1 12917.7 13026.4 13043.4 4180.4 4348.2 4426.7 4460.9 4494.0 10098.8 10125.6 10128.9 10129.8 10134.2 5152.9 5155.8 5158.1 5158.4 5161.8 4041.2 4276.8 4367.0 4418.2 4842.8 3366.4 3673.4 3684.9 3703.0 3757.3 1060.4 1090.8 1100.6 1109.7 1116.4 961.2 965.2 965.6 967.2 977.5 5987.6 6030.3 6044.9 6111.8 6153.0 443.6 444.6 445.2 453.2 455.7 4292.3 4304.3 4312.3 4343.3 4358.2 11294.7 11627.0 11704.8 11715.6 11742.1 10863.8 11397.2 11408.7 11657.1 11802.2 8439.7 8637.8 8650.3 8652.0 8652.4 6087.7 6156.2 6271.4 6290.5 6397.2 10601.7 10776.2 10781.7 10925.9 10937.2 9521.7 10095.8 10635.8 10655.8 11039.4 7443.4 8086.1 8310.9 8311.3 8313.9 8636.4 8690.4 8715.8 8950.3 8969.5 7718.5 7734.9 7896.4 7925.6 8019.2 7465.3 7690.9 7798.0 7814.3 7920.5 6960.9 7056.2 7105.9 7128.0 7141.1 4980.3 5123.4 5175.1 5183.3 5199.0 5116.1 5168.7 5256.9 5322.1 5445.8 12:44:23 INFO - PROCESS | 8313 | 12:44:23 INFO - PROCESS | 8313 | [#4] prototype.html Cycles:180 Average:4487.45 Median:5022.93 stddev:1333.09 (26.5%) stddev-sans-first:1299.38 12:44:23 INFO - PROCESS | 8313 | Values: 306.9 309.2 321.5 323.3 323.5 4987.2 5134.1 5184.9 5197.6 5206.9 5004.8 5109.5 5121.3 5126.2 5150.8 4082.3 4088.2 4103.0 4109.4 4119.1 3837.0 3862.2 4104.4 4113.9 4116.5 4042.3 4046.8 4048.6 4052.9 4067.7 4035.1 4044.2 4046.7 4048.2 4061.9 3549.9 3564.4 3564.9 3576.8 3582.3 4986.8 4995.4 5014.3 5024.7 5054.4 4541.6 4554.0 4559.5 4562.5 4572.4 5349.4 5359.3 5364.0 5367.8 5413.9 3683.7 3827.5 3839.9 3840.1 3874.4 5568.5 5577.9 5589.6 5593.2 5613.2 3928.2 3934.1 3953.4 3968.8 3969.1 3797.4 3959.6 3973.2 4017.6 4021.0 4549.5 4559.6 4570.8 4574.8 4585.2 5436.4 5441.7 5445.8 5459.4 5475.2 1248.5 1284.5 1299.6 1361.4 1374.9 869.4 871.3 890.8 891.1 895.9 4682.8 4687.4 4692.5 4700.1 4703.5 4897.5 4904.5 4909.9 4917.3 4954.9 4496.1 4656.7 4663.4 4676.7 4696.7 2570.3 2628.2 2630.0 2630.8 2632.7 5109.6 5125.1 5129.6 5163.1 5215.4 5021.2 5038.6 5043.1 5045.4 5303.7 5840.2 5851.0 5854.3 5856.4 5860.5 5555.9 5580.4 5583.9 5591.8 5661.1 5455.8 5551.4 5586.4 5600.9 5607.4 5842.1 5852.6 5853.3 5857.0 5872.4 4045.9 4072.3 4074.7 4081.2 4089.6 5340.6 5554.2 5598.9 5604.4 5645.6 5259.3 5383.0 5406.8 5422.9 5439.5 5429.3 5462.2 5493.2 5506.7 5515.3 5267.2 5430.3 5450.4 5492.9 5502.5 5459.2 5480.0 5491.5 5510.4 5530.4 5317.8 5352.8 5383.6 5391.0 5401.5 12:44:23 INFO - PROCESS | 8313 | 12:44:23 INFO - PROCESS | 8313 | [#5] yui.html Cycles:180 Average:20626.34 Median:4621.33 stddev:29819.84 (645.3%) stddev-sans-first:29865.81 12:44:23 INFO - PROCESS | 8313 | Values: 662.6 685.5 699.8 725.3 777.7 14746.5 15875.4 15916.1 15929.9 15932.0 15125.4 15161.5 15188.7 15196.8 15231.1 637.6 651.3 758.1 762.3 780.8 778.3 784.7 790.0 791.0 791.4 847.4 847.7 848.4 849.1 849.2 671.8 690.0 837.5 838.3 838.6 507.2 507.9 583.1 598.4 603.2 13223.5 13740.4 13813.7 13836.9 13986.1 13897.7 14400.4 14746.3 14834.9 14955.9 13227.3 13363.0 13501.6 13696.5 14205.7 4490.9 4615.4 4627.2 4637.8 4761.1 79890.6 80299.6 80316.2 81090.6 83934.6 11026.8 11056.7 11447.8 11518.5 11908.8 22459.8 22475.9 22484.4 22488.6 22620.0 8326.2 8399.9 8431.7 8449.4 8678.4 4493.5 4571.8 4634.0 4669.8 4910.9 3424.8 3556.8 3561.9 3569.3 3571.1 598.3 603.0 606.8 619.5 624.2 522.2 547.2 603.7 609.5 634.0 8731.7 8762.3 9013.7 9089.2 9103.5 639.4 653.5 657.5 666.2 706.5 4212.8 4439.7 4505.5 4511.9 4600.7 113803.0 116763.4 119140.0 120059.2 123060.0 82706.6 84409.0 84443.0 105890.5 106214.5 58513.0 65625.0 79768.6 92521.5 94206.5 8002.6 8002.9 8493.9 9429.4 9476.8 47838.8 48112.5 48733.8 49530.0 49883.8 75266.2 76159.2 76580.6 77660.6 78992.6 12353.6 12476.5 12522.8 12701.4 13015.8 13950.0 14501.2 15165.2 15316.3 15430.2 12508.3 12793.9 13662.2 13792.0 13923.9 12404.4 12727.3 12904.9 13204.6 14454.6 13115.6 13209.4 13475.0 13556.9 13680.9 11441.5 11630.8 11807.5 11813.2 12036.3 10522.8 10547.3 10770.5 11240.8 11404.8 12:44:23 INFO - PROCESS | 8313 | -------- Summary: end -------- 12:44:23 INFO - PROCESS | 8313 | 12:44:24 INFO - TEST-INFO | 8313: exit 0 12:44:24 INFO - TEST-OK | dromaeo_css | took 1117449ms 12:44:24 INFO - TEST-START | kraken 12:44:24 INFO - operating with platform_type : linux_ 12:44:24 INFO - Initialising browser for kraken test... 12:44:24 INFO - TEST-INFO | started process 8624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplSYWj9/profile http://localhost:53884/getInfo.html) 12:44:28 INFO - PROCESS | 8624 | __metrics Screen width/height:1600/1200 12:44:28 INFO - PROCESS | 8624 | colorDepth:24 12:44:28 INFO - PROCESS | 8624 | Browser inner width/height: 1024/697 12:44:28 INFO - PROCESS | 8624 | __metrics 12:44:29 INFO - PROCESS | 8624 | 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" 12:44:29 INFO - PROCESS | 8624 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:44:29 INFO - PROCESS | 8624 | console.error: PushService: 12:44:29 INFO - PROCESS | 8624 | stateChangeProcessEnqueue: Error transitioning state 12:44:29 INFO - PROCESS | 8624 | UnknownError 12:44:30 INFO - TEST-INFO | 8624: exit 0 12:44:30 INFO - Browser initialized. 12:44:30 INFO - Running cycle 1/1 for kraken test... 12:44:30 INFO - TEST-INFO | started process 8704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplSYWj9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:44:42 INFO - PROCESS | 8704 | RSS: Main: 173686784 12:44:42 INFO - PROCESS | 8704 | 12:44:45 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53884/tests/kraken/driver.html?testName=audio-beat-detection) 12:44:46 INFO - PROCESS | 8704 | RSS: Main: 233422848 12:44:46 INFO - PROCESS | 8704 | 12:44:48 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53884/tests/kraken/driver.html?testName=audio-dft) 12:44:49 INFO - PROCESS | 8704 | RSS: Main: 217903104 12:44:49 INFO - PROCESS | 8704 | 12:44:52 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53884/tests/kraken/driver.html?testName=audio-fft) 12:44:52 INFO - PROCESS | 8704 | RSS: Main: 299732992 12:44:52 INFO - PROCESS | 8704 | 12:44:55 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53884/tests/kraken/driver.html?testName=audio-oscillator) 12:44:55 INFO - PROCESS | 8704 | RSS: Main: 208257024 12:44:55 INFO - PROCESS | 8704 | 12:44:57 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53884/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:44:58 INFO - PROCESS | 8704 | RSS: Main: 214011904 12:44:58 INFO - PROCESS | 8704 | 12:45:01 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53884/tests/kraken/driver.html?testName=imaging-darkroom) 12:45:02 INFO - PROCESS | 8704 | RSS: Main: 250245120 12:45:02 INFO - PROCESS | 8704 | 12:45:05 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53884/tests/kraken/driver.html?testName=imaging-desaturate) 12:45:05 INFO - PROCESS | 8704 | RSS: Main: 249024512 12:45:05 INFO - PROCESS | 8704 | 12:45:08 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53884/tests/kraken/driver.html?testName=json-parse-financial) 12:45:09 INFO - PROCESS | 8704 | RSS: Main: 248344576 12:45:09 INFO - PROCESS | 8704 | 12:45:10 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53884/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:45:11 INFO - PROCESS | 8704 | RSS: Main: 210767872 12:45:11 INFO - PROCESS | 8704 | 12:45:13 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53884/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:45:13 INFO - PROCESS | 8704 | RSS: Main: 218349568 12:45:13 INFO - PROCESS | 8704 | 12:45:15 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53884/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:45:16 INFO - PROCESS | 8704 | RSS: Main: 227414016 12:45:16 INFO - PROCESS | 8704 | 12:45:19 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53884/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:45:19 INFO - PROCESS | 8704 | RSS: Main: 236232704 12:45:19 INFO - PROCESS | 8704 | 12:45:22 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53884/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:45:23 INFO - PROCESS | 8704 | RSS: Main: 233967616 12:45:23 INFO - PROCESS | 8704 | 12:45:24 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53884/tests/kraken/driver.html?testName=ai-astar) 12:45:25 INFO - PROCESS | 8704 | RSS: Main: 283672576 12:45:25 INFO - PROCESS | 8704 | 12:45:25 INFO - PROCESS | 8704 | __start_tp_report 12:45:25 INFO - PROCESS | 8704 | _x_x_mozilla_page_load 12:45:25 INFO - PROCESS | 8704 | _x_x_mozilla_page_load_details 12:45:25 INFO - PROCESS | 8704 | |i|pagename|runs| 12:45:25 INFO - PROCESS | 8704 | |0;ai-astar;112;113;113;113;115;112;112;114;112;112 12:45:25 INFO - PROCESS | 8704 | |1;audio-beat-detection;146;128;124;161;128;124;126;120;159;130 12:45:25 INFO - PROCESS | 8704 | |2;audio-dft;160;160;161;160;160;162;160;161;160;159 12:45:25 INFO - PROCESS | 8704 | |3;audio-fft;75;74;76;112;77;77;76;75;103;75 12:45:25 INFO - PROCESS | 8704 | |4;audio-oscillator;84;82;113;83;83;82;104;83;82;113 12:45:25 INFO - PROCESS | 8704 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;117;117;117 12:45:25 INFO - PROCESS | 8704 | |6;imaging-darkroom;145;146;145;145;145;146;145;146;146;146 12:45:25 INFO - PROCESS | 8704 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;96;95 12:45:25 INFO - PROCESS | 8704 | |8;json-parse-financial;53;52;52;52;51;53;53;53;53;52 12:45:25 INFO - PROCESS | 8704 | |9;json-stringify-tinderbox;61;62;61;61;61;61;62;62;61;62 12:45:25 INFO - PROCESS | 8704 | |10;stanford-crypto-aes;80;89;83;82;80;80;82;83;79;80 12:45:25 INFO - PROCESS | 8704 | |11;stanford-crypto-ccm;135;131;131;133;134;129;146;131;172;141 12:45:25 INFO - PROCESS | 8704 | |12;stanford-crypto-pbkdf2;174;172;167;175;172;173;172;167;171;166 12:45:25 INFO - PROCESS | 8704 | |13;stanford-crypto-sha256-iterative;68;66;66;67;67;68;65;66;65;65 12:45:25 INFO - PROCESS | 8704 | __end_tp_report 12:45:25 INFO - PROCESS | 8704 | __start_cc_report 12:45:25 INFO - PROCESS | 8704 | _x_x_mozilla_cycle_collect,1634 12:45:25 INFO - PROCESS | 8704 | __end_cc_report 12:45:25 INFO - PROCESS | 8704 | __startTimestamp1475610325157__endTimestamp 12:45:25 INFO - PROCESS | 8704 | 12:45:25 INFO - PROCESS | 8704 | ------- Summary: start ------- 12:45:25 INFO - PROCESS | 8704 | Number of tests: 14 12:45:25 INFO - PROCESS | 8704 | 12:45:25 INFO - PROCESS | 8704 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:1.03 (0.9%) stddev-sans-first:1.05 12:45:25 INFO - PROCESS | 8704 | Values: 112.0 113.0 113.0 113.0 115.0 112.0 112.0 114.0 112.0 112.0 12:45:25 INFO - PROCESS | 8704 | 12:45:25 INFO - PROCESS | 8704 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:129.00 stddev:15.06 (11.7%) stddev-sans-first:15.40 12:45:25 INFO - PROCESS | 8704 | Values: 146.0 128.0 124.0 161.0 128.0 124.0 126.0 120.0 159.0 130.0 12:45:25 INFO - PROCESS | 8704 | 12:45:25 INFO - PROCESS | 8704 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 12:45:25 INFO - PROCESS | 8704 | Values: 160.0 160.0 161.0 160.0 160.0 162.0 160.0 161.0 160.0 159.0 12:45:25 INFO - PROCESS | 8704 | 12:45:25 INFO - PROCESS | 8704 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.50 stddev:13.64 (18.1%) stddev-sans-first:14.23 12:45:25 INFO - PROCESS | 8704 | Values: 75.0 74.0 76.0 112.0 77.0 77.0 76.0 75.0 103.0 75.0 12:45:25 INFO - PROCESS | 8704 | 12:45:25 INFO - PROCESS | 8704 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:82.50 stddev:13.42 (16.3%) stddev-sans-first:14.00 12:45:25 INFO - PROCESS | 8704 | Values: 84.0 82.0 113.0 83.0 83.0 82.0 104.0 83.0 82.0 113.0 12:45:25 INFO - PROCESS | 8704 | 12:45:25 INFO - PROCESS | 8704 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:45:25 INFO - PROCESS | 8704 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 12:45:25 INFO - PROCESS | 8704 | 12:45:25 INFO - PROCESS | 8704 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 12:45:25 INFO - PROCESS | 8704 | Values: 145.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 146.0 146.0 12:45:25 INFO - PROCESS | 8704 | 12:45:25 INFO - PROCESS | 8704 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 12:45:25 INFO - PROCESS | 8704 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 12:45:25 INFO - PROCESS | 8704 | 12:45:25 INFO - PROCESS | 8704 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:53.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 12:45:25 INFO - PROCESS | 8704 | Values: 53.0 52.0 52.0 52.0 51.0 53.0 53.0 53.0 53.0 52.0 12:45:25 INFO - PROCESS | 8704 | 12:45:25 INFO - PROCESS | 8704 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 12:45:25 INFO - PROCESS | 8704 | Values: 61.0 62.0 61.0 61.0 61.0 61.0 62.0 62.0 61.0 62.0 12:45:25 INFO - PROCESS | 8704 | 12:45:25 INFO - PROCESS | 8704 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:2.90 (3.5%) stddev-sans-first:3.00 12:45:25 INFO - PROCESS | 8704 | Values: 80.0 89.0 83.0 82.0 80.0 80.0 82.0 83.0 79.0 80.0 12:45:25 INFO - PROCESS | 8704 | 12:45:25 INFO - PROCESS | 8704 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:134.50 stddev:12.94 (9.6%) stddev-sans-first:13.67 12:45:25 INFO - PROCESS | 8704 | Values: 135.0 131.0 131.0 133.0 134.0 129.0 146.0 131.0 172.0 141.0 12:45:25 INFO - PROCESS | 8704 | 12:45:25 INFO - PROCESS | 8704 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:172.00 stddev:3.14 (1.8%) stddev-sans-first:3.13 12:45:25 INFO - PROCESS | 8704 | Values: 174.0 172.0 167.0 175.0 172.0 173.0 172.0 167.0 171.0 166.0 12:45:25 INFO - PROCESS | 8704 | 12:45:25 INFO - PROCESS | 8704 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.16 (1.7%) stddev-sans-first:1.05 12:45:25 INFO - PROCESS | 8704 | Values: 68.0 66.0 66.0 67.0 67.0 68.0 65.0 66.0 65.0 65.0 12:45:25 INFO - PROCESS | 8704 | -------- Summary: end -------- 12:45:25 INFO - PROCESS | 8704 | 12:45:26 INFO - TEST-INFO | 8704: exit 0 12:45:26 INFO - TEST-OK | kraken | took 62183ms 12:45:26 INFO - SUITE-END | took 1179s 12:45:26 INFO - Completed test suite (00:19:40) 12:45:26 INFO - javascript benchmark 12:45:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2890.913272601822, 2920.7371336579704, 2926.8975585854487, 2971.0344138155106, 2974.7025297470254, 4943.0, 5056.938043010972, 5083.5933125349975, 5086.160783470727, 5139.357580302462, 5087.949120508793, 5122.948770512294, 5169.224616307556, 5196.766145523451, 5205.011047900896, 4607.17070927233, 4611.123886461562, 4623.537646235383, 4644.883877903046, 4788.257820037899, 4795.448523419816, 4843.39457567804, 4850.53919877611, 4872.829450969217, 4874.683145595543, 4663.556962088596, 4707.835225767116, 4760.809567617292, 4819.903601927959, 4834.661573689861, 4685.4377474702915, 4752.097101550728, 4754.952450475485, 4769.689970151963, 4827.25177597473, 4722.574968252839, 4741.288806678991, 4743.881402964919, 4749.430068391781, 4769.499202583714, 5205.193195054772, 5222.63441559091, 5226.189940559219, 5229.398619158807, 5278.340207474066, 5344.732763361816, 5385.892282154374, 5386.892262154735, 5463.590230732711, 5483.75323110461, 5483.7806487740445, 5485.369182544018, 5491.28613280271, 5492.917606235909, 5493.615446918678, 5069.163588007974, 5098.362704661918, 5103.566196873233, 5106.4638212987475, 5137.51193636604, 5572.777088916398, 5616.185653080281, 5616.6068375213345, 5667.0, 5682.289713785777, 5391.110466772939, 5397.622166448311, 5399.217113518518, 5401.108817045222, 5401.648892822032, 5381.784728610812, 5421.0, 5453.863653408617, 5461.481159289861, 5533.612647114744, 5348.812791552355, 5402.675839449567, 5450.5639548836, 5487.6981766002455, 5548.528375088163, 5465.152901300305, 5472.042392581362, 5477.808276710296, 5482.890342193134, 5542.528885044736, 4225.788710564521, 4264.978675106605, 4270.765107919095, 4279.957200428018, 4323.978380108079, 3776.735628505978, 3806.2958352704836, 3811.866584669523, 3819.102510909934, 3843.404272337792, 5257.868553286198, 5271.288376069258, 5272.578193744491, 5273.499017593323, 5327.733613319396, 5538.16927460876, 5541.251930989265, 5546.306711661043, 5549.084401073858, 5549.139883318092, 5073.670211436245, 5118.667286626432, 5150.098732721759, 5171.301874247004, 5196.92204616931, 4755.95244047562, 4756.5956893664425, 4758.0, 4796.184648609745, 4803.255495398219, 5665.376808550974, 5700.344460387026, 5710.942890571041, 5713.314402271754, 5741.196232527366, 5396.78412863481, 5398.973005134949, 5450.482204190595, 5496.780128794803, 5505.284313039279, 5692.943070569241, 5735.25441692594, 5765.884682306414, 5840.591158618856, 5844.561657875592, 5398.568114550905, 5445.945540544544, 5446.237526746179, 5465.59008074388, 5473.288472498709, 5504.22940788282, 5512.228288039598, 5514.420985796433, 5533.197686335539, 5570.972145139248, 5227.973860130675, 5247.291615631841, 5306.097963346318, 5317.7341132943975, 5341.893162136813, 5315.123004704181, 5359.14253719403, 5359.490848369399, 5368.892622147613, 5412.8646783829145, 5375.1131063374105, 5377.811776587957, 5381.165919282517, 5386.057439947915, 5444.700541470257, 5305.045091883498, 5335.519803217729, 5375.247465354775, 5383.273258110262, 5398.892022159456, 5361.758720857492, 5363.651362661414, 5406.297181366397, 5419.458054194549, 5426.348838139448], "value": 5086.007457204816, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.8494397960453, 581.299534061456, 599.5653151465189, 606.0485038489571, 607.7325976570312, 31396.843015784918, 41454.7927260364, 42249.57750422495, 42261.366079508756, 42315.15369692604, 43349.56650433494, 43503.34744978828, 43584.128317433635, 43859.12281754363, 43913.34129988053, 7894.763157105296, 8086.676532938704, 8817.95591022044, 8984.730458086235, 8986.460812351279, 10457.58169673212, 10712.78574428511, 10723.463826808667, 11094.889051109507, 11114.6109886154, 8138.715144969928, 8169.0, 8174.6730130794695, 8176.591170441484, 8184.0, 10709.410982395964, 10786.0, 10794.352338859693, 10796.2442629016, 10800.945995270013, 10630.362178269328, 10706.250562460631, 10706.78586428267, 10708.1433485321, 10712.78574428515, 41997.37003944943, 42310.57689423097, 42331.36502952458, 42368.0, 42454.787726061484, 3327.750418718606, 3336.7664263501565, 3356.127406874206, 3389.9491507627404, 3450.430678937972, 29946.0, 32266.677333226602, 32334.514982275286, 32433.43232244451, 34041.6595834041, 4366.235908715962, 4382.189294980439, 4397.934030989538, 4477.417935668343, 4516.616087632555, 134630.0, 135933.0, 135941.0, 136165.31917340448, 136301.0, 58863.41136588665, 59223.70388148118, 59267.999999999134, 59378.70310648505, 59412.0, 34804.65195348065, 35595.0, 35725.821370892976, 38286.23427531434, 38481.42277865834, 17028.148592570324, 17238.741418878726, 17239.396621118452, 17242.827571724374, 17250.65498690044, 11782.705432364088, 12082.939585302192, 12826.294553799444, 13118.212907225598, 13189.340532973312, 18771.436856894314, 18801.623967520845, 18841.717374239397, 18879.339223127125, 18984.43046708601, 6984.930150698428, 7080.857014433443, 7110.484842125287, 7147.392471639865, 7175.533590316717, 907.5235501361838, 949.4398305000083, 966.2511553546058, 1038.89611038897, 1126.3129491010477, 31119.533207001914, 31192.376152477278, 31461.685383146334, 31500.80516903597, 31574.210644733605, 1027.6505987964129, 1049.2445439283704, 1104.9889501104885, 1114.1977776001265, 1196.4137572589543, 15735.763963540556, 16472.341106355612, 16624.168791560616, 16633.25150368212, 16729.247183876756, 555468.0, 563658.0, 564813.0, 564915.0, 566188.0, 38838.80580597135, 38857.0, 38960.61039389626, 39022.414663780066, 39216.0, 1189.8815113793007, 1231.6058861164342, 1312.7505773902737, 1338.9732205356033, 1344.1867670059669, 28065.859670701517, 31364.215894602818, 31760.523592146597, 31973.20066998344, 32537.0, 47521.762391187825, 48100.27849582329, 48134.0, 48178.518214817406, 48196.18038196152, 370216.0, 371964.0, 372202.0, 372366.0, 373271.0, 27504.58743118895, 28152.43695126127, 28348.43303133967, 28481.857590711912, 29885.0, 44549.0, 44668.776656117814, 44898.0, 45871.541284586725, 46598.0, 38258.80870595629, 38489.80889189046, 39096.41355379728, 39724.0, 40168.0, 37999.0, 38528.42207366836, 38910.0, 39980.400293996194, 40250.39624405577, 37551.81224093971, 37708.0, 37735.81132094322, 37820.24359512849, 38829.0, 33351.83324083364, 34709.47935780915, 35112.0, 35587.644123558435, 35643.28713425769, 26416.8679156603, 26805.11325857779, 26865.462690746466, 26974.667649930674, 27193.72806271912], "value": 18942.462092350765, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.79434722208333, 374.1936127644926, 404.64593480704383, 405.5640186799192, 416.4523651398411, 13745.45018199272, 18970.146343414544, 19124.521886952833, 19761.0, 19888.303909363174, 18426.0, 18645.347412840554, 18975.810241897576, 19160.904195479005, 19163.520911977208, 5553.4724201200825, 5838.386969368219, 5851.093080572518, 5854.356020837705, 5855.765769369242, 5652.547796176296, 5654.406287339832, 5685.602007859451, 5687.914681279784, 5707.686077265748, 5674.716264186794, 5677.9716101419435, 5682.232898558704, 5684.914726279109, 5687.374388817227, 5443.401225865172, 5544.390117087117, 5573.136163894583, 5579.469950354751, 5668.093105103184, 4959.355283813081, 4967.254911763228, 4968.975155124202, 4970.453250142481, 4972.602191824645, 22539.661905071436, 22840.428989275235, 22975.655365169536, 23058.884705576365, 23179.870717453265, 2346.9647955280516, 2407.590709579376, 2465.815063870199, 2711.3086163028497, 2848.017433985272, 14027.649308767363, 14531.636709082251, 14596.562103136817, 14800.259987000714, 15159.09045457276, 1908.8568357373113, 1909.217220939422, 1913.5598812273115, 1926.9614607707767, 2023.929162479321, 82468.0, 86043.0, 86144.0, 87117.0, 89860.55069724676, 10418.030861204521, 10471.47642617866, 10593.675790526184, 10873.184511161695, 10928.617498387519, 15111.54665360041, 15197.31612077437, 15198.088114713153, 15222.543323700307, 15243.23783810805, 7597.734079307198, 7739.496932699469, 7781.494202876795, 7970.6413211405625, 8027.117017128111, 7627.618619069024, 7677.309042186118, 7774.961125194338, 7843.294103530709, 8178.906714497737, 6418.518611104186, 6433.228012638513, 6490.825573432859, 6597.703103360361, 6694.464442844561, 1940.185122248659, 1945.4844466216464, 1959.913580185301, 1969.3796454117194, 1972.9185709076776, 865.7619154732373, 950.7195377363694, 982.7297493189287, 992.0129471176226, 1020.0513522424217, 19263.8073619262, 19649.508762281057, 19857.106430210388, 19874.403767886986, 19968.0, 953.2421724728857, 965.2374624047064, 984.4339504784778, 1073.2111897755144, 1089.6948854320804, 10481.266311358284, 11119.944400277947, 11127.326522860418, 11382.260153090188, 11387.259828111311, 410197.0, 413025.0, 417010.0, 417228.0, 425207.0, 77491.0, 78789.0, 80689.59655201687, 84486.577567113, 84757.57621211854, 977.3940157102784, 1012.427978192319, 1045.2421994054403, 1045.9633912813015, 1053.115383078218, 16508.33966641321, 16772.664546709242, 17327.0, 17727.73408398901, 17897.73153402726, 39562.80218598888, 40554.79722601368, 40863.7956810214, 40895.0, 42044.0, 51509.48490515197, 52922.0, 53228.20157697715, 53631.0, 54143.18785218146, 8087.47431416956, 8237.588120594066, 8496.192861678132, 8570.914290857261, 8705.0, 12752.48990040388, 13480.595582132551, 13501.662458438617, 13664.316784160554, 13755.931220343835, 11251.38117403518, 11402.543898244308, 11654.359010254517, 11770.52917883275, 12166.270023798601, 11590.826137608112, 11612.941935290608, 11724.941375293069, 11786.823197652213, 12114.454849531969, 11520.596779112691, 11583.305001699924, 11690.298582085103, 11865.940670296593, 12312.753744924872, 7569.0, 7924.7018364673595, 8602.827943441222, 8716.520591367536, 8786.428882122642, 11055.115590752559, 11308.7738245233, 11367.317960922372, 11390.430478475877, 12090.637280881587], "value": 9254.325774109577, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.6994676197862, 1464.611877852369, 1483.0, 1612.9032258064517, 1772.3353742346612, 8025.91974080259, 8764.824703505927, 9222.90777092229, 9234.538273086344, 9508.857367139499, 9298.070192980698, 9380.71857844264, 9386.85919711205, 9389.483578403186, 9400.20098291646, 2307.1348244408346, 2309.6304591265402, 2322.5587138443725, 2329.9417514562188, 2344.132670911765, 2266.9659955100688, 2283.3834864586634, 2298.276043046435, 2320.860748355104, 2321.2455951815728, 2230.6765518999737, 2249.977500224993, 2261.9886900565557, 2290.2442194075998, 2304.44693273614, 2215.3907675389237, 2236.8434209605252, 2243.9439014024615, 2250.797428231459, 2263.4001989472804, 2183.344996501043, 2212.7565967743535, 2224.421650370899, 2229.6098182818105, 2238.2278114050628, 8983.056779038172, 9042.457452552868, 9054.77363065922, 9197.862032069457, 9535.952320238424, 4986.052649996489, 5051.116054690415, 5077.796888124471, 5095.082885080684, 5103.7192954387865, 3227.467467867799, 3331.233816222258, 3387.728981681484, 3416.4533674611944, 3436.742244331685, 1090.3893819461127, 1128.2835399521282, 1137.8520792297031, 1157.8321143434239, 1161.7792619402287, 12769.936150319189, 12879.098463107492, 12917.741645167138, 13026.413811378416, 13043.41304641284, 4180.352045432963, 4348.152110338517, 4426.667999900021, 4460.910781784346, 4493.955060449353, 10098.8485172721, 10125.594976201017, 10128.949355253177, 10129.797404051878, 10134.23993200513, 5152.92270615941, 5155.819546315861, 5158.097332966716, 5158.4067832199025, 5161.767720452589, 4041.1513582148077, 4276.764777937244, 4366.973761166123, 4418.248897687401, 4842.83050093245, 3366.444536651425, 3673.430618254175, 3684.9447258291148, 3703.0, 3757.342465068602, 1060.390275591538, 1090.8472813806075, 1100.5927806711568, 1109.7225693576606, 1116.3580940958982, 961.1829944547079, 965.1506674126723, 965.6041023180603, 967.2068903499063, 977.4770497783652, 5987.640741555433, 6030.33666296707, 6044.879102417927, 6111.84720381994, 6153.0, 443.58967954641827, 444.6198500282277, 445.20753059554045, 453.2136742751324, 455.731118640004, 4292.313229883203, 4304.268274393361, 4312.331588603772, 4343.283358245854, 4358.193734159191, 11294.7176320591, 11627.0, 11704.765904681859, 11715.589954351728, 11742.060635149168, 10863.83704244437, 11397.202195846212, 11408.65774026764, 11657.125715571367, 11802.232854864405, 8439.662413503514, 8637.784055398539, 8650.307975361957, 8651.95674021626, 8652.3510736695, 6087.66517841523, 6156.199694039746, 6271.43557079865, 6290.528210384148, 6397.232332120176, 10601.653322137887, 10776.245662803529, 10781.676549703521, 10925.945370273097, 10937.234393592373, 9521.666741664008, 10095.798084038131, 10635.787284254426, 10655.840162397726, 11039.448027598428, 7443.36731377839, 8086.070101938352, 8310.916890831015, 8311.293540049164, 8313.916860831556, 8636.438631488933, 8690.435121717068, 8715.825683486422, 8950.283977281932, 8969.461832290084, 7718.53688778675, 7734.92265077342, 7896.368290536858, 7925.603719814101, 8019.157988411366, 7465.29079737424, 7690.884636730341, 7798.0, 7814.33578145864, 7920.5247685139075, 6960.8955865663065, 7056.188538318159, 7105.857882842418, 7127.964360178166, 7141.071660684078, 4980.302757613865, 5123.436421993503, 5175.068487672104, 5183.300254465599, 5198.9740051299505, 5116.104681680766, 5168.664036837594, 5256.9211461827335, 5322.121849894879, 5445.809396671098], "value": 4561.786684363382, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.9493533566963, 309.1590872825913, 321.46636583271766, 323.2839261036803, 323.5082674335012, 4987.202047672373, 5134.127198376275, 5184.948150518494, 5197.610179236558, 5206.895862082756, 5004.7747851346685, 5109.540141387283, 5121.283020377141, 5126.2054381570915, 5150.768215430306, 4082.2856000199995, 4088.1619268050126, 4102.958970410287, 4109.4246805447265, 4119.073208528087, 3837.0, 3862.2275544890995, 4104.363823607331, 4113.8971525711795, 4116.506019277691, 4042.292598795214, 4046.817893194813, 4048.57489963554, 4052.9189416211657, 4067.6745860331102, 4035.1122752994293, 4044.170944956292, 4046.6964977626503, 4048.1701251243426, 4061.918761624766, 3549.9172752310533, 3564.41187204111, 3564.8752293669595, 3576.7675101118602, 3582.301451217014, 4986.825461108844, 4995.426440671177, 5014.297998280207, 5024.67339622927, 5054.444011158769, 4541.613962813165, 4554.043650833329, 4559.521250268707, 4562.4753153387455, 4572.382728331666, 5349.362433545188, 5359.303290572239, 5364.0, 5367.838964831061, 5413.918791218135, 3683.650053244937, 3827.502424684801, 3839.865604703822, 3840.135969406889, 3874.4382064600477, 5568.52667523261, 5577.9163312550345, 5589.608727389084, 5593.216949627055, 5613.214150019001, 3928.175083232496, 3934.055826601595, 3953.446517487554, 3968.797317488764, 3969.1069509360163, 3797.411401232813, 3959.6436320731273, 3973.2252210818615, 4017.5781542938157, 4020.979895100506, 4549.475925564972, 4559.635229181657, 4570.794314255866, 4574.794134263966, 4585.197590421662, 5436.374816896028, 5441.700706461103, 5445.782168713286, 5459.3994660587305, 5475.233467314579, 1248.5380409248637, 1284.5035533603434, 1299.5581502289267, 1361.4486133116104, 1374.9037567370187, 869.3653632848057, 871.3421366867974, 890.8040231149137, 891.1445012787797, 895.8611415230649, 4682.84589089016, 4687.414073240845, 4692.498400511871, 4700.109432698866, 4703.506131856174, 4897.510248975074, 4904.5340692634145, 4909.877253068702, 4917.286993385939, 4954.9009019819405, 4496.065942300487, 4656.720596764205, 4663.417072865892, 4676.719396836201, 4696.694714843524, 2570.3317137544, 2628.172125780373, 2629.961779620771, 2630.842149471038, 2632.7498887605648, 5109.591232701375, 5125.051865404912, 5129.563722157802, 5163.108659150887, 5215.426303106655, 5021.1923707465285, 5038.571721403649, 5043.092243396224, 5045.369328833895, 5303.7348132593215, 5840.240768700041, 5851.034579294454, 5854.326752423441, 5856.355800861902, 5860.531157507389, 5555.8888822224135, 5580.38615752275, 5583.944160558342, 5591.832245032656, 5661.065924122474, 5455.763137113764, 5551.417101204477, 5586.38549759518, 5600.891505214645, 5607.41122182165, 5842.130518234294, 5852.561057920758, 5853.326867410302, 5856.975029369928, 5872.354041055395, 4045.8988525287104, 4072.3077076896407, 4074.6943979201087, 4081.2449696806184, 4089.6484521400907, 5340.584745042489, 5554.222408862682, 5598.916016259678, 5604.355499117653, 5645.604807663424, 5259.342582177228, 5383.0, 5406.810761623325, 5422.945770542244, 5439.48324909133, 5429.294191755047, 5462.170172991933, 5493.23094766741, 5506.669599824023, 5515.255440515479, 5267.236250743544, 5430.294061771944, 5450.400455949763, 5492.945070549244, 5502.477264659851, 5459.235707001102, 5480.0, 5491.533219676372, 5510.421405752339, 5530.391656917816, 5317.813876514303, 5352.839414817562, 5383.596230282823, 5390.973045134906, 5401.4868587484125], "value": 4057.8535752219814, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.5693299355419, 685.5372623479153, 699.7550857199977, 725.2747252747251, 777.6889244302279, 14746.483873064431, 15875.36498540057, 15916.124613146272, 15929.920350398246, 15932.0, 15125.394984200619, 15161.54515364538, 15188.696226075472, 15196.772048419283, 15231.08613483189, 637.5664548107285, 651.3421444341202, 758.1281526244808, 762.3063012658469, 780.7618676303725, 778.2723153851139, 784.6978913118434, 790.0124843945068, 790.9723159689412, 791.3827214772487, 847.3729440214228, 847.7075408983891, 848.4485084694936, 849.1254008371387, 849.2484151525882, 671.8018184635545, 690.0408432279136, 837.5100566168799, 838.266516797805, 838.6100463284572, 507.2163507381105, 507.88318686701894, 583.1456915618639, 598.3537779198455, 603.1525706382539, 13223.537176198786, 13740.381682824196, 13813.723725525533, 13836.861631383657, 13986.090904091201, 13897.722045559032, 14400.351984160738, 14746.336414861356, 14834.851651483455, 14955.925220373829, 13227.272500012496, 13363.0, 13501.59495215145, 13696.52062177819, 14205.715885682332, 4490.8877278067985, 4615.446146462413, 4627.213373726441, 4637.814487420499, 4761.119192949315, 79890.60054699748, 80299.5985020077, 80316.19683803145, 81090.59454702689, 83934.58032709858, 11026.834597481044, 11056.668299951014, 11447.771044579062, 11518.481668324945, 11908.76182476363, 22459.775402246094, 22475.887620561793, 22484.437889052577, 22488.55022899533, 22620.0, 8326.209010144026, 8399.874001889977, 8431.662733490715, 8449.408541402043, 8678.392512524062, 4493.483249426293, 4571.839985600488, 4634.026854360554, 4669.836555720533, 4910.926336104962, 3424.8116353600294, 3556.822158892045, 3561.857525698943, 3569.303985722759, 3571.053670777246, 598.2910251352162, 602.9969850150721, 606.7663949379432, 619.510586636552, 624.1605041219552, 522.1932114882464, 547.2393373211239, 603.7253049862302, 609.4575827513517, 633.9746410143542, 8731.694390696295, 8762.255208307366, 9013.684521041863, 9089.181973622273, 9103.499307538017, 639.405353021685, 653.5359894474976, 657.5167252069725, 666.2438132719302, 706.4913262451028, 4212.831486740557, 4439.733615983051, 4505.549445055468, 4511.932321015187, 4600.723956562617, 113803.0, 116763.41618291855, 119140.0, 120059.19911201339, 123060.0, 82706.58646706727, 84409.0, 84443.0, 105890.47054764676, 106214.46892765487, 58513.0, 65625.0, 79768.60115699384, 92521.5373923126, 94206.52896735609, 8002.639881205476, 8002.879956800769, 8493.853329800644, 9429.434233945985, 9476.810463790547, 47838.76080619574, 48112.5188748122, 48733.756331219534, 49530.0, 49883.76685380527, 75266.24733752593, 76159.23840761521, 76580.61709691415, 77660.61169694115, 78992.60503697675, 12353.567625133077, 12476.500939962663, 12522.812157817822, 12701.36493175356, 13015.804762928754, 13950.0, 14501.20243386624, 15165.165915874733, 15316.310766015778, 15430.151341676315, 12508.312042837731, 12793.936030319788, 13662.248576328397, 13792.0, 13923.930380348034, 12404.441800119197, 12727.281816954963, 12904.935475322563, 13204.640112921603, 14454.638634034232, 13115.606531804062, 13209.405576748877, 13475.0, 13556.93221533886, 13680.863191367958, 11441.542338306375, 11630.825537617111, 11807.468663910317, 11813.173077884465, 12036.338001410006, 10522.842157367493, 10547.261691681508, 10770.497940846126, 11240.83138752903, 11404.82892756626], "value": 7396.554738753886, "unit": "score"}], "name": "dromaeo_css", "value": 7043.321937777851, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 113.0, 115.0, 112.0, 112.0, 114.0, 112.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 128.0, 124.0, 161.0, 128.0, 124.0, 126.0, 120.0, 159.0, 130.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 160.0, 162.0, 160.0, 161.0, 160.0, 159.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 112.0, 77.0, 77.0, 76.0, 75.0, 103.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 113.0, 83.0, 83.0, 82.0, 104.0, 83.0, 82.0, 113.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 52.0, 51.0, 53.0, 53.0, 53.0, 53.0, 52.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 62.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 89.0, 83.0, 82.0, 80.0, 80.0, 82.0, 83.0, 79.0, 80.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 131.0, 131.0, 133.0, 134.0, 129.0, 146.0, 131.0, 172.0, 141.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 167.0, 175.0, 172.0, 173.0, 172.0, 167.0, 171.0, 166.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 67.0, 67.0, 68.0, 65.0, 66.0, 65.0, 65.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1509.0, "alertThreshold": 2.0}]} 12:45:26 INFO - Return code: 0 12:45:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:45:26 INFO - # TBPL SUCCESS # 12:45:26 INFO - Running post-action listener: _resource_record_post_action 12:45:26 INFO - [mozharness: 2016-10-04 19:45:26.950921Z] Finished run-tests step (success) 12:45:26 INFO - Running post-run listener: _resource_record_post_run 12:45:27 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394240000; Read time: 12; Write time: 267364 12:45:27 INFO - TinderboxPrint: CPU usage
13.1% 12:45:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 12:45:27 INFO - TinderboxPrint: I/O write bytes / time
394,240,000 / 267,364 12:45:27 INFO - TinderboxPrint: CPU idle
8,300.5 (86.9%) 12:45:27 INFO - TinderboxPrint: CPU user
1,199.6 (12.6%) 12:45:27 INFO - TinderboxPrint: Swap in / out
0 / 0 12:45:27 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 103686144; Read time: 0; Write time: 79728 12:45:27 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 290553856; Read time: 0; Write time: 187636 12:45:27 INFO - Running post-run listener: _upload_blobber_files 12:45:27 INFO - Blob upload gear active. 12:45:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:45:27 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 12:45:27 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'] 12:45:27 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 12:45:27 INFO - (blobuploader) - INFO - Open directory for files ... 12:45:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:45:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:45:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:45:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:45:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:45:28 INFO - (blobuploader) - INFO - Done attempting. 12:45:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:45:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:45:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:45:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:45:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:45:29 INFO - (blobuploader) - INFO - Done attempting. 12:45:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:45:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:45:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:45:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:45:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:45:33 INFO - (blobuploader) - INFO - Done attempting. 12:45:33 INFO - (blobuploader) - INFO - Iteration through files over. 12:45:33 INFO - Return code: 0 12:45:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:45:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:45:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a71894a0db81ae233ba6c6ee7f8d5c1a67dd3e0623b94ac685258cd551f9392685a010ecdfec8ca30176e69e5219ea3b82571014fc36ebb6d68766666466b9e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02c4524e61bbde233a6dc733a7ac47fc5ef632d1018587abb6f83a597d8994147ee16c7100fae85be330a059cdf99decc39650c89484bdc22331975ad7d47465", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/859aeb25e9cba1844089ca5b20b99f03123f516c2c5869ac1dced2e247ba4f0710be36007d1bac3fc242a0fa3559fd3db8964c36fed25201c9cab4494d3d7844"} 12:45:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:45:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:45:33 INFO - Contents: 12:45:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a71894a0db81ae233ba6c6ee7f8d5c1a67dd3e0623b94ac685258cd551f9392685a010ecdfec8ca30176e69e5219ea3b82571014fc36ebb6d68766666466b9e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02c4524e61bbde233a6dc733a7ac47fc5ef632d1018587abb6f83a597d8994147ee16c7100fae85be330a059cdf99decc39650c89484bdc22331975ad7d47465", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/859aeb25e9cba1844089ca5b20b99f03123f516c2c5869ac1dced2e247ba4f0710be36007d1bac3fc242a0fa3559fd3db8964c36fed25201c9cab4494d3d7844"} 12:45:33 INFO - Running post-run listener: copy_logs_to_upload_dir 12:45:33 INFO - Copying logs to upload dir... 12:45:33 INFO - mkdir: /builds/slave/test/build/upload/logs 12:45:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.967146 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-04 12:45:33.478337) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 12:45:33.481605) ========= 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=7de08804244eb36560b44971000001c3-1475609089.266249-1680016937 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/a71894a0db81ae233ba6c6ee7f8d5c1a67dd3e0623b94ac685258cd551f9392685a010ecdfec8ca30176e69e5219ea3b82571014fc36ebb6d68766666466b9e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02c4524e61bbde233a6dc733a7ac47fc5ef632d1018587abb6f83a597d8994147ee16c7100fae85be330a059cdf99decc39650c89484bdc22331975ad7d47465", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/859aeb25e9cba1844089ca5b20b99f03123f516c2c5869ac1dced2e247ba4f0710be36007d1bac3fc242a0fa3559fd3db8964c36fed25201c9cab4494d3d7844"} build_url:https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011390 build_url: 'https://queue.taskcluster.net/v1/task/Kb-ED0AmRh21KJjni4ke9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a71894a0db81ae233ba6c6ee7f8d5c1a67dd3e0623b94ac685258cd551f9392685a010ecdfec8ca30176e69e5219ea3b82571014fc36ebb6d68766666466b9e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02c4524e61bbde233a6dc733a7ac47fc5ef632d1018587abb6f83a597d8994147ee16c7100fae85be330a059cdf99decc39650c89484bdc22331975ad7d47465", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/859aeb25e9cba1844089ca5b20b99f03123f516c2c5869ac1dced2e247ba4f0710be36007d1bac3fc242a0fa3559fd3db8964c36fed25201c9cab4494d3d7844"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 12:45:33.508828) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 12:45:33.509188) ========= 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=7de08804244eb36560b44971000001c3-1475609089.266249-1680016937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 12:45:33.596595) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 12:45:33.596959) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 12:45:33.597293) ========= ========= Total master_lag: 0.19 =========