builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-060 starttime: 1476476085.06 results: success (0) buildid: 20161014113235 builduid: f98f80e944b94df8aee6987c0de9b0cc revision: 905f1bc96fb67f7a827387203cb5cafce70b67bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 13:14:45.058290) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 13:14:45.058768) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 13:14:45.059042) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 13:14:45.114509) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 13:14:45.114809) ========= 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=337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 13:14:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 26.9M=0s 2016-10-14 13:14:45 (26.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.218849 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 13:14:45.359375) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 13:14:45.359706) ========= 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=337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018274 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 13:14:45.408921) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 13:14:45.412369) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 905f1bc96fb67f7a827387203cb5cafce70b67bf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 905f1bc96fb67f7a827387203cb5cafce70b67bf --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=337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 13:14:45,454 truncating revision to first 12 chars 2016-10-14 13:14:45,454 Setting DEBUG logging. 2016-10-14 13:14:45,454 attempt 1/10 2016-10-14 13:14:45,454 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/905f1bc96fb6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 13:14:45,763 unpacking tar archive at: autoland-905f1bc96fb6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.627165 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 13:14:46.052786) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 13:14:46.053090) ========= script_repo_revision: 905f1bc96fb67f7a827387203cb5cafce70b67bf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 13:14:46.056539) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 13:14:46.056817) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 13:14:46.066103) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-14 13:14:46.066436) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:14:46 INFO - MultiFileLogger online at 20161014 13:14:46 in /builds/slave/test 13:14:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 13:14:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:14:46 INFO - {'append_to_log': False, 13:14:46 INFO - 'base_work_dir': '/builds/slave/test', 13:14:46 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 13:14:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:14:46 INFO - 'branch': 'Autoland-Non-PGO', 13:14:46 INFO - 'buildbot_json_path': 'buildprops.json', 13:14:46 INFO - 'config_files': ('talos/linux_config.py',), 13:14:46 INFO - 'default_actions': ('clobber', 13:14:46 INFO - 'read-buildbot-config', 13:14:46 INFO - 'download-and-extract', 13:14:46 INFO - 'populate-webroot', 13:14:46 INFO - 'create-virtualenv', 13:14:46 INFO - 'install', 13:14:46 INFO - 'run-tests'), 13:14:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:14:46 INFO - 'download_minidump_stackwalk': True, 13:14:46 INFO - 'download_symbols': 'ondemand', 13:14:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:14:46 INFO - 'tooltool.py': '/tools/tooltool.py', 13:14:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:14:46 INFO - '/tools/misc-python/virtualenv.py')}, 13:14:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:14:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:14:46 INFO - 'installer_path': 'installer.exe', 13:14:46 INFO - 'log_level': 'info', 13:14:46 INFO - 'log_name': 'talos', 13:14:46 INFO - 'log_to_console': True, 13:14:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:14:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:14:46 INFO - 'opt_config_files': (), 13:14:46 INFO - 'pip_index': False, 13:14:46 INFO - 'sps_profile': False, 13:14:46 INFO - 'sps_profile_interval': 0, 13:14:46 INFO - 'suite': 'dromaeojs', 13:14:46 INFO - 'system_bits': '32', 13:14:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:14:46 INFO - 'title': 'talos-linux64-ix-060', 13:14:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:14:46 INFO - 'use_talos_json': True, 13:14:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:14:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:14:46 INFO - 'work_dir': 'build'} 13:14:46 INFO - [mozharness: 2016-10-14 20:14:46.212728Z] Running clobber step. 13:14:46 INFO - Running pre-action listener: _resource_record_pre_action 13:14:46 INFO - Running main action method: clobber 13:14:46 INFO - rmtree: /builds/slave/test/build 13:14:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:14:47 INFO - Running post-action listener: _resource_record_post_action 13:14:47 INFO - [mozharness: 2016-10-14 20:14:47.187113Z] Finished clobber step (success) 13:14:47 INFO - [mozharness: 2016-10-14 20:14:47.187214Z] Running read-buildbot-config step. 13:14:47 INFO - Running pre-action listener: _resource_record_pre_action 13:14:47 INFO - Running main action method: read_buildbot_config 13:14:47 INFO - Using buildbot properties: 13:14:47 INFO - { 13:14:47 INFO - "project": "", 13:14:47 INFO - "product": "firefox", 13:14:47 INFO - "script_repo_revision": "production", 13:14:47 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 13:14:47 INFO - "repository": "", 13:14:47 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 13:14:47 INFO - "buildid": "20161014113235", 13:14:47 INFO - "pgo_build": "False", 13:14:47 INFO - "basedir": "/builds/slave/test", 13:14:47 INFO - "buildnumber": 730, 13:14:47 INFO - "slavename": "talos-linux64-ix-060", 13:14:47 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:14:47 INFO - "platform": "ubuntu64_hw", 13:14:47 INFO - "scheduler": "tests-autoland-linux64-talos", 13:14:47 INFO - "branch": "autoland", 13:14:47 INFO - "repo_path": "integration/autoland", 13:14:47 INFO - "revision": "905f1bc96fb67f7a827387203cb5cafce70b67bf", 13:14:47 INFO - "stage_platform": "linux64", 13:14:47 INFO - "builduid": "f98f80e944b94df8aee6987c0de9b0cc", 13:14:47 INFO - "slavebuilddir": "test" 13:14:47 INFO - } 13:14:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 13:14:47 INFO - Running post-action listener: _resource_record_post_action 13:14:47 INFO - [mozharness: 2016-10-14 20:14:47.189961Z] Finished read-buildbot-config step (success) 13:14:47 INFO - [mozharness: 2016-10-14 20:14:47.190049Z] Running download-and-extract step. 13:14:47 INFO - Running pre-action listener: _resource_record_pre_action 13:14:47 INFO - Running main action method: download_and_extract 13:14:47 INFO - mkdir: /builds/slave/test/build/tests 13:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:47 INFO - trying https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:14:47 INFO - Downloading https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/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 13:14:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/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 13:14:47 INFO - Downloaded 1361 bytes. 13:14:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:14:47 INFO - Using the following test package requirements: 13:14:47 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:14:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:14:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:14:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:47 INFO - u'jsshell-linux-x86_64.zip'], 13:14:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:14:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:14:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:14:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:14:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:14:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:14:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:14:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:14:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:14:47 INFO - Fetch https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:14:48 INFO - Http code: 200 13:14:48 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 13:14:48 INFO - x-amz-cf-id: GPBoYXhlX8zk33x-jPczbxMU65JwA1NSVTjTBQqluGZ7ToUBnXVfpA== 13:14:48 INFO - x-amz-version-id: Pp3RqgPoFZ2glA_cYeCH3ktJsug8cHyM 13:14:49 INFO - Expected file size: 20553992 13:14:49 INFO - Obtained file size: 20553992 13:14:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:14:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:14:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:14:53 INFO - Fetch https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:14:54 INFO - Http code: 200 13:14:54 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 13:14:54 INFO - x-amz-cf-id: XpG0LW3mJZxK6KAPmz6F5r1ANuWSjYEncnrUPVi5i8WKUPSCLfT8xg== 13:14:54 INFO - x-amz-version-id: Pp3RqgPoFZ2glA_cYeCH3ktJsug8cHyM 13:14:54 INFO - Expected file size: 20553992 13:14:54 INFO - Obtained file size: 20553992 13:14:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 13:14:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:14:58 INFO - Fetch https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:14:59 INFO - Http code: 200 13:14:59 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 13:14:59 INFO - x-amz-cf-id: rmPQzOgy5dLKA7C24B4ThNIpd7zqBbFbzRmLTRdUrOyhJi27XGxnWw== 13:14:59 INFO - x-amz-version-id: Hm6w72emc0rkTxz5eAOX9r31rOHDtiTD 13:15:00 INFO - Expected file size: 14409006 13:15:00 INFO - Obtained file size: 14409006 13:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:00 INFO - trying https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:15:00 INFO - Downloading https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/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 13:15:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/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 13:15:02 INFO - Downloaded 55549550 bytes. 13:15:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:15:02 INFO - mkdir: /builds/slave/test/properties 13:15:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:15:02 INFO - Writing to file /builds/slave/test/properties/build_url 13:15:02 INFO - Contents: 13:15:02 INFO - build_url:https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:15:03 INFO - Running post-action listener: _resource_record_post_action 13:15:03 INFO - Running post-action listener: set_extra_try_arguments 13:15:03 INFO - [mozharness: 2016-10-14 20:15:03.528800Z] Finished download-and-extract step (success) 13:15:03 INFO - [mozharness: 2016-10-14 20:15:03.529058Z] Running populate-webroot step. 13:15:03 INFO - Running pre-action listener: _resource_record_pre_action 13:15:03 INFO - Running main action method: populate_webroot 13:15:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:15:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:15:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:15:03 INFO - '--tppagecycles', 13:15:03 INFO - '7'], 13:15:03 INFO - 'tests': ['tsvgm']}}, 13:15:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:15:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:15:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:15:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:15:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:15:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:15:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:03 INFO - 'talos_options': ['--disable-e10s'], 13:15:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:15:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:15:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:03 INFO - 'talos_options': ['--disable-e10s'], 13:15:03 INFO - 'tests': ['damp', 'tps']}, 13:15:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:03 INFO - 'tests': ['damp', 'tps']}, 13:15:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:15:03 INFO - 'tests': ['dromaeo_dom']}, 13:15:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:15:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:15:03 INFO - 'tests': ['basic_compositor_video']}, 13:15:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:15:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:15:03 INFO - 'tests': ['a11yr', 13:15:03 INFO - 'ts_paint', 13:15:03 INFO - 'tpaint', 13:15:03 INFO - 'sessionrestore', 13:15:03 INFO - 'sessionrestore_no_auto_restore', 13:15:03 INFO - 'tabpaint']}, 13:15:03 INFO - 'other-e10s': {'tests': ['a11yr', 13:15:03 INFO - 'ts_paint', 13:15:03 INFO - 'tpaint', 13:15:03 INFO - 'sessionrestore', 13:15:03 INFO - 'sessionrestore_no_auto_restore', 13:15:03 INFO - 'tabpaint']}, 13:15:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:15:03 INFO - 'ts_paint', 13:15:03 INFO - 'tpaint', 13:15:03 INFO - 'sessionrestore', 13:15:03 INFO - 'sessionrestore_no_auto_restore', 13:15:03 INFO - 'tabpaint']}, 13:15:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:15:03 INFO - 'ts_paint', 13:15:03 INFO - 'tpaint', 13:15:03 INFO - 'sessionrestore', 13:15:03 INFO - 'sessionrestore_no_auto_restore', 13:15:03 INFO - 'tabpaint']}, 13:15:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:15:03 INFO - 'tests': ['a11yr', 13:15:03 INFO - 'ts_paint', 13:15:03 INFO - 'tpaint', 13:15:03 INFO - 'sessionrestore', 13:15:03 INFO - 'sessionrestore_no_auto_restore', 13:15:03 INFO - 'tabpaint']}, 13:15:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:15:03 INFO - 'tests': ['a11yr', 13:15:03 INFO - 'ts_paint', 13:15:03 INFO - 'tpaint', 13:15:03 INFO - 'sessionrestore', 13:15:03 INFO - 'sessionrestore_no_auto_restore', 13:15:03 INFO - 'tabpaint']}, 13:15:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:15:03 INFO - 'tests': ['tsvgx', 13:15:03 INFO - 'tsvgr_opacity', 13:15:03 INFO - 'tart', 13:15:03 INFO - 'tscrollx', 13:15:03 INFO - 'cart']}, 13:15:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:15:03 INFO - 'tsvgr_opacity', 13:15:03 INFO - 'tart', 13:15:03 INFO - 'tscrollx', 13:15:03 INFO - 'cart']}, 13:15:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:03 INFO - 'talos_options': ['--disable-e10s'], 13:15:03 INFO - 'tests': ['tp5o']}, 13:15:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:03 INFO - 'tests': ['tp5o']}, 13:15:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:03 INFO - 'talos_options': ['--disable-e10s', 13:15:03 INFO - '--xperf_path', 13:15:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:15:03 INFO - 'tests': ['tp5n']}, 13:15:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:03 INFO - 'talos_options': ['--xperf_path', 13:15:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:15:03 INFO - 'tests': ['tp5n']}}, 13:15:03 INFO - 'talos.zip': {'path': '', 13:15:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:15:03 INFO - Running post-action listener: _resource_record_post_action 13:15:03 INFO - [mozharness: 2016-10-14 20:15:03.547455Z] Finished populate-webroot step (success) 13:15:03 INFO - [mozharness: 2016-10-14 20:15:03.547543Z] Running create-virtualenv step. 13:15:03 INFO - Running pre-action listener: _resource_record_pre_action 13:15:03 INFO - Running main action method: create_virtualenv 13:15:03 INFO - Creating virtualenv /builds/slave/test/build/venv 13:15:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:15:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:15:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:15:03 INFO - Using real prefix '/usr' 13:15:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:15:04 INFO - Installing distribute.............................................................................................................................................................................................done. 13:15:06 INFO - Installing pip.................done. 13:15:06 INFO - Return code: 0 13:15:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:15:06 INFO - Reading from file tmpfile_stdout 13:15:06 INFO - Output received: 13:15:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:15:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:06 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 0x7ff2454dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aefca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aecf60>, '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 0x1aedd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:15:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:15:06 INFO - Using env: {'DISPLAY': ':0', 13:15:06 INFO - 'HOME': '/home/cltbld', 13:15:06 INFO - 'LANG': 'en_US.UTF-8', 13:15:06 INFO - 'LANGUAGE': 'en_US:en', 13:15:06 INFO - 'LOGNAME': 'cltbld', 13:15:06 INFO - 'MAIL': '/var/mail/cltbld', 13:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:06 INFO - 'MOZ_NO_REMOTE': '1', 13:15:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:06 INFO - 'NO_EM_RESTART': '1', 13:15:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:06 INFO - 'PWD': '/builds/slave/test', 13:15:06 INFO - 'SHELL': '/bin/bash', 13:15:06 INFO - 'SHLVL': '1', 13:15:06 INFO - 'TERM': 'linux', 13:15:06 INFO - 'TMOUT': '86400', 13:15:06 INFO - 'USER': 'cltbld', 13:15:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 13:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:06 INFO - '_': '/tools/buildbot/bin/python'} 13:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:15:06 INFO - Cleaning up... 13:15:06 INFO - Return code: 0 13:15:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:06 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 0x7ff2454dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aefca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aecf60>, '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 0x1aedd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:15:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:15:06 INFO - Using env: {'DISPLAY': ':0', 13:15:06 INFO - 'HOME': '/home/cltbld', 13:15:06 INFO - 'LANG': 'en_US.UTF-8', 13:15:06 INFO - 'LANGUAGE': 'en_US:en', 13:15:06 INFO - 'LOGNAME': 'cltbld', 13:15:06 INFO - 'MAIL': '/var/mail/cltbld', 13:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:06 INFO - 'MOZ_NO_REMOTE': '1', 13:15:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:06 INFO - 'NO_EM_RESTART': '1', 13:15:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:06 INFO - 'PWD': '/builds/slave/test', 13:15:06 INFO - 'SHELL': '/bin/bash', 13:15:06 INFO - 'SHLVL': '1', 13:15:06 INFO - 'TERM': 'linux', 13:15:06 INFO - 'TMOUT': '86400', 13:15:06 INFO - 'USER': 'cltbld', 13:15:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 13:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:06 INFO - '_': '/tools/buildbot/bin/python'} 13:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:06 INFO - Downloading/unpacking psutil>=3.1.1 13:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:15:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:15:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:15:08 INFO - Installing collected packages: psutil 13:15:08 INFO - Running setup.py install for psutil 13:15:08 INFO - building 'psutil._psutil_linux' extension 13:15:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:15:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:15:09 INFO - building 'psutil._psutil_posix' extension 13:15:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:15:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:15:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:15:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:15:09 INFO - Successfully installed psutil 13:15:09 INFO - Cleaning up... 13:15:09 INFO - Return code: 0 13:15:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:15: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')]} 13:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15: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')]} 13:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2454dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aefca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aecf60>, '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 0x1aedd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:15: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:15: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 mozsystemmonitor==0.3 13:15:09 INFO - Using env: {'DISPLAY': ':0', 13:15:09 INFO - 'HOME': '/home/cltbld', 13:15:09 INFO - 'LANG': 'en_US.UTF-8', 13:15:09 INFO - 'LANGUAGE': 'en_US:en', 13:15:09 INFO - 'LOGNAME': 'cltbld', 13:15:09 INFO - 'MAIL': '/var/mail/cltbld', 13:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:09 INFO - 'MOZ_NO_REMOTE': '1', 13:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:09 INFO - 'NO_EM_RESTART': '1', 13:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:09 INFO - 'PWD': '/builds/slave/test', 13:15:09 INFO - 'SHELL': '/bin/bash', 13:15:09 INFO - 'SHLVL': '1', 13:15:09 INFO - 'TERM': 'linux', 13:15:09 INFO - 'TMOUT': '86400', 13:15:09 INFO - 'USER': 'cltbld', 13:15:09 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 13:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:09 INFO - '_': '/tools/buildbot/bin/python'} 13:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:15:11 INFO - Installing collected packages: mozsystemmonitor 13:15:11 INFO - Running setup.py install for mozsystemmonitor 13:15:11 INFO - Successfully installed mozsystemmonitor 13:15:11 INFO - Cleaning up... 13:15:11 INFO - Return code: 0 13:15:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:11 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 0x7ff2454dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aefca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aecf60>, '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 0x1aedd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:15:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:15:11 INFO - Using env: {'DISPLAY': ':0', 13:15:11 INFO - 'HOME': '/home/cltbld', 13:15:11 INFO - 'LANG': 'en_US.UTF-8', 13:15:11 INFO - 'LANGUAGE': 'en_US:en', 13:15:11 INFO - 'LOGNAME': 'cltbld', 13:15:11 INFO - 'MAIL': '/var/mail/cltbld', 13:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:11 INFO - 'MOZ_NO_REMOTE': '1', 13:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:11 INFO - 'NO_EM_RESTART': '1', 13:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:11 INFO - 'PWD': '/builds/slave/test', 13:15:11 INFO - 'SHELL': '/bin/bash', 13:15:11 INFO - 'SHLVL': '1', 13:15:11 INFO - 'TERM': 'linux', 13:15:11 INFO - 'TMOUT': '86400', 13:15:11 INFO - 'USER': 'cltbld', 13:15:11 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 13:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:11 INFO - '_': '/tools/buildbot/bin/python'} 13:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:11 INFO - Downloading/unpacking jsonschema==2.5.1 13:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:15:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:14 INFO - Downloading functools32-3.2.3-2.tar.gz 13:15:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:15:14 INFO - warning: no files found matching '*.txt' 13:15:14 INFO - no previously-included directories found matching 'build' 13:15:14 INFO - no previously-included directories found matching 'dist' 13:15:14 INFO - no previously-included directories found matching '.git*' 13:15:14 INFO - Installing collected packages: jsonschema, functools32 13:15:14 INFO - Running setup.py install for functools32 13:15:14 INFO - warning: no files found matching '*.txt' 13:15:14 INFO - no previously-included directories found matching 'build' 13:15:14 INFO - no previously-included directories found matching 'dist' 13:15:14 INFO - no previously-included directories found matching '.git*' 13:15:14 INFO - Successfully installed jsonschema functools32 13:15:14 INFO - Cleaning up... 13:15:14 INFO - Return code: 0 13:15:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:15: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')]} 13:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15: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')]} 13:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15: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', '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 0x7ff2454dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aefca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aecf60>, '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 0x1aedd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:15: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:15: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 functools32==3.2.3-2 13:15:14 INFO - Using env: {'DISPLAY': ':0', 13:15:14 INFO - 'HOME': '/home/cltbld', 13:15:14 INFO - 'LANG': 'en_US.UTF-8', 13:15:14 INFO - 'LANGUAGE': 'en_US:en', 13:15:14 INFO - 'LOGNAME': 'cltbld', 13:15:14 INFO - 'MAIL': '/var/mail/cltbld', 13:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:14 INFO - 'MOZ_NO_REMOTE': '1', 13:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:14 INFO - 'NO_EM_RESTART': '1', 13:15:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:14 INFO - 'PWD': '/builds/slave/test', 13:15:14 INFO - 'SHELL': '/bin/bash', 13:15:14 INFO - 'SHLVL': '1', 13:15:14 INFO - 'TERM': 'linux', 13:15:14 INFO - 'TMOUT': '86400', 13:15:14 INFO - 'USER': 'cltbld', 13:15:14 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 13:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:14 INFO - '_': '/tools/buildbot/bin/python'} 13:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:15:14 INFO - Cleaning up... 13:15:14 INFO - Return code: 0 13:15:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:15: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')]} 13:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15: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')]} 13:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15: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', '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 0x7ff2454dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aefca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aecf60>, '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 0x1aedd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:15: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:15: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 blobuploader==1.2.4 13:15:14 INFO - Using env: {'DISPLAY': ':0', 13:15:14 INFO - 'HOME': '/home/cltbld', 13:15:14 INFO - 'LANG': 'en_US.UTF-8', 13:15:14 INFO - 'LANGUAGE': 'en_US:en', 13:15:14 INFO - 'LOGNAME': 'cltbld', 13:15:14 INFO - 'MAIL': '/var/mail/cltbld', 13:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:14 INFO - 'MOZ_NO_REMOTE': '1', 13:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:14 INFO - 'NO_EM_RESTART': '1', 13:15:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:14 INFO - 'PWD': '/builds/slave/test', 13:15:14 INFO - 'SHELL': '/bin/bash', 13:15:14 INFO - 'SHLVL': '1', 13:15:14 INFO - 'TERM': 'linux', 13:15:14 INFO - 'TMOUT': '86400', 13:15:14 INFO - 'USER': 'cltbld', 13:15:14 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 13:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:14 INFO - '_': '/tools/buildbot/bin/python'} 13:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:14 INFO - Downloading/unpacking blobuploader==1.2.4 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15:16 INFO - Downloading blobuploader-1.2.4.tar.gz 13:15:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:15:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:15:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15:17 INFO - Downloading docopt-0.6.1.tar.gz 13:15:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:15:17 INFO - Installing collected packages: blobuploader, requests, docopt 13:15:17 INFO - Running setup.py install for blobuploader 13:15:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:15:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:15:17 INFO - Running setup.py install for requests 13:15:18 INFO - Running setup.py install for docopt 13:15:18 INFO - Successfully installed blobuploader requests docopt 13:15:18 INFO - Cleaning up... 13:15:18 INFO - Return code: 0 13:15:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:18 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 0x7ff2454dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aefca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aecf60>, '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 0x1aedd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:15:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:15:18 INFO - Using env: {'DISPLAY': ':0', 13:15:18 INFO - 'HOME': '/home/cltbld', 13:15:18 INFO - 'LANG': 'en_US.UTF-8', 13:15:18 INFO - 'LANGUAGE': 'en_US:en', 13:15:18 INFO - 'LOGNAME': 'cltbld', 13:15:18 INFO - 'MAIL': '/var/mail/cltbld', 13:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:18 INFO - 'MOZ_NO_REMOTE': '1', 13:15:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:18 INFO - 'NO_EM_RESTART': '1', 13:15:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:18 INFO - 'PWD': '/builds/slave/test', 13:15:18 INFO - 'SHELL': '/bin/bash', 13:15:18 INFO - 'SHLVL': '1', 13:15:18 INFO - 'TERM': 'linux', 13:15:18 INFO - 'TMOUT': '86400', 13:15:18 INFO - 'USER': 'cltbld', 13:15:18 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 13:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:18 INFO - '_': '/tools/buildbot/bin/python'} 13:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:15:18 INFO - Running setup.py (path:/tmp/pip-hYUp5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:15:18 INFO - Running setup.py (path:/tmp/pip-_8hMp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:15:18 INFO - Running setup.py (path:/tmp/pip-41GvKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:15:18 INFO - Running setup.py (path:/tmp/pip-wxt2ge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:15:18 INFO - Running setup.py (path:/tmp/pip-LEyB3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:15:18 INFO - Running setup.py (path:/tmp/pip-23NfzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:15:18 INFO - Running setup.py (path:/tmp/pip-m0GMGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:15:18 INFO - Running setup.py (path:/tmp/pip-LPykok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:15:19 INFO - Running setup.py (path:/tmp/pip-f3E5G8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:15:19 INFO - Running setup.py (path:/tmp/pip-XAKJLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:15:19 INFO - Running setup.py (path:/tmp/pip-q0QTNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:15:19 INFO - Running setup.py (path:/tmp/pip-BMG8ZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:15:19 INFO - Running setup.py (path:/tmp/pip-FrdnO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:15:19 INFO - Running setup.py (path:/tmp/pip-EnKIrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:19 INFO - Running setup.py (path:/tmp/pip-j49biH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:15:19 INFO - Running setup.py (path:/tmp/pip-VKdILk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:15:19 INFO - Running setup.py (path:/tmp/pip-FDJBaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:15:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:15:19 INFO - Running setup.py install for manifestparser 13:15:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:15:19 INFO - Running setup.py install for mozcrash 13:15:19 INFO - Running setup.py install for mozdebug 13:15:19 INFO - Running setup.py install for mozdevice 13:15:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:15:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:15:20 INFO - Running setup.py install for mozfile 13:15:20 INFO - Running setup.py install for mozhttpd 13:15:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:15:20 INFO - Running setup.py install for mozinfo 13:15:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:15:20 INFO - Running setup.py install for mozInstall 13:15:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:15:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:15:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:15:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:15:20 INFO - Running setup.py install for mozleak 13:15:20 INFO - Running setup.py install for mozlog 13:15:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:15:20 INFO - Running setup.py install for moznetwork 13:15:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:15:20 INFO - Running setup.py install for mozprocess 13:15:20 INFO - Running setup.py install for mozprofile 13:15:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:15:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:15:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:15:21 INFO - Running setup.py install for mozrunner 13:15:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:15:21 INFO - Running setup.py install for mozscreenshot 13:15:21 INFO - Running setup.py install for moztest 13:15:21 INFO - Running setup.py install for mozversion 13:15:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:15:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:15:21 INFO - Cleaning up... 13:15:21 INFO - Return code: 0 13:15:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15: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')]} 13:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15: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')]} 13:15:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:21 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 0x7ff2454dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aefca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aecf60>, '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 0x1aedd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:15:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:15:21 INFO - Using env: {'DISPLAY': ':0', 13:15:21 INFO - 'HOME': '/home/cltbld', 13:15:21 INFO - 'LANG': 'en_US.UTF-8', 13:15:21 INFO - 'LANGUAGE': 'en_US:en', 13:15:21 INFO - 'LOGNAME': 'cltbld', 13:15:21 INFO - 'MAIL': '/var/mail/cltbld', 13:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:21 INFO - 'MOZ_NO_REMOTE': '1', 13:15:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:21 INFO - 'NO_EM_RESTART': '1', 13:15:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:21 INFO - 'PWD': '/builds/slave/test', 13:15:21 INFO - 'SHELL': '/bin/bash', 13:15:21 INFO - 'SHLVL': '1', 13:15:21 INFO - 'TERM': 'linux', 13:15:21 INFO - 'TMOUT': '86400', 13:15:21 INFO - 'USER': 'cltbld', 13:15:21 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 13:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:21 INFO - '_': '/tools/buildbot/bin/python'} 13:15:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:15:21 INFO - Running setup.py (path:/tmp/pip-zekc7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:15:21 INFO - Running setup.py (path:/tmp/pip-fJNfid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:15:21 INFO - Running setup.py (path:/tmp/pip-kpmIqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:15:21 INFO - Running setup.py (path:/tmp/pip-UN_mgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:15:22 INFO - Running setup.py (path:/tmp/pip-LZIsjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:15:22 INFO - Running setup.py (path:/tmp/pip-4bxxY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:15:22 INFO - Running setup.py (path:/tmp/pip-Hc_ffE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:15:22 INFO - Running setup.py (path:/tmp/pip-J43vXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:15:22 INFO - Running setup.py (path:/tmp/pip-KPsnaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:15:22 INFO - Running setup.py (path:/tmp/pip-hmCJVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:15:22 INFO - Running setup.py (path:/tmp/pip-lbHNCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:15:22 INFO - Running setup.py (path:/tmp/pip-7wg6WQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:15:22 INFO - Running setup.py (path:/tmp/pip-srD0CL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:15:22 INFO - Running setup.py (path:/tmp/pip-kyBt6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:22 INFO - Running setup.py (path:/tmp/pip-NgODgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:15:22 INFO - Running setup.py (path:/tmp/pip-3minqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:15:22 INFO - Running setup.py (path:/tmp/pip-IVmNbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:15:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:24 INFO - Downloading blessings-1.6.tar.gz 13:15:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:15:24 INFO - Installing collected packages: blessings 13:15:24 INFO - Running setup.py install for blessings 13:15:25 INFO - Successfully installed blessings 13:15:25 INFO - Cleaning up... 13:15:25 INFO - Return code: 0 13:15:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:15:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:15:25 INFO - Reading from file tmpfile_stdout 13:15:25 INFO - Current package versions: 13:15:25 INFO - argparse == 1.2.1 13:15:25 INFO - blessings == 1.6 13:15:25 INFO - blobuploader == 1.2.4 13:15:25 INFO - docopt == 0.6.1 13:15:25 INFO - functools32 == 3.2.3-2 13:15:25 INFO - jsonschema == 2.5.1 13:15:25 INFO - manifestparser == 1.1 13:15:25 INFO - mozInstall == 1.12 13:15:25 INFO - mozcrash == 0.17 13:15:25 INFO - mozdebug == 0.1 13:15:25 INFO - mozdevice == 0.48 13:15:25 INFO - mozfile == 1.2 13:15:25 INFO - mozhttpd == 0.7 13:15:25 INFO - mozinfo == 0.9 13:15:25 INFO - mozleak == 0.1 13:15:25 INFO - mozlog == 3.4 13:15:25 INFO - moznetwork == 0.27 13:15:25 INFO - mozprocess == 0.23 13:15:25 INFO - mozprofile == 0.28 13:15:25 INFO - mozrunner == 6.12 13:15:25 INFO - mozscreenshot == 0.1 13:15:25 INFO - mozsystemmonitor == 0.3 13:15:25 INFO - moztest == 0.7 13:15:25 INFO - mozversion == 1.4 13:15:25 INFO - psutil == 3.1.1 13:15:25 INFO - requests == 1.2.3 13:15:25 INFO - wsgiref == 0.1.2 13:15:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:25 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 0x7ff2454dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aefca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aecf60>, '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 0x1aedd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:15:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:15:25 INFO - Using env: {'DISPLAY': ':0', 13:15:25 INFO - 'HOME': '/home/cltbld', 13:15:25 INFO - 'LANG': 'en_US.UTF-8', 13:15:25 INFO - 'LANGUAGE': 'en_US:en', 13:15:25 INFO - 'LOGNAME': 'cltbld', 13:15:25 INFO - 'MAIL': '/var/mail/cltbld', 13:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:25 INFO - 'MOZ_NO_REMOTE': '1', 13:15:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:25 INFO - 'NO_EM_RESTART': '1', 13:15:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:25 INFO - 'PWD': '/builds/slave/test', 13:15:25 INFO - 'SHELL': '/bin/bash', 13:15:25 INFO - 'SHLVL': '1', 13:15:25 INFO - 'TERM': 'linux', 13:15:25 INFO - 'TMOUT': '86400', 13:15:25 INFO - 'USER': 'cltbld', 13:15:25 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 13:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:25 INFO - '_': '/tools/buildbot/bin/python'} 13:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:15:25 INFO - Cleaning up... 13:15:25 INFO - Return code: 0 13:15:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:25 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 0x7ff2454dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aefca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aecf60>, '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 0x1aedd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:15:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:15:25 INFO - Using env: {'DISPLAY': ':0', 13:15:25 INFO - 'HOME': '/home/cltbld', 13:15:25 INFO - 'LANG': 'en_US.UTF-8', 13:15:25 INFO - 'LANGUAGE': 'en_US:en', 13:15:25 INFO - 'LOGNAME': 'cltbld', 13:15:25 INFO - 'MAIL': '/var/mail/cltbld', 13:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:25 INFO - 'MOZ_NO_REMOTE': '1', 13:15:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:25 INFO - 'NO_EM_RESTART': '1', 13:15:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:25 INFO - 'PWD': '/builds/slave/test', 13:15:25 INFO - 'SHELL': '/bin/bash', 13:15:25 INFO - 'SHLVL': '1', 13:15:25 INFO - 'TERM': 'linux', 13:15:25 INFO - 'TMOUT': '86400', 13:15:25 INFO - 'USER': 'cltbld', 13:15:25 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 13:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:25 INFO - '_': '/tools/buildbot/bin/python'} 13:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:15:25 INFO - Cleaning up... 13:15:25 INFO - Return code: 0 13:15:25 INFO - Running post-action listener: _resource_record_post_action 13:15:25 INFO - Running post-action listener: _start_resource_monitoring 13:15:25 INFO - Starting resource monitoring. 13:15:25 INFO - [mozharness: 2016-10-14 20:15:25.838997Z] Finished create-virtualenv step (success) 13:15:25 INFO - [mozharness: 2016-10-14 20:15:25.839468Z] Running install step. 13:15:25 INFO - Running pre-action listener: _resource_record_pre_action 13:15:25 INFO - Running main action method: install 13:15:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:15:26 INFO - Reading from file tmpfile_stdout 13:15:26 INFO - Detecting whether we're running mozinstall >=1.0... 13:15:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:15:26 INFO - Reading from file tmpfile_stdout 13:15:26 INFO - Output received: 13:15:26 INFO - Usage: mozinstall [options] installer 13:15:26 INFO - Options: 13:15:26 INFO - -h, --help show this help message and exit 13:15:26 INFO - -d DEST, --destination=DEST 13:15:26 INFO - Directory to install application into. [default: 13:15:26 INFO - "/builds/slave/test"] 13:15:26 INFO - --app=APP Application being installed. [default: firefox] 13:15:26 INFO - mkdir: /builds/slave/test/build/application 13:15:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:15:42 INFO - Reading from file tmpfile_stdout 13:15:42 INFO - Output received: 13:15:42 INFO - /builds/slave/test/build/application/firefox/firefox 13:15:42 INFO - Running post-action listener: _resource_record_post_action 13:15:42 INFO - [mozharness: 2016-10-14 20:15:42.179839Z] Finished install step (success) 13:15:42 INFO - [mozharness: 2016-10-14 20:15:42.180083Z] Running run-tests step. 13:15:42 INFO - Running pre-action listener: _resource_record_pre_action 13:15:42 INFO - Running main action method: run_tests 13:15:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:15:42 INFO - Python 2.7.3 13:15:42 INFO - Return code: 0 13:15:42 INFO - grabbing minidump binary from tooltool 13:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:42 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 0x1aecf60>, '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 0x1aedd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:15:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:15:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:15:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:15:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:15:42 INFO - Return code: 0 13:15:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:15:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:15:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:15:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:15:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:15:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:15:42 INFO - Using env: {'DISPLAY': ':0', 13:15:42 INFO - 'HOME': '/home/cltbld', 13:15:42 INFO - 'LANG': 'en_US.UTF-8', 13:15:42 INFO - 'LANGUAGE': 'en_US:en', 13:15:42 INFO - 'LOGNAME': 'cltbld', 13:15:42 INFO - 'MAIL': '/var/mail/cltbld', 13:15:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:15:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:42 INFO - 'MOZ_NO_REMOTE': '1', 13:15:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:42 INFO - 'NO_EM_RESTART': '1', 13:15:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:42 INFO - 'PWD': '/builds/slave/test', 13:15:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:15:42 INFO - 'SHELL': '/bin/bash', 13:15:42 INFO - 'SHLVL': '1', 13:15:42 INFO - 'TERM': 'linux', 13:15:42 INFO - 'TMOUT': '86400', 13:15:42 INFO - 'USER': 'cltbld', 13:15:42 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531', 13:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:42 INFO - '_': '/tools/buildbot/bin/python'} 13:15:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:15:42 INFO - mozversion application_buildid: 20161014113235 13:15:42 INFO - mozversion application_changeset: 905f1bc96fb67f7a827387203cb5cafce70b67bf 13:15:42 INFO - mozversion application_display_name: Nightly 13:15:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:15:42 INFO - mozversion application_name: Firefox 13:15:42 INFO - mozversion application_remotingname: firefox 13:15:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 13:15:42 INFO - mozversion application_vendor: Mozilla 13:15:42 INFO - mozversion application_version: 52.0a1 13:15:42 INFO - mozversion platform_buildid: 20161014113235 13:15:42 INFO - mozversion platform_changeset: 905f1bc96fb67f7a827387203cb5cafce70b67bf 13:15:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 13:15:42 INFO - mozversion platform_version: 52.0a1 13:15:42 INFO - using testdate: 1476476142 13:15:42 INFO - actual date: 1476476142 13:15:42 INFO - starting webserver on 'localhost:48852' 13:15:42 INFO - SUITE-START | Running 2 tests 13:15:42 INFO - TEST-START | dromaeo_css 13:15:42 INFO - operating with platform_type : linux_ 13:15:42 INFO - Initialising browser for dromaeo_css test... 13:15:42 INFO - TEST-INFO | started process 12192 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMsUEaI/profile http://localhost:48852/getInfo.html) 13:15:46 INFO - PROCESS | 12192 | __metrics Screen width/height:1600/1200 13:15:46 INFO - PROCESS | 12192 | colorDepth:24 13:15:46 INFO - PROCESS | 12192 | Browser inner width/height: 1024/697 13:15:46 INFO - PROCESS | 12192 | __metrics 13:15:47 INFO - PROCESS | 12192 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:15:47 INFO - PROCESS | 12192 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:15:48 INFO - PROCESS | 12192 | console.error: PushService: 13:15:48 INFO - PROCESS | 12192 | stateChangeProcessEnqueue: Error transitioning state 13:15:48 INFO - PROCESS | 12192 | UnknownError 13:15:48 INFO - TEST-INFO | 12192: exit 0 13:15:48 INFO - Browser initialized. 13:15:48 INFO - Running cycle 1/1 for dromaeo_css test... 13:15:48 INFO - TEST-INFO | started process 12275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMsUEaI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:16:00 INFO - PROCESS | 12275 | RSS: Main: 173740032 13:16:00 INFO - PROCESS | 12275 | 13:16:52 INFO - PROCESS | 12275 | 1476476212563 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:19:06 INFO - PROCESS | 12275 | Cycle 1(1): loaded http://localhost:48852/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48852/tests/dromaeo/cssquery-ext.html) 13:19:07 INFO - PROCESS | 12275 | RSS: Main: 268898304 13:19:07 INFO - PROCESS | 12275 | 13:22:10 INFO - PROCESS | 12275 | Cycle 1(1): loaded http://localhost:48852/tests/dromaeo/cssquery-ext.html (next: http://localhost:48852/tests/dromaeo/cssquery-jquery.html) 13:22:10 INFO - PROCESS | 12275 | RSS: Main: 276439040 13:22:10 INFO - PROCESS | 12275 | 13:25:13 INFO - PROCESS | 12275 | Cycle 1(1): loaded http://localhost:48852/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48852/tests/dromaeo/cssquery-mootools.html) 13:25:13 INFO - PROCESS | 12275 | RSS: Main: 220590080 13:25:13 INFO - PROCESS | 12275 | 13:28:16 INFO - PROCESS | 12275 | Cycle 1(1): loaded http://localhost:48852/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48852/tests/dromaeo/cssquery-prototype.html) 13:28:16 INFO - PROCESS | 12275 | RSS: Main: 222556160 13:28:16 INFO - PROCESS | 12275 | 13:31:19 INFO - PROCESS | 12275 | Cycle 1(1): loaded http://localhost:48852/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48852/tests/dromaeo/cssquery-yui.html) 13:31:20 INFO - PROCESS | 12275 | RSS: Main: 220000256 13:31:20 INFO - PROCESS | 12275 | 13:34:23 INFO - PROCESS | 12275 | Cycle 1(1): loaded http://localhost:48852/tests/dromaeo/cssquery-yui.html (next: http://localhost:48852/tests/dromaeo/cssquery-dojo.html) 13:34:23 INFO - PROCESS | 12275 | RSS: Main: 313352192 13:34:23 INFO - PROCESS | 12275 | 13:34:23 INFO - PROCESS | 12275 | __start_tp_report 13:34:23 INFO - PROCESS | 12275 | _x_x_mozilla_page_load 13:34:23 INFO - PROCESS | 12275 | _x_x_mozilla_page_load_details 13:34:23 INFO - PROCESS | 12275 | |i|pagename|runs| 13:34:23 INFO - PROCESS | 12275 | |0;dojo.html;2617.136345006148;2632.1313966391094;2651.549236629772;2674.304680782996;2684.3691732442885;4519.480259770127;4618.653600979932;4719.882002949928;4723.669343145981;4758.1435341638535;4649.9070018599605;4651.093036857814;4664.976675116628;4668.62650987921;4672.696274742139;4286.057067445157;4314;4317.13657268546;4338.566143385668;4345.978270108645;4323.286657701476;4353.499347575022;4358.825646974117;4360.454943132108;4365.738055716652;4351.0862718829085;4358.193734159175;4366.541513141122;4387.956120438803;4448.154850578379;4450.532694067108;4461.107778444291;4466.464024317071;4466.57567531084;4491.101779644085;4210.347396153601;4245.129748401601;4251.766152861592;4373.562643735601;4428.667849911238;4638.1187574360765;4640.118377508296;4641.605463535603;4660.813567457298;4665.160271151191;4968.354113965162;4993.600511959071;5002.649814512985;5014.498550144993;5067.34124563808;4883.316335713003;4947.703137811779;5011.072951503984;5059.16523773577;5079.060373830816;4657.720536767804;4737.076270127292;4776.259679749644;4779.689320194177;4855.028994201174;5249.42256351801;5254.290670759475;5256.6057545684225;5256.9737151314;5258.237555554423;5043.646944713835;5044.747762611854;5045.142325804622;5048.949510504848;5096.6941983480365;4934.925976110361;4970.925436118461;4974.900501990012;5039.370078740158;5073.822416215415;5039.067772462106;5042.6470147090085;5088.745562721849;5103.18349064148;5107.923381149286;4977.576905962961;5013.473585273567;5017.422996355393;5029.270755740397;5085.7202853842655;4046.1300820323772;4070.5115386153257;4072.9185416291507;4196.097838964637;4239.830406783756;3662.1393972416463;3693.8522459101873;3694.9261014779554;3705.481232627434;3747.063234191452;4416.315471101984;4416.845410410684;4432.645388368923;4462.843800466968;4489.663275254304;4922.9753851231235;5087.592992560586;5098.694078355311;5099.413567439718;5101.795928162906;4345.174416860849;4391.978040109779;4400.075984043323;4423.845165419195;4432.556744325606;4508.256137737237;4520.50274469808;4524.615407690383;4567.543245675406;4577.977110114428;4849.563539281482;4849.903001940012;4861.076395484846;4869.123557759637;4928.088303663833;4910.508949105061;4944.8763780905765;4949.529794669501;5011.624128190473;5048.621353398436;4839.806407743651;4845.830395936126;4855.150348689036;4906.215005599087;4912.729799861042;5041.6722913010535;5042.218456139158;5046.142155833444;5058.34241548611;5110.9233361500355;4914.5822605078965;5028.698278103326;5047.545720885138;5110.437851836221;5190.688558686491;4913.263010548446;4966.255061740768;4976.800927962986;5031.396232452129;5041.42023667283;4953.900921981468;4958.082754690394;4963.230699241623;4976.10430122567;5033.546980771602;4785.396892041205;4838.346823178967;4870.269459581091;4893.266010098514;4948.109340318777;4946.03552307311;4979.775910083982;4986.15235409974;4993.450720420678;5065.366829146356;4838.2016967201425;4877.439094504036;4883.975580122076;4897.608191344755;4950.900981980412 13:34:23 INFO - PROCESS | 12275 | |1;ext.html;564.4609398024886;575.0913556580603;575.7840809696363;576.5935015813849;578.4764787866982;27289.863550682243;27888.860555697218;38225.808870955676;38691.80654096733;38871.611283887156;39242;39412.40881386781;39520.60479395205;39545;39564.60435395645;7423.443241756876;7567.918822323877;7568.886466703004;7569;7592.126905405866;7556.962215188943;7638.045244344457;7638.350740187091;7649.120351159604;7690.077190737092;7684.116326622454;7715.614219289041;7734.303912647861;7737.110232323271;7738.18749031352;7672.386209103258;7698.2686644768655;7713.730019449348;7714.922850771477;7720.691172353099;7684.769456916246;7726.420518461138;7734.071911370615;7744.922550774477;7746.883796743054;36700.44949325762;37199;37296.62703372959;37338;37398.626013739784;2882.509973304543;3101.3332133591384;3173.254285242989;3242.1084201844446;3343.147497388175;26650.866745666342;27064.864675676494;27312.86343568289;27352.316192095157;27443.276397282792;3417.6411476795074;3505.0886769439876;3543.7519373643854;3600.963990360089;3647.908802279938;237051;237689;239298;239362;240177;30946.690533094832;49187.75406122946;49222.261666075035;49554.504454954986;49637;31306.37387252242;32654.183645409055;32825.83587082049;32909.50635740466;32958.3408331832;11985.101117416229;12197.817032744517;12204.755904881853;12210.26738395699;12218.144729869002;9604.135627793532;9663.13031827139;9663.758406039764;9667.758306042406;9679.128878400978;7594;7670.654820533089;7747.845043099106;7755.612219389121;7759.107702614158;3031.7726170536857;3042.8478576071107;3059.801112927697;3082.830444325539;3097.984510077435;827.8261565071402;856.4647095565272;868.8392647360258;868.9652413903373;952.5046975572664;26230.34424139412;26661.800583930053;26715.465690686076;26920.865395672896;27043.594346084825;775.0623441396509;894.5706061090713;949.990500095004;991.2169386184834;1001.4692213127055;13950.511732089328;14162.929185354007;14470.158585237034;14508.637284067772;14652.267386630625;338654;339402;339464;339903;340130;48470;48763;48806.755966220655;48874.75562622164;48945;1066.0938202527789;1087.075985412393;1093.7593729379682;1160.3965937712342;1178.1752773058893;28216.29459263535;30655.386892261584;30829.845850770602;31261.218469538442;31279;43931.78034109809;44177.33733994057;44532;44575;44654.553454465036;296353;300370;300736;301245;301928;24573.38566535851;39000.6099938997;40016.1996760069;40959.79520102381;42920.35619465648;38297.4255386175;38745.6125438742;39072.6092739069;42832.78583607187;42892.78553607337;35528.28943421065;36202.27595448129;36256.456153157196;36585.45121823228;36633.63366366302;35949.82025089858;35966.640333596326;36181.81909090543;36761.26477470489;36775.816120919226;34751.4787278186;35216;35857;36043.09892252715;36206.818965905004;29736.851315743283;31826.840865795522;32097.839510802296;32507.512387314684;32572.674273256966;25013.749862501143;25366.49267014686;25399;25432.74567254304;25775 13:34:23 INFO - PROCESS | 12275 | |2;jquery.html;336.36930754834685;348.2165128460963;360.7727131906899;364.93796054670696;379.46116514549357;12374.814377784329;13292.13601115928;15640.843591564095;16530.669386612262;17761.46715598531;16739.83260167398;16956.49130526086;17322.13389330535;17506.737398939025;17616.295348186057;3921.9803900980596;4897.24092765621;5125.12872811621;5127.743612819363;5172.534471897528;4925.532074452921;5061.519155680223;5065.696058236517;5066.898662026757;5068.315777370063;4796.4244290685165;5031.27046578246;5032;5034.42104158021;5036.874078148057;5018.698878067327;5024.648274620778;5025.04524140414;5031.22016087507;5041.445441001487;4475.641948644134;4476.261416866213;4481.462224533045;4481.484629267643;4493.460784705823;12383.876161238453;13736.381862816197;19799.208031678714;20343.5931281375;20397.694034589495;1729.161356741979;1874.7843997940274;1918.7985261547476;2000.2299114840746;2268.26281458525;9171.403858749227;9192.540372981392;9400.059994000614;9551.761205969837;10423.895761042368;1573.7403328450791;1630.9592260193472;1672.1137796967625;1747.021667865999;1750.3523696232348;44323.77838110821;70248.6487567564;70461;71001.64499177523;72633;9316.394434361744;9782.854669067412;9869.703908882744;9998.900010999942;10128.44293563861;13808.17150970925;13824.516141934984;13839.861601383856;13842.238676872868;13867.306634668428;6949.374556289857;7093.255208203064;7154.39187669054;7299.087614048244;7335.669894854745;6366.204224471941;6544.59680965895;6601.3728695773825;6745.865082698417;6758.155230596176;4255.5744425557195;4261.083866968616;4299.892502687458;4332.436783218224;4388.407564978751;1780.6349698311815;1791.2208189437636;1805.7020591602238;1811.6829554827852;1838.8896666200071;627.996860015697;811.7361857396252;855.2217482091268;891.1133422244908;911.2573252799081;15999.520014399586;16497.257623406735;16768.161591920354;17234.224459899335;17955.820441795415;832.1553623072465;841.9115992820788;852.8507511185518;854.4104567848165;865.2818160926416;9335.626574936927;9598.568064437117;9826.950865245628;9851.211903047739;9988.850167247498;362584;366738;371968;372192;372343;45320.773396132805;45787.31319030217;71950.64024679843;81748;82870.99999999879;842.3429724814654;869.9086595907338;873.0440168016012;879.2394578689388;879.4986857491297;15431;15568.922155389151;16165.838341616432;16318.265678044754;16416;24552.263432097065;25422.74577254204;34952.300953980266;35324.11689707778;36424.453633196055;52094.739526302124;52354.738226310146;52507.47492525026;52663;52914;7588.506747061423;7654.961725191339;7765.72819951299;7809.609519524115;7817.0619525657285;9256.49089300095;11588.768224635629;11883.940580297043;11967.461464234304;12062.396880156133;9501.809963800824;10116.342437741523;10216.846747298945;10261.179105671677;10346.22403319769;10151.847722284025;10154.339967902062;10157.84763228567;10218.540165692413;10260.948695256477;9377.85933211016;9928.453935033642;9999.950000249952;10060.346077505232;10365.533550990072;7565.508241964255;7751.263629955145;7801.843963120819;7827.882581761392;7958.124606293419;8984.55077246122;9871.210303175872;10115.797684046425;10165.237607179639;10246.436445995541 13:34:23 INFO - PROCESS | 12275 | |3;mootools.html;1341.8993575481836;1398.4615922869696;1470.8970372073952;1641.458318754811;1694.5848267174536;6661.500387470935;6919;7231.89152162718;7653.923460765391;7667.118281397634;7232.710691572331;7530.58581778002;7552.1692613812575;7717.536947783137;7722.459427840054;2149.1833103420677;2182.0835249195297;2183.650615901456;2186.169255682846;2187;1859.5165257033202;1946.13397038318;2122.9363119106374;2176.4776453651166;2182.432567532445;1862.236483041953;1889.1309997401213;2077.0757013129164;2138.1447421031557;2143.732033495813;2080.5734824361043;2084.280923081542;2099.4331530486834;2100.1179504608103;2107.504736386948;2045.243259993797;2059;2076.9169233230655;2080.365488525999;2083.114676262582;7663.31030207284;7705.6917723291;7723.53658780475;7730.304272615435;7733.7679869604;4433.113377324516;4648.209804333272;4692.061587682477;4719.646026548023;4724.527547245282;2857.2428306498796;2957.512010518262;3018.351054523288;3026.228311780504;3037.331787006855;888.4108202860436;945.7635591102224;960.4477425480306;963.036963036963;963.7397902566338;10170.491475426199;10215.642452514201;10232.744181395525;10243.385396876136;10261.973802619754;3977.3636218204947;4062.8171732272117;4246.278132717445;4313.956860431418;4327.826886924488;8887.15572020657;8887.200151986352;8890.511021893857;8893.28853691703;8899.02110767815;4689.577937985598;4693.929591056137;4696.8590942271785;4697.859064228079;4698.271767875985;4211.620954114144;4259.339802330644;4259.403683484315;4268.914621707549;4285.700000999963;3527.8941631750577;3553.076200187918;3654.926901461956;3672.2839046385698;3689.538807649044;1145.095374654014;1162.8139497680331;1174.9530018799153;1186.596557170549;1187.2223693480785;657.2244751193542;772.5017363800317;781.7029528779027;784.282381620822;807.2129673568224;4928.975355123202;5051.949480505222;5076.695398276115;5135.486451354835;5372.221027950925;413.80964756211876;416.90202802341423;419.50917426610937;421.19341461101646;423.51084497405543;3428;3436.862525499002;3438.5529881115795;3492.738044646662;3675.889723308305;8877.245434138042;9304.95347523258;9317.860232096524;9324.906750932403;9325.347225694271;9271.304652151115;9275.118863707938;9282.30382721285;9289.071092890657;9296.30277729173;7180.281971802778;7250.854982900418;7289.890651640229;7296.635168241567;7300.16048154469;5060.468650791614;5211.635185536976;5347.491988261109;5475.589330800126;5620.606557540933;8256.174382561696;8433.114522975;8522.531260780717;8594.398392112493;8640.913590864262;8694.565271736514;8723.302135828992;8791.912080879109;8812.118788121137;9014.819703606023;6485.092087107903;6590.209174899042;6593.8131136395905;6602.6698665067515;6604.471642268511;6942.757003504853;7179.676914538963;7222.530535515175;7265.9273407265255;7289.380402665833;6597.0764093026055;6666.2333831609985;6667.19993600771;6668.199816022108;6850.3149685033095;6397.808065758035;6580.934190658032;6595.043718660863;6715.93284067153;6763.93236067633;5814.73833677494;5900.1149827526215;5946.137810017437;5948.970255148696;5952.940470595238;4126.546079931265;4194.266003449445;4195.307774217342;4206.116715489659;4382.189294980311;4263.93604095945;4267.80794864238;4340.066885619607;4373.562643735601;4454.4877339106415 13:34:23 INFO - PROCESS | 12275 | |4;prototype.html;288.17581716291403;290.83131783565534;300.86912193195946;301.48747129879195;303.64928507573734;4674.85975420737;4820.421549414066;4837.80648774049;4850.490698476658;4873.537013983675;4715.764211789414;4729.929051064237;4745.311929770181;4762.547557981995;4770.236762118053;3494.668006539375;3629.4192929131345;3654.9817250913707;3736.626337366255;3748.5876553579083;3570.964420318118;3620.4931309616672;3623.202895363016;3736.7010639148803;3758.2107757370986;3679.5584529856455;3682.9927689409337;3684.042149041255;3693.205960718445;3714.962850371489;3695.427208782643;3703.2963736889906;3703.611120832314;3714.591394946554;3732.309522738302;3191.4734068878606;3229.3864165808654;3246.5779448671756;3253.723433508155;3255.128301226804;4585.014221942265;4589.862304130881;4605.30920361945;4611.169989401907;4614.492405835355;4228.619424251832;4236.385724070024;4236.703430759848;4242.5121111072;4249.893752656209;4660.508637236086;4912.140375434285;4939.209726443752;4998;5001.8499445016705;3515.701165400944;3523.8766643167623;3525.171584677624;3529.711655245817;3547.130952916552;5200.141976573861;5208.5572726318305;5214.348206474191;5215.8174463893965;5239.528442440199;3593.5508061492314;3602.9819850900576;3614.8793873899176;3623.2753449309716;3624.4563315502887;3566.1262990567475;3627.093226693327;3651.6348365163803;3655.981720091436;3657.0743405276203;4154.729942553724;4158.688098392572;4170.374443833389;4170.416141740159;4200.558941311179;4882.414110306786;4927.482614325516;4947.183714687037;4962.774196772127;4989.151844186497;1184.899283560907;1236.9319687417278;1247.133242396544;1263.2925561685486;1267.3536496386726;797.696875187425;804.047204063187;808.6495552427343;809.6032943857467;818.7912082418945;3966.147278335172;3966.9768418106974;3969.047428617111;4298.183345164409;4428.4243048403505;4972.955679307313;5068.265101560253;5086.21163719624;5095.617828662791;5115.693058416507;4471.630036080883;4475.820967161342;4482;4487.573680500347;4497.572730590588;2576.7680908718307;2674.7860171186258;2687.6774787025292;2703.635009273762;2705.78353731701;4861.927071093936;4880.707157570557;4881.194602890483;4883.316335713003;4908.631852611068;5213.191955246943;5236.240745092016;5298.125809241432;5298.443663415286;5330.866728331745;4666.733286699324;4843.4430040545785;4879.829205977845;4910.877228069256;4973.856013116931;5050.520200580939;5061;5089.287499749964;5092.694438333712;5103.132467480612;5005.824796132118;5026.59787217029;5038.974805125951;5045.445001049955;5046.293518907282;4648.721076735406;4913.385826771653;4926.187179115549;4927.457979622311;4951.207806750903;3604.2971620533744;3642.3990041642833;3644.4168932971656;3651.2697460507475;3656.3784156692896;5231.738413079407;5232.738363081907;5237.738113094406;5248.947510524846;5249.527542521191;4934.235193545006;5026.824061157842;5066.771995260148;5085.5931525477135;5085.821996230115;4973.651844370859;4978.626603004716;4979.829740011167;4989.12690279207;5021.974890125526;4907.730074845917;4918.6802857815555;4923.655344125877;4924.901501970012;4957.182064959241;4842.7820748065715;4999.075171093359;5012.223105418666;5027.974860125676;5049.84850454487;4689.882752931204;4798;4799.640026998059;4934.358533390637;4936.531029552187 13:34:23 INFO - PROCESS | 12275 | |5;yui.html;539.9514043736064;635.6027482823235;652.3118407486717;681.3749208138585;748.0649188514357;13028.934855325722;13917.860821391783;13979.440822367118;14043.36804843782;14131.222782746945;12693.428795704192;12936.417861196245;13032.93483532581;13081.67295817605;13088.869111308884;783.8510682970245;802.6869520886859;805.5931754463987;807.7294106474309;808.1716240853114;631.8641492079201;649.4317472211815;650.5836264790538;653.4119292636617;795.097564264561;686.8969654551807;800.771780042688;828.1966492502263;828.8715249136394;833.7332053742805;820.2535692519779;821.5604651511443;821.5974172655416;821.8685010398337;822.0628483528782;597.0804960361039;599.0086406996428;599.1641659884436;599.3946114424419;599.7001499250375;9901.405915645084;10246.795064098751;12399.380030998414;12696.555620553328;12746;12044.939775301067;13366.198028118344;13390.598282051456;13540.255285959269;13711.931440342734;10287.12559432449;10338;10373.896261037444;10475.84286235707;10484.213683973732;3271.4765637498126;3302.669733026702;3370.6629337066342;3377.9662203377898;3474.3746125697367;58132.418675813125;58726.11910821341;58882;59480;60369.6981515094;8837.425567338103;8906.55467226636;8938.731838044869;8953;9022.684206052756;17778.822211777977;17947.820521794874;17972.730409043874;17987;18475.445736627924;6171.907421388682;6389.169407976933;6485.935140648628;6499.447546958561;6588.275289718127;3492.5634295713035;3496.1281151525354;3512.438009918401;3570.625084366156;3578.499010138583;3021.5014522603965;3110.3001824589287;3130.6712795156636;3134.5611614374006;3141.513065474855;531.6278604976454;540.2733323679645;544.27067729243;545.0679338331419;559.2589818490517;614.3733391940196;627.6234259444296;629.8299459146097;639.4404895716249;645.0872016097263;8102.675892964333;8103.918960810316;8259.339252859876;8283.420160588701;8472.290215903622;612.7579606055672;616.3220457496718;617.1144407774857;630.1870586942792;630.3066626710673;3821.7898015608853;4027.7154678231277;4120.814563344657;4149.605787450248;4294.377315289265;77945.61027194827;97061.5146924275;97436;97487;100012.49993749984;70651.64674176596;89465.55267223752;90490.54754726184;90865;92415.53792230996;80706.59646701728;81028.59485702534;81221.78167327495;82247.5887620558;82906.17093828984;8546.2308392245;8574.485530868167;8859.468431894107;8870.42342247752;9360.15758581731;40239;42545;43284;44541.10917781561;45672.54327456683;55561.722191388784;57292.140617889934;70118.49407529706;70205.64897175481;71600;12312.630621081382;12376.257424554555;12412.875871241173;12494.562690306158;12604.55884044054;12977.221366718028;13011.089223754625;13062.216267024009;13366.465341386625;13481.528146514825;11513.194076414571;12562.623121306375;12700.188824393033;12830.704322283658;12955.093143479866;11565.537378504765;11580.768384632429;13231.404586793426;13655.453781848615;13781.517646882712;11712.297262164297;12170.939145304217;12195.695107622381;12303.93848030754;12458.688532786391;9465.47939863314;10034.899651003396;10077.647282345377;10119.645812396531;10282.126019288444;8741.519216443157;8757.299416046828;9194.49430281341;9973.451460169761;9997.100260976547 13:34:23 INFO - PROCESS | 12275 | __end_tp_report 13:34:23 INFO - PROCESS | 12275 | __start_cc_report 13:34:23 INFO - PROCESS | 12275 | _x_x_mozilla_cycle_collect,998 13:34:23 INFO - PROCESS | 12275 | __end_cc_report 13:34:23 INFO - PROCESS | 12275 | __startTimestamp1476477263699__endTimestamp 13:34:23 INFO - PROCESS | 12275 | 13:34:23 INFO - PROCESS | 12275 | ------- Summary: start ------- 13:34:23 INFO - PROCESS | 12275 | Number of tests: 6 13:34:23 INFO - PROCESS | 12275 | 13:34:23 INFO - PROCESS | 12275 | [#0] dojo.html Cycles:165 Average:4680.31 Median:4855.15 stddev:498.04 (10.3%) stddev-sans-first:472.54 13:34:23 INFO - PROCESS | 12275 | Values: 2617.1 2632.1 2651.5 2674.3 2684.4 4519.5 4618.7 4719.9 4723.7 4758.1 4649.9 4651.1 4665.0 4668.6 4672.7 4286.1 4314.0 4317.1 4338.6 4346.0 4323.3 4353.5 4358.8 4360.5 4365.7 4351.1 4358.2 4366.5 4388.0 4448.2 4450.5 4461.1 4466.5 4466.6 4491.1 4210.3 4245.1 4251.8 4373.6 4428.7 4638.1 4640.1 4641.6 4660.8 4665.2 4968.4 4993.6 5002.6 5014.5 5067.3 4883.3 4947.7 5011.1 5059.2 5079.1 4657.7 4737.1 4776.3 4779.7 4855.0 5249.4 5254.3 5256.6 5257.0 5258.2 5043.6 5044.7 5045.1 5048.9 5096.7 4934.9 4970.9 4974.9 5039.4 5073.8 5039.1 5042.6 5088.7 5103.2 5107.9 4977.6 5013.5 5017.4 5029.3 5085.7 4046.1 4070.5 4072.9 4196.1 4239.8 3662.1 3693.9 3694.9 3705.5 3747.1 4416.3 4416.8 4432.6 4462.8 4489.7 4923.0 5087.6 5098.7 5099.4 5101.8 4345.2 4392.0 4400.1 4423.8 4432.6 4508.3 4520.5 4524.6 4567.5 4578.0 4849.6 4849.9 4861.1 4869.1 4928.1 4910.5 4944.9 4949.5 5011.6 5048.6 4839.8 4845.8 4855.2 4906.2 4912.7 5041.7 5042.2 5046.1 5058.3 5110.9 4914.6 5028.7 5047.5 5110.4 5190.7 4913.3 4966.3 4976.8 5031.4 5041.4 4953.9 4958.1 4963.2 4976.1 5033.5 4785.4 4838.3 4870.3 4893.3 4948.1 4946.0 4979.8 4986.2 4993.5 5065.4 4838.2 4877.4 4884.0 4897.6 4950.9 13:34:23 INFO - PROCESS | 12275 | 13:34:23 INFO - PROCESS | 12275 | [#1] ext.html Cycles:180 Average:43987.31 Median:20116.68 stddev:77715.53 (386.3%) stddev-sans-first:77865.16 13:34:23 INFO - PROCESS | 12275 | Values: 564.5 575.1 575.8 576.6 578.5 27289.9 27888.9 38225.8 38691.8 38871.6 39242.0 39412.4 39520.6 39545.0 39564.6 7423.4 7567.9 7568.9 7569.0 7592.1 7557.0 7638.0 7638.4 7649.1 7690.1 7684.1 7715.6 7734.3 7737.1 7738.2 7672.4 7698.3 7713.7 7714.9 7720.7 7684.8 7726.4 7734.1 7744.9 7746.9 36700.4 37199.0 37296.6 37338.0 37398.6 2882.5 3101.3 3173.3 3242.1 3343.1 26650.9 27064.9 27312.9 27352.3 27443.3 3417.6 3505.1 3543.8 3601.0 3647.9 237051.0 237689.0 239298.0 239362.0 240177.0 30946.7 49187.8 49222.3 49554.5 49637.0 31306.4 32654.2 32825.8 32909.5 32958.3 11985.1 12197.8 12204.8 12210.3 12218.1 9604.1 9663.1 9663.8 9667.8 9679.1 7594.0 7670.7 7747.8 7755.6 7759.1 3031.8 3042.8 3059.8 3082.8 3098.0 827.8 856.5 868.8 869.0 952.5 26230.3 26661.8 26715.5 26920.9 27043.6 775.1 894.6 950.0 991.2 1001.5 13950.5 14162.9 14470.2 14508.6 14652.3 338654.0 339402.0 339464.0 339903.0 340130.0 48470.0 48763.0 48806.8 48874.8 48945.0 1066.1 1087.1 1093.8 1160.4 1178.2 28216.3 30655.4 30829.8 31261.2 31279.0 43931.8 44177.3 44532.0 44575.0 44654.6 296353.0 300370.0 300736.0 301245.0 301928.0 24573.4 39000.6 40016.2 40959.8 42920.4 38297.4 38745.6 39072.6 42832.8 42892.8 35528.3 36202.3 36256.5 36585.5 36633.6 35949.8 35966.6 36181.8 36761.3 36775.8 34751.5 35216.0 35857.0 36043.1 36206.8 29736.9 31826.8 32097.8 32507.5 32572.7 25013.7 25366.5 25399.0 25432.7 25775.0 13:34:23 INFO - PROCESS | 12275 | 13:34:23 INFO - PROCESS | 12275 | [#2] jquery.html Cycles:180 Average:22986.26 Median:4487.47 stddev:60907.94 (1357.3%) stddev-sans-first:61055.06 13:34:23 INFO - PROCESS | 12275 | Values: 336.4 348.2 360.8 364.9 379.5 12374.8 13292.1 15640.8 16530.7 17761.5 16739.8 16956.5 17322.1 17506.7 17616.3 3922.0 4897.2 5125.1 5127.7 5172.5 4925.5 5061.5 5065.7 5066.9 5068.3 4796.4 5031.3 5032.0 5034.4 5036.9 5018.7 5024.6 5025.0 5031.2 5041.4 4475.6 4476.3 4481.5 4481.5 4493.5 12383.9 13736.4 19799.2 20343.6 20397.7 1729.2 1874.8 1918.8 2000.2 2268.3 9171.4 9192.5 9400.1 9551.8 10423.9 1573.7 1631.0 1672.1 1747.0 1750.4 44323.8 70248.6 70461.0 71001.6 72633.0 9316.4 9782.9 9869.7 9998.9 10128.4 13808.2 13824.5 13839.9 13842.2 13867.3 6949.4 7093.3 7154.4 7299.1 7335.7 6366.2 6544.6 6601.4 6745.9 6758.2 4255.6 4261.1 4299.9 4332.4 4388.4 1780.6 1791.2 1805.7 1811.7 1838.9 628.0 811.7 855.2 891.1 911.3 15999.5 16497.3 16768.2 17234.2 17955.8 832.2 841.9 852.9 854.4 865.3 9335.6 9598.6 9827.0 9851.2 9988.9 362584.0 366738.0 371968.0 372192.0 372343.0 45320.8 45787.3 71950.6 81748.0 82871.0 842.3 869.9 873.0 879.2 879.5 15431.0 15568.9 16165.8 16318.3 16416.0 24552.3 25422.7 34952.3 35324.1 36424.5 52094.7 52354.7 52507.5 52663.0 52914.0 7588.5 7655.0 7765.7 7809.6 7817.1 9256.5 11588.8 11883.9 11967.5 12062.4 9501.8 10116.3 10216.8 10261.2 10346.2 10151.8 10154.3 10157.8 10218.5 10260.9 9377.9 9928.5 10000.0 10060.3 10365.5 7565.5 7751.3 7801.8 7827.9 7958.1 8984.6 9871.2 10115.8 10165.2 10246.4 13:34:23 INFO - PROCESS | 12275 | 13:34:23 INFO - PROCESS | 12275 | [#3] mootools.html Cycles:180 Average:4993.44 Median:4990.46 stddev:2791.26 (55.9%) stddev-sans-first:2785.60 13:34:23 INFO - PROCESS | 12275 | Values: 1341.9 1398.5 1470.9 1641.5 1694.6 6661.5 6919.0 7231.9 7653.9 7667.1 7232.7 7530.6 7552.2 7717.5 7722.5 2149.2 2182.1 2183.7 2186.2 2187.0 1859.5 1946.1 2122.9 2176.5 2182.4 1862.2 1889.1 2077.1 2138.1 2143.7 2080.6 2084.3 2099.4 2100.1 2107.5 2045.2 2059.0 2076.9 2080.4 2083.1 7663.3 7705.7 7723.5 7730.3 7733.8 4433.1 4648.2 4692.1 4719.6 4724.5 2857.2 2957.5 3018.4 3026.2 3037.3 888.4 945.8 960.4 963.0 963.7 10170.5 10215.6 10232.7 10243.4 10262.0 3977.4 4062.8 4246.3 4314.0 4327.8 8887.2 8887.2 8890.5 8893.3 8899.0 4689.6 4693.9 4696.9 4697.9 4698.3 4211.6 4259.3 4259.4 4268.9 4285.7 3527.9 3553.1 3654.9 3672.3 3689.5 1145.1 1162.8 1175.0 1186.6 1187.2 657.2 772.5 781.7 784.3 807.2 4929.0 5051.9 5076.7 5135.5 5372.2 413.8 416.9 419.5 421.2 423.5 3428.0 3436.9 3438.6 3492.7 3675.9 8877.2 9305.0 9317.9 9324.9 9325.3 9271.3 9275.1 9282.3 9289.1 9296.3 7180.3 7250.9 7289.9 7296.6 7300.2 5060.5 5211.6 5347.5 5475.6 5620.6 8256.2 8433.1 8522.5 8594.4 8640.9 8694.6 8723.3 8791.9 8812.1 9014.8 6485.1 6590.2 6593.8 6602.7 6604.5 6942.8 7179.7 7222.5 7265.9 7289.4 6597.1 6666.2 6667.2 6668.2 6850.3 6397.8 6580.9 6595.0 6715.9 6763.9 5814.7 5900.1 5946.1 5949.0 5952.9 4126.5 4194.3 4195.3 4206.1 4382.2 4263.9 4267.8 4340.1 4373.6 4454.5 13:34:23 INFO - PROCESS | 12275 | 13:34:23 INFO - PROCESS | 12275 | [#4] prototype.html Cycles:180 Average:4130.33 Median:4722.85 stddev:1215.88 (25.7%) stddev-sans-first:1184.60 13:34:23 INFO - PROCESS | 12275 | Values: 288.2 290.8 300.9 301.5 303.6 4674.9 4820.4 4837.8 4850.5 4873.5 4715.8 4729.9 4745.3 4762.5 4770.2 3494.7 3629.4 3655.0 3736.6 3748.6 3571.0 3620.5 3623.2 3736.7 3758.2 3679.6 3683.0 3684.0 3693.2 3715.0 3695.4 3703.3 3703.6 3714.6 3732.3 3191.5 3229.4 3246.6 3253.7 3255.1 4585.0 4589.9 4605.3 4611.2 4614.5 4228.6 4236.4 4236.7 4242.5 4249.9 4660.5 4912.1 4939.2 4998.0 5001.8 3515.7 3523.9 3525.2 3529.7 3547.1 5200.1 5208.6 5214.3 5215.8 5239.5 3593.6 3603.0 3614.9 3623.3 3624.5 3566.1 3627.1 3651.6 3656.0 3657.1 4154.7 4158.7 4170.4 4170.4 4200.6 4882.4 4927.5 4947.2 4962.8 4989.2 1184.9 1236.9 1247.1 1263.3 1267.4 797.7 804.0 808.6 809.6 818.8 3966.1 3967.0 3969.0 4298.2 4428.4 4973.0 5068.3 5086.2 5095.6 5115.7 4471.6 4475.8 4482.0 4487.6 4497.6 2576.8 2674.8 2687.7 2703.6 2705.8 4861.9 4880.7 4881.2 4883.3 4908.6 5213.2 5236.2 5298.1 5298.4 5330.9 4666.7 4843.4 4879.8 4910.9 4973.9 5050.5 5061.0 5089.3 5092.7 5103.1 5005.8 5026.6 5039.0 5045.4 5046.3 4648.7 4913.4 4926.2 4927.5 4951.2 3604.3 3642.4 3644.4 3651.3 3656.4 5231.7 5232.7 5237.7 5248.9 5249.5 4934.2 5026.8 5066.8 5085.6 5085.8 4973.7 4978.6 4979.8 4989.1 5022.0 4907.7 4918.7 4923.7 4924.9 4957.2 4842.8 4999.1 5012.2 5028.0 5049.8 4689.9 4798.0 4799.6 4934.4 4936.5 13:34:23 INFO - PROCESS | 12275 | 13:34:23 INFO - PROCESS | 12275 | [#5] yui.html Cycles:180 Average:17911.04 Median:28925.70 stddev:25706.64 (88.9%) stddev-sans-first:25745.67 13:34:23 INFO - PROCESS | 12275 | Values: 540.0 635.6 652.3 681.4 748.1 13028.9 13917.9 13979.4 14043.4 14131.2 12693.4 12936.4 13032.9 13081.7 13088.9 783.9 802.7 805.6 807.7 808.2 631.9 649.4 650.6 653.4 795.1 686.9 800.8 828.2 828.9 833.7 820.3 821.6 821.6 821.9 822.1 597.1 599.0 599.2 599.4 599.7 9901.4 10246.8 12399.4 12696.6 12746.0 12044.9 13366.2 13390.6 13540.3 13711.9 10287.1 10338.0 10373.9 10475.8 10484.2 3271.5 3302.7 3370.7 3378.0 3474.4 58132.4 58726.1 58882.0 59480.0 60369.7 8837.4 8906.6 8938.7 8953.0 9022.7 17778.8 17947.8 17972.7 17987.0 18475.4 6171.9 6389.2 6485.9 6499.4 6588.3 3492.6 3496.1 3512.4 3570.6 3578.5 3021.5 3110.3 3130.7 3134.6 3141.5 531.6 540.3 544.3 545.1 559.3 614.4 627.6 629.8 639.4 645.1 8102.7 8103.9 8259.3 8283.4 8472.3 612.8 616.3 617.1 630.2 630.3 3821.8 4027.7 4120.8 4149.6 4294.4 77945.6 97061.5 97436.0 97487.0 100012.5 70651.6 89465.6 90490.5 90865.0 92415.5 80706.6 81028.6 81221.8 82247.6 82906.2 8546.2 8574.5 8859.5 8870.4 9360.2 40239.0 42545.0 43284.0 44541.1 45672.5 55561.7 57292.1 70118.5 70205.6 71600.0 12312.6 12376.3 12412.9 12494.6 12604.6 12977.2 13011.1 13062.2 13366.5 13481.5 11513.2 12562.6 12700.2 12830.7 12955.1 11565.5 11580.8 13231.4 13655.5 13781.5 11712.3 12170.9 12195.7 12303.9 12458.7 9465.5 10034.9 10077.6 10119.6 10282.1 8741.5 8757.3 9194.5 9973.5 9997.1 13:34:23 INFO - PROCESS | 12275 | -------- Summary: end -------- 13:34:23 INFO - PROCESS | 12275 | 13:34:24 INFO - TEST-INFO | 12275: exit 0 13:34:24 INFO - TEST-OK | dromaeo_css | took 1122312ms 13:34:24 INFO - TEST-START | kraken 13:34:24 INFO - operating with platform_type : linux_ 13:34:24 INFO - Initialising browser for kraken test... 13:34:24 INFO - TEST-INFO | started process 12584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq4yzL5/profile http://localhost:48852/getInfo.html) 13:34:29 INFO - PROCESS | 12584 | __metrics Screen width/height:1600/1200 13:34:29 INFO - PROCESS | 12584 | colorDepth:24 13:34:29 INFO - PROCESS | 12584 | Browser inner width/height: 1024/697 13:34:29 INFO - PROCESS | 12584 | __metrics 13:34:29 INFO - PROCESS | 12584 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:34:29 INFO - PROCESS | 12584 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:34:30 INFO - PROCESS | 12584 | console.error: PushService: 13:34:30 INFO - PROCESS | 12584 | stateChangeProcessEnqueue: Error transitioning state 13:34:30 INFO - PROCESS | 12584 | UnknownError 13:34:31 INFO - TEST-INFO | 12584: exit 0 13:34:31 INFO - Browser initialized. 13:34:31 INFO - Running cycle 1/1 for kraken test... 13:34:31 INFO - TEST-INFO | started process 12665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq4yzL5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:34:43 INFO - PROCESS | 12665 | RSS: Main: 173109248 13:34:43 INFO - PROCESS | 12665 | 13:34:46 INFO - PROCESS | 12665 | Cycle 1(1): loaded http://localhost:48852/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48852/tests/kraken/driver.html?testName=audio-beat-detection) 13:34:47 INFO - PROCESS | 12665 | RSS: Main: 234430464 13:34:47 INFO - PROCESS | 12665 | 13:34:49 INFO - PROCESS | 12665 | Cycle 1(1): loaded http://localhost:48852/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48852/tests/kraken/driver.html?testName=audio-dft) 13:34:50 INFO - PROCESS | 12665 | RSS: Main: 216727552 13:34:50 INFO - PROCESS | 12665 | 13:34:53 INFO - PROCESS | 12665 | Cycle 1(1): loaded http://localhost:48852/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48852/tests/kraken/driver.html?testName=audio-fft) 13:34:54 INFO - PROCESS | 12665 | RSS: Main: 299495424 13:34:54 INFO - PROCESS | 12665 | 13:34:56 INFO - PROCESS | 12665 | Cycle 1(1): loaded http://localhost:48852/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48852/tests/kraken/driver.html?testName=audio-oscillator) 13:34:57 INFO - PROCESS | 12665 | RSS: Main: 210051072 13:34:57 INFO - PROCESS | 12665 | 13:34:59 INFO - PROCESS | 12665 | Cycle 1(1): loaded http://localhost:48852/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48852/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:34:59 INFO - PROCESS | 12665 | RSS: Main: 212889600 13:34:59 INFO - PROCESS | 12665 | 13:35:03 INFO - PROCESS | 12665 | Cycle 1(1): loaded http://localhost:48852/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48852/tests/kraken/driver.html?testName=imaging-darkroom) 13:35:03 INFO - PROCESS | 12665 | RSS: Main: 249196544 13:35:03 INFO - PROCESS | 12665 | 13:35:07 INFO - PROCESS | 12665 | Cycle 1(1): loaded http://localhost:48852/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48852/tests/kraken/driver.html?testName=imaging-desaturate) 13:35:07 INFO - PROCESS | 12665 | RSS: Main: 243449856 13:35:07 INFO - PROCESS | 12665 | 13:35:10 INFO - PROCESS | 12665 | Cycle 1(1): loaded http://localhost:48852/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48852/tests/kraken/driver.html?testName=json-parse-financial) 13:35:11 INFO - PROCESS | 12665 | RSS: Main: 246169600 13:35:11 INFO - PROCESS | 12665 | 13:35:12 INFO - PROCESS | 12665 | Cycle 1(1): loaded http://localhost:48852/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48852/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:35:13 INFO - PROCESS | 12665 | RSS: Main: 209829888 13:35:13 INFO - PROCESS | 12665 | 13:35:15 INFO - PROCESS | 12665 | Cycle 1(1): loaded http://localhost:48852/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48852/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:35:16 INFO - PROCESS | 12665 | RSS: Main: 217432064 13:35:16 INFO - PROCESS | 12665 | 13:35:18 INFO - PROCESS | 12665 | Cycle 1(1): loaded http://localhost:48852/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48852/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:35:18 INFO - PROCESS | 12665 | RSS: Main: 226086912 13:35:18 INFO - PROCESS | 12665 | 13:35:21 INFO - PROCESS | 12665 | Cycle 1(1): loaded http://localhost:48852/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48852/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:35:22 INFO - PROCESS | 12665 | RSS: Main: 234749952 13:35:22 INFO - PROCESS | 12665 | 13:35:25 INFO - PROCESS | 12665 | Cycle 1(1): loaded http://localhost:48852/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48852/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:35:26 INFO - PROCESS | 12665 | RSS: Main: 231153664 13:35:26 INFO - PROCESS | 12665 | 13:35:27 INFO - PROCESS | 12665 | Cycle 1(1): loaded http://localhost:48852/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48852/tests/kraken/driver.html?testName=ai-astar) 13:35:28 INFO - PROCESS | 12665 | RSS: Main: 281694208 13:35:28 INFO - PROCESS | 12665 | 13:35:28 INFO - PROCESS | 12665 | __start_tp_report 13:35:28 INFO - PROCESS | 12665 | _x_x_mozilla_page_load 13:35:28 INFO - PROCESS | 12665 | _x_x_mozilla_page_load_details 13:35:28 INFO - PROCESS | 12665 | |i|pagename|runs| 13:35:28 INFO - PROCESS | 12665 | |0;ai-astar;106;115;116;116;115;117;113;114;114;114 13:35:28 INFO - PROCESS | 12665 | |1;audio-beat-detection;157;137;127;182;130;139;140;127;168;128 13:35:28 INFO - PROCESS | 12665 | |2;audio-dft;161;161;161;162;161;161;159;161;163;162 13:35:28 INFO - PROCESS | 12665 | |3;audio-fft;78;76;76;114;78;76;77;76;106;77 13:35:28 INFO - PROCESS | 12665 | |4;audio-oscillator;85;83;116;84;84;85;105;82;83;121 13:35:28 INFO - PROCESS | 12665 | |5;imaging-gaussian-blur;117;117;116;117;118;116;117;117;119;117 13:35:28 INFO - PROCESS | 12665 | |6;imaging-darkroom;147;147;146;147;147;146;146;146;148;145 13:35:28 INFO - PROCESS | 12665 | |7;imaging-desaturate;86;84;84;84;84;85;84;84;84;84 13:35:28 INFO - PROCESS | 12665 | |8;json-parse-financial;65;65;66;65;78;65;67;66;68;66 13:35:28 INFO - PROCESS | 12665 | |9;json-stringify-tinderbox;68;68;68;69;71;68;68;68;73;69 13:35:28 INFO - PROCESS | 12665 | |10;stanford-crypto-aes;86;89;83;84;82;84;88;83;83;83 13:35:28 INFO - PROCESS | 12665 | |11;stanford-crypto-ccm;149;139;140;137;138;140;137;140;181;152 13:35:28 INFO - PROCESS | 12665 | |12;stanford-crypto-pbkdf2;184;177;177;176;175;179;176;178;176;179 13:35:28 INFO - PROCESS | 12665 | |13;stanford-crypto-sha256-iterative;69;70;71;69;70;70;71;72;70;67 13:35:28 INFO - PROCESS | 12665 | __end_tp_report 13:35:28 INFO - PROCESS | 12665 | __start_cc_report 13:35:28 INFO - PROCESS | 12665 | _x_x_mozilla_cycle_collect,1946 13:35:28 INFO - PROCESS | 12665 | __end_cc_report 13:35:28 INFO - PROCESS | 12665 | __startTimestamp1476477328158__endTimestamp 13:35:28 INFO - PROCESS | 12665 | 13:35:28 INFO - PROCESS | 12665 | ------- Summary: start ------- 13:35:28 INFO - PROCESS | 12665 | Number of tests: 14 13:35:28 INFO - PROCESS | 12665 | 13:35:28 INFO - PROCESS | 12665 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:3.06 (2.7%) stddev-sans-first:1.27 13:35:28 INFO - PROCESS | 12665 | Values: 106.0 115.0 116.0 116.0 115.0 117.0 113.0 114.0 114.0 114.0 13:35:28 INFO - PROCESS | 12665 | 13:35:28 INFO - PROCESS | 12665 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:139.50 stddev:19.17 (13.7%) stddev-sans-first:19.70 13:35:28 INFO - PROCESS | 12665 | Values: 157.0 137.0 127.0 182.0 130.0 139.0 140.0 127.0 168.0 128.0 13:35:28 INFO - PROCESS | 12665 | 13:35:28 INFO - PROCESS | 12665 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 13:35:28 INFO - PROCESS | 12665 | Values: 161.0 161.0 161.0 162.0 161.0 161.0 159.0 161.0 163.0 162.0 13:35:28 INFO - PROCESS | 12665 | 13:35:28 INFO - PROCESS | 12665 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.50 stddev:14.17 (18.5%) stddev-sans-first:14.89 13:35:28 INFO - PROCESS | 12665 | Values: 78.0 76.0 76.0 114.0 78.0 76.0 77.0 76.0 106.0 77.0 13:35:28 INFO - PROCESS | 12665 | 13:35:28 INFO - PROCESS | 12665 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:83.50 stddev:15.16 (18.2%) stddev-sans-first:15.81 13:35:28 INFO - PROCESS | 12665 | Values: 85.0 83.0 116.0 84.0 84.0 85.0 105.0 82.0 83.0 121.0 13:35:28 INFO - PROCESS | 12665 | 13:35:28 INFO - PROCESS | 12665 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 13:35:28 INFO - PROCESS | 12665 | Values: 117.0 117.0 116.0 117.0 118.0 116.0 117.0 117.0 119.0 117.0 13:35:28 INFO - PROCESS | 12665 | 13:35:28 INFO - PROCESS | 12665 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 13:35:28 INFO - PROCESS | 12665 | Values: 147.0 147.0 146.0 147.0 147.0 146.0 146.0 146.0 148.0 145.0 13:35:28 INFO - PROCESS | 12665 | 13:35:28 INFO - PROCESS | 12665 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.67 (0.8%) stddev-sans-first:0.33 13:35:28 INFO - PROCESS | 12665 | Values: 86.0 84.0 84.0 84.0 84.0 85.0 84.0 84.0 84.0 84.0 13:35:28 INFO - PROCESS | 12665 | 13:35:28 INFO - PROCESS | 12665 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:66.00 stddev:3.96 (6.0%) stddev-sans-first:4.12 13:35:28 INFO - PROCESS | 12665 | Values: 65.0 65.0 66.0 65.0 78.0 65.0 67.0 66.0 68.0 66.0 13:35:28 INFO - PROCESS | 12665 | 13:35:28 INFO - PROCESS | 12665 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:68.50 stddev:1.70 (2.5%) stddev-sans-first:1.76 13:35:28 INFO - PROCESS | 12665 | Values: 68.0 68.0 68.0 69.0 71.0 68.0 68.0 68.0 73.0 69.0 13:35:28 INFO - PROCESS | 12665 | 13:35:28 INFO - PROCESS | 12665 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:2.37 (2.8%) stddev-sans-first:2.45 13:35:28 INFO - PROCESS | 12665 | Values: 86.0 89.0 83.0 84.0 82.0 84.0 88.0 83.0 83.0 83.0 13:35:28 INFO - PROCESS | 12665 | 13:35:28 INFO - PROCESS | 12665 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:140.00 stddev:13.53 (9.7%) stddev-sans-first:14.29 13:35:28 INFO - PROCESS | 12665 | Values: 149.0 139.0 140.0 137.0 138.0 140.0 137.0 140.0 181.0 152.0 13:35:28 INFO - PROCESS | 12665 | 13:35:28 INFO - PROCESS | 12665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.70 Median:177.50 stddev:2.58 (1.5%) stddev-sans-first:1.41 13:35:28 INFO - PROCESS | 12665 | Values: 184.0 177.0 177.0 176.0 175.0 179.0 176.0 178.0 176.0 179.0 13:35:28 INFO - PROCESS | 12665 | 13:35:28 INFO - PROCESS | 12665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.37 (2.0%) stddev-sans-first:1.41 13:35:28 INFO - PROCESS | 12665 | Values: 69.0 70.0 71.0 69.0 70.0 70.0 71.0 72.0 70.0 67.0 13:35:28 INFO - PROCESS | 12665 | -------- Summary: end -------- 13:35:28 INFO - PROCESS | 12665 | 13:35:29 INFO - TEST-INFO | 12665: exit 0 13:35:29 INFO - TEST-OK | kraken | took 64793ms 13:35:29 INFO - SUITE-END | took 1187s 13:35:29 INFO - Completed test suite (00:19:47) 13:35:29 INFO - javascript benchmark 13:35:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2617.136345006148, 2632.1313966391094, 2651.549236629772, 2674.304680782996, 2684.3691732442885, 4519.480259770127, 4618.653600979932, 4719.882002949928, 4723.669343145981, 4758.1435341638535, 4649.9070018599605, 4651.093036857814, 4664.976675116628, 4668.62650987921, 4672.696274742139, 4286.057067445157, 4314.0, 4317.13657268546, 4338.566143385668, 4345.978270108645, 4323.286657701476, 4353.499347575022, 4358.825646974117, 4360.454943132108, 4365.738055716652, 4351.0862718829085, 4358.193734159175, 4366.541513141122, 4387.956120438803, 4448.154850578379, 4450.532694067108, 4461.107778444291, 4466.464024317071, 4466.57567531084, 4491.101779644085, 4210.347396153601, 4245.129748401601, 4251.766152861592, 4373.562643735601, 4428.667849911238, 4638.1187574360765, 4640.118377508296, 4641.605463535603, 4660.813567457298, 4665.160271151191, 4968.354113965162, 4993.600511959071, 5002.649814512985, 5014.498550144993, 5067.34124563808, 4883.316335713003, 4947.703137811779, 5011.072951503984, 5059.16523773577, 5079.060373830816, 4657.720536767804, 4737.076270127292, 4776.259679749644, 4779.689320194177, 4855.028994201174, 5249.42256351801, 5254.290670759475, 5256.6057545684225, 5256.9737151314, 5258.237555554423, 5043.646944713835, 5044.747762611854, 5045.142325804622, 5048.949510504848, 5096.6941983480365, 4934.925976110361, 4970.925436118461, 4974.900501990012, 5039.370078740158, 5073.822416215415, 5039.067772462106, 5042.6470147090085, 5088.745562721849, 5103.18349064148, 5107.923381149286, 4977.576905962961, 5013.473585273567, 5017.422996355393, 5029.270755740397, 5085.7202853842655, 4046.1300820323772, 4070.5115386153257, 4072.9185416291507, 4196.097838964637, 4239.830406783756, 3662.1393972416463, 3693.8522459101873, 3694.9261014779554, 3705.481232627434, 3747.063234191452, 4416.315471101984, 4416.845410410684, 4432.645388368923, 4462.843800466968, 4489.663275254304, 4922.9753851231235, 5087.592992560586, 5098.694078355311, 5099.413567439718, 5101.795928162906, 4345.174416860849, 4391.978040109779, 4400.075984043323, 4423.845165419195, 4432.556744325606, 4508.256137737237, 4520.50274469808, 4524.615407690383, 4567.543245675406, 4577.977110114428, 4849.563539281482, 4849.903001940012, 4861.076395484846, 4869.123557759637, 4928.088303663833, 4910.508949105061, 4944.8763780905765, 4949.529794669501, 5011.624128190473, 5048.621353398436, 4839.806407743651, 4845.830395936126, 4855.150348689036, 4906.215005599087, 4912.729799861042, 5041.6722913010535, 5042.218456139158, 5046.142155833444, 5058.34241548611, 5110.9233361500355, 4914.5822605078965, 5028.698278103326, 5047.545720885138, 5110.437851836221, 5190.688558686491, 4913.263010548446, 4966.255061740768, 4976.800927962986, 5031.396232452129, 5041.42023667283, 4953.900921981468, 4958.082754690394, 4963.230699241623, 4976.10430122567, 5033.546980771602, 4785.396892041205, 4838.346823178967, 4870.269459581091, 4893.266010098514, 4948.109340318777, 4946.03552307311, 4979.775910083982, 4986.15235409974, 4993.450720420678, 5065.366829146356, 4838.2016967201425, 4877.439094504036, 4883.975580122076, 4897.608191344755, 4950.900981980412], "value": 4648.157535141439, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.4609398024886, 575.0913556580603, 575.7840809696363, 576.5935015813849, 578.4764787866982, 27289.863550682243, 27888.860555697218, 38225.808870955676, 38691.80654096733, 38871.611283887156, 39242.0, 39412.40881386781, 39520.60479395205, 39545.0, 39564.60435395645, 7423.443241756876, 7567.918822323877, 7568.886466703004, 7569.0, 7592.126905405866, 7556.962215188943, 7638.045244344457, 7638.350740187091, 7649.120351159604, 7690.077190737092, 7684.116326622454, 7715.614219289041, 7734.303912647861, 7737.110232323271, 7738.18749031352, 7672.386209103258, 7698.2686644768655, 7713.730019449348, 7714.922850771477, 7720.691172353099, 7684.769456916246, 7726.420518461138, 7734.071911370615, 7744.922550774477, 7746.883796743054, 36700.44949325762, 37199.0, 37296.62703372959, 37338.0, 37398.626013739784, 2882.509973304543, 3101.3332133591384, 3173.254285242989, 3242.1084201844446, 3343.147497388175, 26650.866745666342, 27064.864675676494, 27312.86343568289, 27352.316192095157, 27443.276397282792, 3417.6411476795074, 3505.0886769439876, 3543.7519373643854, 3600.963990360089, 3647.908802279938, 237051.0, 237689.0, 239298.0, 239362.0, 240177.0, 30946.690533094832, 49187.75406122946, 49222.261666075035, 49554.504454954986, 49637.0, 31306.37387252242, 32654.183645409055, 32825.83587082049, 32909.50635740466, 32958.3408331832, 11985.101117416229, 12197.817032744517, 12204.755904881853, 12210.26738395699, 12218.144729869002, 9604.135627793532, 9663.13031827139, 9663.758406039764, 9667.758306042406, 9679.128878400978, 7594.0, 7670.654820533089, 7747.845043099106, 7755.612219389121, 7759.107702614158, 3031.7726170536857, 3042.8478576071107, 3059.801112927697, 3082.830444325539, 3097.984510077435, 827.8261565071402, 856.4647095565272, 868.8392647360258, 868.9652413903373, 952.5046975572664, 26230.34424139412, 26661.800583930053, 26715.465690686076, 26920.865395672896, 27043.594346084825, 775.0623441396509, 894.5706061090713, 949.990500095004, 991.2169386184834, 1001.4692213127055, 13950.511732089328, 14162.929185354007, 14470.158585237034, 14508.637284067772, 14652.267386630625, 338654.0, 339402.0, 339464.0, 339903.0, 340130.0, 48470.0, 48763.0, 48806.755966220655, 48874.75562622164, 48945.0, 1066.0938202527789, 1087.075985412393, 1093.7593729379682, 1160.3965937712342, 1178.1752773058893, 28216.29459263535, 30655.386892261584, 30829.845850770602, 31261.218469538442, 31279.0, 43931.78034109809, 44177.33733994057, 44532.0, 44575.0, 44654.553454465036, 296353.0, 300370.0, 300736.0, 301245.0, 301928.0, 24573.38566535851, 39000.6099938997, 40016.1996760069, 40959.79520102381, 42920.35619465648, 38297.4255386175, 38745.6125438742, 39072.6092739069, 42832.78583607187, 42892.78553607337, 35528.28943421065, 36202.27595448129, 36256.456153157196, 36585.45121823228, 36633.63366366302, 35949.82025089858, 35966.640333596326, 36181.81909090543, 36761.26477470489, 36775.816120919226, 34751.4787278186, 35216.0, 35857.0, 36043.09892252715, 36206.818965905004, 29736.851315743283, 31826.840865795522, 32097.839510802296, 32507.512387314684, 32572.674273256966, 25013.749862501143, 25366.49267014686, 25399.0, 25432.74567254304, 25775.0], "value": 16137.526552882233, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.36930754834685, 348.2165128460963, 360.7727131906899, 364.93796054670696, 379.46116514549357, 12374.814377784329, 13292.13601115928, 15640.843591564095, 16530.669386612262, 17761.46715598531, 16739.83260167398, 16956.49130526086, 17322.13389330535, 17506.737398939025, 17616.295348186057, 3921.9803900980596, 4897.24092765621, 5125.12872811621, 5127.743612819363, 5172.534471897528, 4925.532074452921, 5061.519155680223, 5065.696058236517, 5066.898662026757, 5068.315777370063, 4796.4244290685165, 5031.27046578246, 5032.0, 5034.42104158021, 5036.874078148057, 5018.698878067327, 5024.648274620778, 5025.04524140414, 5031.22016087507, 5041.445441001487, 4475.641948644134, 4476.261416866213, 4481.462224533045, 4481.484629267643, 4493.460784705823, 12383.876161238453, 13736.381862816197, 19799.208031678714, 20343.5931281375, 20397.694034589495, 1729.161356741979, 1874.7843997940274, 1918.7985261547476, 2000.2299114840746, 2268.26281458525, 9171.403858749227, 9192.540372981392, 9400.059994000614, 9551.761205969837, 10423.895761042368, 1573.7403328450791, 1630.9592260193472, 1672.1137796967625, 1747.021667865999, 1750.3523696232348, 44323.77838110821, 70248.6487567564, 70461.0, 71001.64499177523, 72633.0, 9316.394434361744, 9782.854669067412, 9869.703908882744, 9998.900010999942, 10128.44293563861, 13808.17150970925, 13824.516141934984, 13839.861601383856, 13842.238676872868, 13867.306634668428, 6949.374556289857, 7093.255208203064, 7154.39187669054, 7299.087614048244, 7335.669894854745, 6366.204224471941, 6544.59680965895, 6601.3728695773825, 6745.865082698417, 6758.155230596176, 4255.5744425557195, 4261.083866968616, 4299.892502687458, 4332.436783218224, 4388.407564978751, 1780.6349698311815, 1791.2208189437636, 1805.7020591602238, 1811.6829554827852, 1838.8896666200071, 627.996860015697, 811.7361857396252, 855.2217482091268, 891.1133422244908, 911.2573252799081, 15999.520014399586, 16497.257623406735, 16768.161591920354, 17234.224459899335, 17955.820441795415, 832.1553623072465, 841.9115992820788, 852.8507511185518, 854.4104567848165, 865.2818160926416, 9335.626574936927, 9598.568064437117, 9826.950865245628, 9851.211903047739, 9988.850167247498, 362584.0, 366738.0, 371968.0, 372192.0, 372343.0, 45320.773396132805, 45787.31319030217, 71950.64024679843, 81748.0, 82870.99999999879, 842.3429724814654, 869.9086595907338, 873.0440168016012, 879.2394578689388, 879.4986857491297, 15431.0, 15568.922155389151, 16165.838341616432, 16318.265678044754, 16416.0, 24552.263432097065, 25422.74577254204, 34952.300953980266, 35324.11689707778, 36424.453633196055, 52094.739526302124, 52354.738226310146, 52507.47492525026, 52663.0, 52914.0, 7588.506747061423, 7654.961725191339, 7765.72819951299, 7809.609519524115, 7817.0619525657285, 9256.49089300095, 11588.768224635629, 11883.940580297043, 11967.461464234304, 12062.396880156133, 9501.809963800824, 10116.342437741523, 10216.846747298945, 10261.179105671677, 10346.22403319769, 10151.847722284025, 10154.339967902062, 10157.84763228567, 10218.540165692413, 10260.948695256477, 9377.85933211016, 9928.453935033642, 9999.950000249952, 10060.346077505232, 10365.533550990072, 7565.508241964255, 7751.263629955145, 7801.843963120819, 7827.882581761392, 7958.124606293419, 8984.55077246122, 9871.210303175872, 10115.797684046425, 10165.237607179639, 10246.436445995541], "value": 7893.168515311346, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.8993575481836, 1398.4615922869696, 1470.8970372073952, 1641.458318754811, 1694.5848267174536, 6661.500387470935, 6919.0, 7231.89152162718, 7653.923460765391, 7667.118281397634, 7232.710691572331, 7530.58581778002, 7552.1692613812575, 7717.536947783137, 7722.459427840054, 2149.1833103420677, 2182.0835249195297, 2183.650615901456, 2186.169255682846, 2187.0, 1859.5165257033202, 1946.13397038318, 2122.9363119106374, 2176.4776453651166, 2182.432567532445, 1862.236483041953, 1889.1309997401213, 2077.0757013129164, 2138.1447421031557, 2143.732033495813, 2080.5734824361043, 2084.280923081542, 2099.4331530486834, 2100.1179504608103, 2107.504736386948, 2045.243259993797, 2059.0, 2076.9169233230655, 2080.365488525999, 2083.114676262582, 7663.31030207284, 7705.6917723291, 7723.53658780475, 7730.304272615435, 7733.7679869604, 4433.113377324516, 4648.209804333272, 4692.061587682477, 4719.646026548023, 4724.527547245282, 2857.2428306498796, 2957.512010518262, 3018.351054523288, 3026.228311780504, 3037.331787006855, 888.4108202860436, 945.7635591102224, 960.4477425480306, 963.036963036963, 963.7397902566338, 10170.491475426199, 10215.642452514201, 10232.744181395525, 10243.385396876136, 10261.973802619754, 3977.3636218204947, 4062.8171732272117, 4246.278132717445, 4313.956860431418, 4327.826886924488, 8887.15572020657, 8887.200151986352, 8890.511021893857, 8893.28853691703, 8899.02110767815, 4689.577937985598, 4693.929591056137, 4696.8590942271785, 4697.859064228079, 4698.271767875985, 4211.620954114144, 4259.339802330644, 4259.403683484315, 4268.914621707549, 4285.700000999963, 3527.8941631750577, 3553.076200187918, 3654.926901461956, 3672.2839046385698, 3689.538807649044, 1145.095374654014, 1162.8139497680331, 1174.9530018799153, 1186.596557170549, 1187.2223693480785, 657.2244751193542, 772.5017363800317, 781.7029528779027, 784.282381620822, 807.2129673568224, 4928.975355123202, 5051.949480505222, 5076.695398276115, 5135.486451354835, 5372.221027950925, 413.80964756211876, 416.90202802341423, 419.50917426610937, 421.19341461101646, 423.51084497405543, 3428.0, 3436.862525499002, 3438.5529881115795, 3492.738044646662, 3675.889723308305, 8877.245434138042, 9304.95347523258, 9317.860232096524, 9324.906750932403, 9325.347225694271, 9271.304652151115, 9275.118863707938, 9282.30382721285, 9289.071092890657, 9296.30277729173, 7180.281971802778, 7250.854982900418, 7289.890651640229, 7296.635168241567, 7300.16048154469, 5060.468650791614, 5211.635185536976, 5347.491988261109, 5475.589330800126, 5620.606557540933, 8256.174382561696, 8433.114522975, 8522.531260780717, 8594.398392112493, 8640.913590864262, 8694.565271736514, 8723.302135828992, 8791.912080879109, 8812.118788121137, 9014.819703606023, 6485.092087107903, 6590.209174899042, 6593.8131136395905, 6602.6698665067515, 6604.471642268511, 6942.757003504853, 7179.676914538963, 7222.530535515175, 7265.9273407265255, 7289.380402665833, 6597.0764093026055, 6666.2333831609985, 6667.19993600771, 6668.199816022108, 6850.3149685033095, 6397.808065758035, 6580.934190658032, 6595.043718660863, 6715.93284067153, 6763.93236067633, 5814.73833677494, 5900.1149827526215, 5946.137810017437, 5948.970255148696, 5952.940470595238, 4126.546079931265, 4194.266003449445, 4195.307774217342, 4206.116715489659, 4382.189294980311, 4263.93604095945, 4267.80794864238, 4340.066885619607, 4373.562643735601, 4454.4877339106415], "value": 3962.913777835028, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.17581716291403, 290.83131783565534, 300.86912193195946, 301.48747129879195, 303.64928507573734, 4674.85975420737, 4820.421549414066, 4837.80648774049, 4850.490698476658, 4873.537013983675, 4715.764211789414, 4729.929051064237, 4745.311929770181, 4762.547557981995, 4770.236762118053, 3494.668006539375, 3629.4192929131345, 3654.9817250913707, 3736.626337366255, 3748.5876553579083, 3570.964420318118, 3620.4931309616672, 3623.202895363016, 3736.7010639148803, 3758.2107757370986, 3679.5584529856455, 3682.9927689409337, 3684.042149041255, 3693.205960718445, 3714.962850371489, 3695.427208782643, 3703.2963736889906, 3703.611120832314, 3714.591394946554, 3732.309522738302, 3191.4734068878606, 3229.3864165808654, 3246.5779448671756, 3253.723433508155, 3255.128301226804, 4585.014221942265, 4589.862304130881, 4605.30920361945, 4611.169989401907, 4614.492405835355, 4228.619424251832, 4236.385724070024, 4236.703430759848, 4242.5121111072, 4249.893752656209, 4660.508637236086, 4912.140375434285, 4939.209726443752, 4998.0, 5001.8499445016705, 3515.701165400944, 3523.8766643167623, 3525.171584677624, 3529.711655245817, 3547.130952916552, 5200.141976573861, 5208.5572726318305, 5214.348206474191, 5215.8174463893965, 5239.528442440199, 3593.5508061492314, 3602.9819850900576, 3614.8793873899176, 3623.2753449309716, 3624.4563315502887, 3566.1262990567475, 3627.093226693327, 3651.6348365163803, 3655.981720091436, 3657.0743405276203, 4154.729942553724, 4158.688098392572, 4170.374443833389, 4170.416141740159, 4200.558941311179, 4882.414110306786, 4927.482614325516, 4947.183714687037, 4962.774196772127, 4989.151844186497, 1184.899283560907, 1236.9319687417278, 1247.133242396544, 1263.2925561685486, 1267.3536496386726, 797.696875187425, 804.047204063187, 808.6495552427343, 809.6032943857467, 818.7912082418945, 3966.147278335172, 3966.9768418106974, 3969.047428617111, 4298.183345164409, 4428.4243048403505, 4972.955679307313, 5068.265101560253, 5086.21163719624, 5095.617828662791, 5115.693058416507, 4471.630036080883, 4475.820967161342, 4482.0, 4487.573680500347, 4497.572730590588, 2576.7680908718307, 2674.7860171186258, 2687.6774787025292, 2703.635009273762, 2705.78353731701, 4861.927071093936, 4880.707157570557, 4881.194602890483, 4883.316335713003, 4908.631852611068, 5213.191955246943, 5236.240745092016, 5298.125809241432, 5298.443663415286, 5330.866728331745, 4666.733286699324, 4843.4430040545785, 4879.829205977845, 4910.877228069256, 4973.856013116931, 5050.520200580939, 5061.0, 5089.287499749964, 5092.694438333712, 5103.132467480612, 5005.824796132118, 5026.59787217029, 5038.974805125951, 5045.445001049955, 5046.293518907282, 4648.721076735406, 4913.385826771653, 4926.187179115549, 4927.457979622311, 4951.207806750903, 3604.2971620533744, 3642.3990041642833, 3644.4168932971656, 3651.2697460507475, 3656.3784156692896, 5231.738413079407, 5232.738363081907, 5237.738113094406, 5248.947510524846, 5249.527542521191, 4934.235193545006, 5026.824061157842, 5066.771995260148, 5085.5931525477135, 5085.821996230115, 4973.651844370859, 4978.626603004716, 4979.829740011167, 4989.12690279207, 5021.974890125526, 4907.730074845917, 4918.6802857815555, 4923.655344125877, 4924.901501970012, 4957.182064959241, 4842.7820748065715, 4999.075171093359, 5012.223105418666, 5027.974860125676, 5049.84850454487, 4689.882752931204, 4798.0, 4799.640026998059, 4934.358533390637, 4936.531029552187], "value": 3741.500292453829, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.9514043736064, 635.6027482823235, 652.3118407486717, 681.3749208138585, 748.0649188514357, 13028.934855325722, 13917.860821391783, 13979.440822367118, 14043.36804843782, 14131.222782746945, 12693.428795704192, 12936.417861196245, 13032.93483532581, 13081.67295817605, 13088.869111308884, 783.8510682970245, 802.6869520886859, 805.5931754463987, 807.7294106474309, 808.1716240853114, 631.8641492079201, 649.4317472211815, 650.5836264790538, 653.4119292636617, 795.097564264561, 686.8969654551807, 800.771780042688, 828.1966492502263, 828.8715249136394, 833.7332053742805, 820.2535692519779, 821.5604651511443, 821.5974172655416, 821.8685010398337, 822.0628483528782, 597.0804960361039, 599.0086406996428, 599.1641659884436, 599.3946114424419, 599.7001499250375, 9901.405915645084, 10246.795064098751, 12399.380030998414, 12696.555620553328, 12746.0, 12044.939775301067, 13366.198028118344, 13390.598282051456, 13540.255285959269, 13711.931440342734, 10287.12559432449, 10338.0, 10373.896261037444, 10475.84286235707, 10484.213683973732, 3271.4765637498126, 3302.669733026702, 3370.6629337066342, 3377.9662203377898, 3474.3746125697367, 58132.418675813125, 58726.11910821341, 58882.0, 59480.0, 60369.6981515094, 8837.425567338103, 8906.55467226636, 8938.731838044869, 8953.0, 9022.684206052756, 17778.822211777977, 17947.820521794874, 17972.730409043874, 17987.0, 18475.445736627924, 6171.907421388682, 6389.169407976933, 6485.935140648628, 6499.447546958561, 6588.275289718127, 3492.5634295713035, 3496.1281151525354, 3512.438009918401, 3570.625084366156, 3578.499010138583, 3021.5014522603965, 3110.3001824589287, 3130.6712795156636, 3134.5611614374006, 3141.513065474855, 531.6278604976454, 540.2733323679645, 544.27067729243, 545.0679338331419, 559.2589818490517, 614.3733391940196, 627.6234259444296, 629.8299459146097, 639.4404895716249, 645.0872016097263, 8102.675892964333, 8103.918960810316, 8259.339252859876, 8283.420160588701, 8472.290215903622, 612.7579606055672, 616.3220457496718, 617.1144407774857, 630.1870586942792, 630.3066626710673, 3821.7898015608853, 4027.7154678231277, 4120.814563344657, 4149.605787450248, 4294.377315289265, 77945.61027194827, 97061.5146924275, 97436.0, 97487.0, 100012.49993749984, 70651.64674176596, 89465.55267223752, 90490.54754726184, 90865.0, 92415.53792230996, 80706.59646701728, 81028.59485702534, 81221.78167327495, 82247.5887620558, 82906.17093828984, 8546.2308392245, 8574.485530868167, 8859.468431894107, 8870.42342247752, 9360.15758581731, 40239.0, 42545.0, 43284.0, 44541.10917781561, 45672.54327456683, 55561.722191388784, 57292.140617889934, 70118.49407529706, 70205.64897175481, 71600.0, 12312.630621081382, 12376.257424554555, 12412.875871241173, 12494.562690306158, 12604.55884044054, 12977.221366718028, 13011.089223754625, 13062.216267024009, 13366.465341386625, 13481.528146514825, 11513.194076414571, 12562.623121306375, 12700.188824393033, 12830.704322283658, 12955.093143479866, 11565.537378504765, 11580.768384632429, 13231.404586793426, 13655.453781848615, 13781.517646882712, 11712.297262164297, 12170.939145304217, 12195.695107622381, 12303.93848030754, 12458.688532786391, 9465.47939863314, 10034.899651003396, 10077.647282345377, 10119.645812396531, 10282.126019288444, 8741.519216443157, 8757.299416046828, 9194.49430281341, 9973.451460169761, 9997.100260976547], "value": 6599.199102980649, "unit": "score"}], "name": "dromaeo_css", "value": 6220.540547653329, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 116.0, 116.0, 115.0, 117.0, 113.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 137.0, 127.0, 182.0, 130.0, 139.0, 140.0, 127.0, 168.0, 128.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 159.0, 161.0, 163.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 114.0, 78.0, 76.0, 77.0, 76.0, 106.0, 77.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 116.0, 84.0, 84.0, 85.0, 105.0, 82.0, 83.0, 121.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 118.0, 116.0, 117.0, 117.0, 119.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 148.0, 145.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 78.0, 65.0, 67.0, 66.0, 68.0, 66.0], "value": 67.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 69.0, 71.0, 68.0, 68.0, 68.0, 73.0, 69.0], "value": 69.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 89.0, 83.0, 84.0, 82.0, 84.0, 88.0, 83.0, 83.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 139.0, 140.0, 137.0, 138.0, 140.0, 137.0, 140.0, 181.0, 152.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 177.0, 177.0, 176.0, 175.0, 179.0, 176.0, 178.0, 176.0, 179.0], "value": 177.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 71.0, 69.0, 70.0, 70.0, 71.0, 72.0, 70.0, 67.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1556.3000000000002, "alertThreshold": 2.0}]} 13:35:29 INFO - Return code: 0 13:35:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:35:29 INFO - # TBPL SUCCESS # 13:35:29 INFO - Running post-action listener: _resource_record_post_action 13:35:29 INFO - [mozharness: 2016-10-14 20:35:29.933446Z] Finished run-tests step (success) 13:35:29 INFO - Running post-run listener: _resource_record_post_run 13:35:30 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 390979584; Read time: 16; Write time: 221408 13:35:30 INFO - TinderboxPrint: CPU usage
13.0% 13:35:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 13:35:30 INFO - TinderboxPrint: I/O write bytes / time
390,979,584 / 221,408 13:35:30 INFO - TinderboxPrint: CPU idle
8,355.1 (87.0%) 13:35:30 INFO - TinderboxPrint: CPU user
1,202.3 (12.5%) 13:35:30 INFO - TinderboxPrint: Swap in / out
0 / 0 13:35:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99545088; Read time: 0; Write time: 70864 13:35:30 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291434496; Read time: 0; Write time: 150544 13:35:30 INFO - Running post-run listener: _upload_blobber_files 13:35:30 INFO - Blob upload gear active. 13:35:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:35:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:35:30 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:35:30 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:35:30 INFO - (blobuploader) - INFO - Open directory for files ... 13:35:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:35:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:35:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:35:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:35:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:35:31 INFO - (blobuploader) - INFO - Done attempting. 13:35:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:35:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:35:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:35:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:35:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:35:32 INFO - (blobuploader) - INFO - Done attempting. 13:35:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:35:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:35:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:35:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:35:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:35:36 INFO - (blobuploader) - INFO - Done attempting. 13:35:36 INFO - (blobuploader) - INFO - Iteration through files over. 13:35:36 INFO - Return code: 0 13:35:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:35:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:35:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/163da63ed800cc2661f3caf230a67146b9c82ffbb8b229e4c089594f870848394f15969f2b476a7b09e2188c831d88e7e2f08cfbc8234f6a2c6cab80478e2cd7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a0444a5f262293713ca6bcf94f0b58bab827c1a0df10bba9ac6020a045fa47988481fbaa98d64d985477f88314985e7694f3db326a825dce2aff4ba28863fbcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5ee5f36f1fd060f9fee6db48cc5a9950f2906ed19560d5e0272b17385c82d312c4e61db5d843cc80dbf243eedf6fbbdbbded14457ffe6da7287de6df6c231bbf"} 13:35:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:35:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:35:36 INFO - Contents: 13:35:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/163da63ed800cc2661f3caf230a67146b9c82ffbb8b229e4c089594f870848394f15969f2b476a7b09e2188c831d88e7e2f08cfbc8234f6a2c6cab80478e2cd7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a0444a5f262293713ca6bcf94f0b58bab827c1a0df10bba9ac6020a045fa47988481fbaa98d64d985477f88314985e7694f3db326a825dce2aff4ba28863fbcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5ee5f36f1fd060f9fee6db48cc5a9950f2906ed19560d5e0272b17385c82d312c4e61db5d843cc80dbf243eedf6fbbdbbded14457ffe6da7287de6df6c231bbf"} 13:35:36 INFO - Running post-run listener: copy_logs_to_upload_dir 13:35:36 INFO - Copying logs to upload dir... 13:35:36 INFO - mkdir: /builds/slave/test/build/upload/logs 13:35:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.241835 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-14 13:35:36.326334) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 13:35:36.329682) ========= 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=337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/163da63ed800cc2661f3caf230a67146b9c82ffbb8b229e4c089594f870848394f15969f2b476a7b09e2188c831d88e7e2f08cfbc8234f6a2c6cab80478e2cd7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a0444a5f262293713ca6bcf94f0b58bab827c1a0df10bba9ac6020a045fa47988481fbaa98d64d985477f88314985e7694f3db326a825dce2aff4ba28863fbcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5ee5f36f1fd060f9fee6db48cc5a9950f2906ed19560d5e0272b17385c82d312c4e61db5d843cc80dbf243eedf6fbbdbbded14457ffe6da7287de6df6c231bbf"} build_url:https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011195 build_url: 'https://queue.taskcluster.net/v1/task/HVi73ELFT2my5R-lPRrGGg/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/Autoland-Non-PGO/sha512/163da63ed800cc2661f3caf230a67146b9c82ffbb8b229e4c089594f870848394f15969f2b476a7b09e2188c831d88e7e2f08cfbc8234f6a2c6cab80478e2cd7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a0444a5f262293713ca6bcf94f0b58bab827c1a0df10bba9ac6020a045fa47988481fbaa98d64d985477f88314985e7694f3db326a825dce2aff4ba28863fbcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5ee5f36f1fd060f9fee6db48cc5a9950f2906ed19560d5e0272b17385c82d312c4e61db5d843cc80dbf243eedf6fbbdbbded14457ffe6da7287de6df6c231bbf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 13:35:36.354837) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 13:35:36.355440) ========= 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=337fe3f4b1febe37b85fccc40000019e-1476475955.794043-146950531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 13:35:36.440473) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 13:35:36.440787) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 13:35:36.441094) ========= ========= Total master_lag: 0.18 =========