builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1475624545.02 results: success (0) buildid: 20161004123002 builduid: 3b5e2c5355bb40ef960059cdbf64a732 revision: 3470e326025c62381dc5f7c06629dbe5dbd7f242 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 16:42:25.017755) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 16:42:25.018193) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 16:42:25.018471) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 16:42:25.033809) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:42:25.034190) ========= 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=5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 16:42:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-10-04 16:42:25 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112730 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:42:25.163758) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:42:25.164139) ========= 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=5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018122 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:42:25.213490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 16:42:25.217059) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 3470e326025c62381dc5f7c06629dbe5dbd7f242 --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 3470e326025c62381dc5f7c06629dbe5dbd7f242 --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=5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 16:42:25,458 truncating revision to first 12 chars 2016-10-04 16:42:25,458 Setting DEBUG logging. 2016-10-04 16:42:25,458 attempt 1/10 2016-10-04 16:42:25,458 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/3470e326025c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 16:42:26,825 unpacking tar archive at: autoland-3470e326025c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.694895 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 16:42:26.925223) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 16:42:26.925545) ========= script_repo_revision: 3470e326025c62381dc5f7c06629dbe5dbd7f242 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 16:42:26.927437) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 16:42:26.927762) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 16:42:26.937305) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-04 16:42:26.937670) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:42:27 INFO - MultiFileLogger online at 20161004 16:42:27 in /builds/slave/test 16:42:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 16:42:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:42:27 INFO - {'append_to_log': False, 16:42:27 INFO - 'base_work_dir': '/builds/slave/test', 16:42:27 INFO - 'blob_upload_branch': 'Autoland', 16:42:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:42:27 INFO - 'branch': 'Autoland', 16:42:27 INFO - 'buildbot_json_path': 'buildprops.json', 16:42:27 INFO - 'config_files': ('talos/linux_config.py',), 16:42:27 INFO - 'default_actions': ('clobber', 16:42:27 INFO - 'read-buildbot-config', 16:42:27 INFO - 'download-and-extract', 16:42:27 INFO - 'populate-webroot', 16:42:27 INFO - 'create-virtualenv', 16:42:27 INFO - 'install', 16:42:27 INFO - 'run-tests'), 16:42:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:42:27 INFO - 'download_minidump_stackwalk': True, 16:42:27 INFO - 'download_symbols': 'ondemand', 16:42:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:42:27 INFO - 'tooltool.py': '/tools/tooltool.py', 16:42:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:42:27 INFO - '/tools/misc-python/virtualenv.py')}, 16:42:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:42:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:42:27 INFO - 'installer_path': 'installer.exe', 16:42:27 INFO - 'log_level': 'info', 16:42:27 INFO - 'log_name': 'talos', 16:42:27 INFO - 'log_to_console': True, 16:42:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:42:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:42:27 INFO - 'opt_config_files': (), 16:42:27 INFO - 'pip_index': False, 16:42:27 INFO - 'sps_profile': False, 16:42:27 INFO - 'sps_profile_interval': 0, 16:42:27 INFO - 'suite': 'dromaeojs', 16:42:27 INFO - 'system_bits': '32', 16:42:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:42:27 INFO - 'title': 'talos-linux64-ix-011', 16:42:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:42:27 INFO - 'use_talos_json': True, 16:42:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:42:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:42:27 INFO - 'work_dir': 'build'} 16:42:27 INFO - [mozharness: 2016-10-04 23:42:27.282148Z] Running clobber step. 16:42:27 INFO - Running pre-action listener: _resource_record_pre_action 16:42:27 INFO - Running main action method: clobber 16:42:27 INFO - rmtree: /builds/slave/test/build 16:42:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:42:27 INFO - Running post-action listener: _resource_record_post_action 16:42:27 INFO - [mozharness: 2016-10-04 23:42:27.743818Z] Finished clobber step (success) 16:42:27 INFO - [mozharness: 2016-10-04 23:42:27.743919Z] Running read-buildbot-config step. 16:42:27 INFO - Running pre-action listener: _resource_record_pre_action 16:42:27 INFO - Running main action method: read_buildbot_config 16:42:27 INFO - Using buildbot properties: 16:42:27 INFO - { 16:42:27 INFO - "project": "", 16:42:27 INFO - "product": "firefox", 16:42:27 INFO - "script_repo_revision": "production", 16:42:27 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 16:42:27 INFO - "repository": "", 16:42:27 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 16:42:27 INFO - "buildid": "20161004123002", 16:42:27 INFO - "pgo_build": "True", 16:42:27 INFO - "basedir": "/builds/slave/test", 16:42:27 INFO - "buildnumber": 291, 16:42:27 INFO - "slavename": "talos-linux64-ix-011", 16:42:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:42:27 INFO - "platform": "ubuntu64_hw", 16:42:27 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 16:42:27 INFO - "branch": "autoland", 16:42:27 INFO - "repo_path": "integration/autoland", 16:42:27 INFO - "revision": "3470e326025c62381dc5f7c06629dbe5dbd7f242", 16:42:27 INFO - "stage_platform": "linux64-pgo", 16:42:27 INFO - "builduid": "3b5e2c5355bb40ef960059cdbf64a732", 16:42:27 INFO - "slavebuilddir": "test" 16:42:27 INFO - } 16:42:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 16:42:27 INFO - Running post-action listener: _resource_record_post_action 16:42:27 INFO - [mozharness: 2016-10-04 23:42:27.746404Z] Finished read-buildbot-config step (success) 16:42:27 INFO - [mozharness: 2016-10-04 23:42:27.746493Z] Running download-and-extract step. 16:42:27 INFO - Running pre-action listener: _resource_record_pre_action 16:42:27 INFO - Running main action method: download_and_extract 16:42:27 INFO - mkdir: /builds/slave/test/build/tests 16:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:42:27 INFO - trying https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:42:27 INFO - Downloading https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/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 16:42:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/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 16:42:28 INFO - Downloaded 1201 bytes. 16:42:28 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:42:28 INFO - Using the following test package requirements: 16:42:28 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:42:28 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:42:28 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:42:28 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:28 INFO - u'jsshell-linux-x86_64.zip'], 16:42:28 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:42:28 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:42:28 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:42:28 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:42:28 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:42:28 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:42:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:42:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:42:28 INFO - Fetch https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:42:28 INFO - Http code: 200 16:42:28 INFO - via: 1.1 296faebadd40feee8b2eb0e10d5786d2.cloudfront.net (CloudFront) 16:42:28 INFO - x-amz-cf-id: BUI207pvuaecNdTZCruR9putwghNAHW77SlfBiYEEPYPPX-tyVjKTg== 16:42:28 INFO - x-amz-version-id: GzcLuU2ZVDGU8f8ywzKMg8P5ub1yBKIu 16:42:29 INFO - Expected file size: 21992842 16:42:29 INFO - Obtained file size: 21992842 16:42:33 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 16:42:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:42:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:42:33 INFO - Fetch https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:42:33 INFO - Http code: 200 16:42:33 INFO - via: 1.1 95da1452a75435200220a7075ca3893f.cloudfront.net (CloudFront) 16:42:33 INFO - x-amz-cf-id: RLGh-1gy55Rf1_hVLG8cu7Lmlbd57PGewjLayIShq-6k6x1lsO6tRA== 16:42:33 INFO - x-amz-version-id: GzcLuU2ZVDGU8f8ywzKMg8P5ub1yBKIu 16:42:34 INFO - Expected file size: 21992842 16:42:34 INFO - Obtained file size: 21992842 16:42:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 16:42:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:42:38 INFO - Fetch https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:42:39 INFO - Http code: 200 16:42:39 INFO - via: 1.1 fc7da6323a08a2c16d48dd4939ce0898.cloudfront.net (CloudFront) 16:42:39 INFO - x-amz-cf-id: u72v9erGD2Vs14976ZyVVqI8dBim2-rR1PvOdvYJz75eZoLGu2h8fg== 16:42:39 INFO - x-amz-version-id: VZINkuKF0VGZOO_krnp8eogw6O0tZ4eX 16:42:39 INFO - Expected file size: 14409006 16:42:39 INFO - Obtained file size: 14409006 16:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:42:39 INFO - trying https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:42:39 INFO - Downloading https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/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 16:42:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/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 16:42:40 INFO - Downloaded 59701484 bytes. 16:42:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:42:40 INFO - mkdir: /builds/slave/test/properties 16:42:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:42:40 INFO - Writing to file /builds/slave/test/properties/build_url 16:42:40 INFO - Contents: 16:42:40 INFO - build_url:https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:42:41 INFO - Running post-action listener: _resource_record_post_action 16:42:41 INFO - Running post-action listener: set_extra_try_arguments 16:42:41 INFO - [mozharness: 2016-10-04 23:42:41.441029Z] Finished download-and-extract step (success) 16:42:41 INFO - [mozharness: 2016-10-04 23:42:41.441256Z] Running populate-webroot step. 16:42:41 INFO - Running pre-action listener: _resource_record_pre_action 16:42:41 INFO - Running main action method: populate_webroot 16:42:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:42:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:42:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:42:41 INFO - '--tppagecycles', 16:42:41 INFO - '7'], 16:42:41 INFO - 'tests': ['tsvgm']}}, 16:42:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:42:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:42:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:42:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:42:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:41 INFO - 'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:42:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:42:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:41 INFO - 'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['damp', 'tps']}, 16:42:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:41 INFO - 'tests': ['damp', 'tps']}, 16:42:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['dromaeo_dom']}, 16:42:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:42:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['basic_compositor_video']}, 16:42:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:42:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['a11yr', 16:42:41 INFO - 'ts_paint', 16:42:41 INFO - 'tpaint', 16:42:41 INFO - 'sessionrestore', 16:42:41 INFO - 'sessionrestore_no_auto_restore', 16:42:41 INFO - 'tabpaint']}, 16:42:41 INFO - 'other-e10s': {'tests': ['a11yr', 16:42:41 INFO - 'ts_paint', 16:42:41 INFO - 'tpaint', 16:42:41 INFO - 'sessionrestore', 16:42:41 INFO - 'sessionrestore_no_auto_restore', 16:42:41 INFO - 'tabpaint']}, 16:42:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:42:41 INFO - 'ts_paint', 16:42:41 INFO - 'tpaint', 16:42:41 INFO - 'sessionrestore', 16:42:41 INFO - 'sessionrestore_no_auto_restore', 16:42:41 INFO - 'tabpaint']}, 16:42:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:42:41 INFO - 'ts_paint', 16:42:41 INFO - 'tpaint', 16:42:41 INFO - 'sessionrestore', 16:42:41 INFO - 'sessionrestore_no_auto_restore', 16:42:41 INFO - 'tabpaint']}, 16:42:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['a11yr', 16:42:41 INFO - 'ts_paint', 16:42:41 INFO - 'tpaint', 16:42:41 INFO - 'sessionrestore', 16:42:41 INFO - 'sessionrestore_no_auto_restore', 16:42:41 INFO - 'tabpaint']}, 16:42:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['a11yr', 16:42:41 INFO - 'ts_paint', 16:42:41 INFO - 'tpaint', 16:42:41 INFO - 'sessionrestore', 16:42:41 INFO - 'sessionrestore_no_auto_restore', 16:42:41 INFO - 'tabpaint']}, 16:42:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['tsvgx', 16:42:41 INFO - 'tsvgr_opacity', 16:42:41 INFO - 'tart', 16:42:41 INFO - 'tscrollx', 16:42:41 INFO - 'cart']}, 16:42:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:42:41 INFO - 'tsvgr_opacity', 16:42:41 INFO - 'tart', 16:42:41 INFO - 'tscrollx', 16:42:41 INFO - 'cart']}, 16:42:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:41 INFO - 'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['tp5o']}, 16:42:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:41 INFO - 'tests': ['tp5o']}, 16:42:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:41 INFO - 'talos_options': ['--disable-e10s', 16:42:41 INFO - '--xperf_path', 16:42:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:42:41 INFO - 'tests': ['tp5n']}, 16:42:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:41 INFO - 'talos_options': ['--xperf_path', 16:42:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:42:41 INFO - 'tests': ['tp5n']}}, 16:42:41 INFO - 'talos.zip': {'path': '', 16:42:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:42:41 INFO - Running post-action listener: _resource_record_post_action 16:42:41 INFO - [mozharness: 2016-10-04 23:42:41.457262Z] Finished populate-webroot step (success) 16:42:41 INFO - [mozharness: 2016-10-04 23:42:41.457364Z] Running create-virtualenv step. 16:42:41 INFO - Running pre-action listener: _resource_record_pre_action 16:42:41 INFO - Running main action method: create_virtualenv 16:42:41 INFO - Creating virtualenv /builds/slave/test/build/venv 16:42:41 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 16:42:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:42:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:42:41 INFO - Using real prefix '/usr' 16:42:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:42:42 INFO - Installing distribute.............................................................................................................................................................................................done. 16:42:44 INFO - Installing pip.................done. 16:42:44 INFO - Return code: 0 16:42:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:42:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:42:44 INFO - Reading from file tmpfile_stdout 16:42:44 INFO - Output received: 16:42:44 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) 16:42:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:42:44 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')]} 16:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:44 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')]} 16:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:44 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 0x7f96aae95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c52790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4f930>, '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 0x2c50830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c50cc0>, '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': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', '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 16:42:44 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 16:42:44 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 16:42:44 INFO - Using env: {'DISPLAY': ':0', 16:42:44 INFO - 'HOME': '/home/cltbld', 16:42:44 INFO - 'LANG': 'en_US.UTF-8', 16:42:44 INFO - 'LANGUAGE': 'en_US:en', 16:42:44 INFO - 'LOGNAME': 'cltbld', 16:42:44 INFO - 'MAIL': '/var/mail/cltbld', 16:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:44 INFO - 'MOZ_NO_REMOTE': '1', 16:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:44 INFO - 'NO_EM_RESTART': '1', 16:42:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:44 INFO - 'PWD': '/builds/slave/test', 16:42:44 INFO - 'SHELL': '/bin/bash', 16:42:44 INFO - 'SHLVL': '1', 16:42:44 INFO - 'TERM': 'linux', 16:42:44 INFO - 'TMOUT': '86400', 16:42:44 INFO - 'USER': 'cltbld', 16:42:44 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', 16:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:44 INFO - '_': '/tools/buildbot/bin/python'} 16:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:44 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 16:42:44 INFO - Cleaning up... 16:42:44 INFO - Return code: 0 16:42:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:42:44 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')]} 16:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:44 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')]} 16:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:44 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 0x7f96aae95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c52790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4f930>, '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 0x2c50830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c50cc0>, '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': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', '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 16:42:44 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 16:42:44 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 16:42:44 INFO - Using env: {'DISPLAY': ':0', 16:42:44 INFO - 'HOME': '/home/cltbld', 16:42:44 INFO - 'LANG': 'en_US.UTF-8', 16:42:44 INFO - 'LANGUAGE': 'en_US:en', 16:42:44 INFO - 'LOGNAME': 'cltbld', 16:42:44 INFO - 'MAIL': '/var/mail/cltbld', 16:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:44 INFO - 'MOZ_NO_REMOTE': '1', 16:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:44 INFO - 'NO_EM_RESTART': '1', 16:42:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:44 INFO - 'PWD': '/builds/slave/test', 16:42:44 INFO - 'SHELL': '/bin/bash', 16:42:44 INFO - 'SHLVL': '1', 16:42:44 INFO - 'TERM': 'linux', 16:42:44 INFO - 'TMOUT': '86400', 16:42:44 INFO - 'USER': 'cltbld', 16:42:44 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', 16:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:44 INFO - '_': '/tools/buildbot/bin/python'} 16:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:44 INFO - Downloading/unpacking psutil>=3.1.1 16:42:44 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 16:42:44 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 16:42:44 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 16:42:44 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 16:42:44 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 16:42:44 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 16:42:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:42:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:42:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:42:46 INFO - Installing collected packages: psutil 16:42:46 INFO - Running setup.py install for psutil 16:42:46 INFO - building 'psutil._psutil_linux' extension 16:42:46 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 16:42:46 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 16:42:46 INFO - building 'psutil._psutil_posix' extension 16:42:46 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 16:42:47 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 16:42:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:42:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:42:47 INFO - Successfully installed psutil 16:42:47 INFO - Cleaning up... 16:42:47 INFO - Return code: 0 16:42:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:42: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')]} 16:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42: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')]} 16:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96aae95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c52790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4f930>, '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 0x2c50830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c50cc0>, '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': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', '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 16:42:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:42:47 INFO - Using env: {'DISPLAY': ':0', 16:42:47 INFO - 'HOME': '/home/cltbld', 16:42:47 INFO - 'LANG': 'en_US.UTF-8', 16:42:47 INFO - 'LANGUAGE': 'en_US:en', 16:42:47 INFO - 'LOGNAME': 'cltbld', 16:42:47 INFO - 'MAIL': '/var/mail/cltbld', 16:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:47 INFO - 'MOZ_NO_REMOTE': '1', 16:42:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:47 INFO - 'NO_EM_RESTART': '1', 16:42:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:47 INFO - 'PWD': '/builds/slave/test', 16:42:47 INFO - 'SHELL': '/bin/bash', 16:42:47 INFO - 'SHLVL': '1', 16:42:47 INFO - 'TERM': 'linux', 16:42:47 INFO - 'TMOUT': '86400', 16:42:47 INFO - 'USER': 'cltbld', 16:42:47 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', 16:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:47 INFO - '_': '/tools/buildbot/bin/python'} 16:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:42:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:42:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:42:49 INFO - Installing collected packages: mozsystemmonitor 16:42:49 INFO - Running setup.py install for mozsystemmonitor 16:42:49 INFO - Successfully installed mozsystemmonitor 16:42:49 INFO - Cleaning up... 16:42:49 INFO - Return code: 0 16:42:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f96aae95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c52790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4f930>, '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 0x2c50830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c50cc0>, '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': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', '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 16:42:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:42:49 INFO - Using env: {'DISPLAY': ':0', 16:42:49 INFO - 'HOME': '/home/cltbld', 16:42:49 INFO - 'LANG': 'en_US.UTF-8', 16:42:49 INFO - 'LANGUAGE': 'en_US:en', 16:42:49 INFO - 'LOGNAME': 'cltbld', 16:42:49 INFO - 'MAIL': '/var/mail/cltbld', 16:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:49 INFO - 'MOZ_NO_REMOTE': '1', 16:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:49 INFO - 'NO_EM_RESTART': '1', 16:42:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:49 INFO - 'PWD': '/builds/slave/test', 16:42:49 INFO - 'SHELL': '/bin/bash', 16:42:49 INFO - 'SHLVL': '1', 16:42:49 INFO - 'TERM': 'linux', 16:42:49 INFO - 'TMOUT': '86400', 16:42:49 INFO - 'USER': 'cltbld', 16:42:49 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', 16:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:49 INFO - '_': '/tools/buildbot/bin/python'} 16:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:49 INFO - Downloading/unpacking jsonschema==2.5.1 16:42:49 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 16:42:49 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 16:42:49 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 16:42:49 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 16:42:49 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 16:42:49 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 16:42:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:42:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:42:51 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 16:42:51 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 16:42:51 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 16:42:51 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 16:42:51 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 16:42:51 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 16:42:51 INFO - Downloading functools32-3.2.3-2.tar.gz 16:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:42:51 INFO - warning: no files found matching '*.txt' 16:42:51 INFO - no previously-included directories found matching 'build' 16:42:51 INFO - no previously-included directories found matching 'dist' 16:42:51 INFO - no previously-included directories found matching '.git*' 16:42:51 INFO - Installing collected packages: jsonschema, functools32 16:42:51 INFO - Running setup.py install for functools32 16:42:52 INFO - warning: no files found matching '*.txt' 16:42:52 INFO - no previously-included directories found matching 'build' 16:42:52 INFO - no previously-included directories found matching 'dist' 16:42:52 INFO - no previously-included directories found matching '.git*' 16:42:52 INFO - Successfully installed jsonschema functools32 16:42:52 INFO - Cleaning up... 16:42:52 INFO - Return code: 0 16:42:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f96aae95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c52790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4f930>, '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 0x2c50830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c50cc0>, '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': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', '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 16:42:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:42:52 INFO - Using env: {'DISPLAY': ':0', 16:42:52 INFO - 'HOME': '/home/cltbld', 16:42:52 INFO - 'LANG': 'en_US.UTF-8', 16:42:52 INFO - 'LANGUAGE': 'en_US:en', 16:42:52 INFO - 'LOGNAME': 'cltbld', 16:42:52 INFO - 'MAIL': '/var/mail/cltbld', 16:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:52 INFO - 'MOZ_NO_REMOTE': '1', 16:42:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:52 INFO - 'NO_EM_RESTART': '1', 16:42:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:52 INFO - 'PWD': '/builds/slave/test', 16:42:52 INFO - 'SHELL': '/bin/bash', 16:42:52 INFO - 'SHLVL': '1', 16:42:52 INFO - 'TERM': 'linux', 16:42:52 INFO - 'TMOUT': '86400', 16:42:52 INFO - 'USER': 'cltbld', 16:42:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', 16:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:52 INFO - '_': '/tools/buildbot/bin/python'} 16:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:42:52 INFO - Cleaning up... 16:42:52 INFO - Return code: 0 16:42:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f96aae95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c52790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4f930>, '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 0x2c50830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c50cc0>, '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': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', '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 16:42:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:42:52 INFO - Using env: {'DISPLAY': ':0', 16:42:52 INFO - 'HOME': '/home/cltbld', 16:42:52 INFO - 'LANG': 'en_US.UTF-8', 16:42:52 INFO - 'LANGUAGE': 'en_US:en', 16:42:52 INFO - 'LOGNAME': 'cltbld', 16:42:52 INFO - 'MAIL': '/var/mail/cltbld', 16:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:52 INFO - 'MOZ_NO_REMOTE': '1', 16:42:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:52 INFO - 'NO_EM_RESTART': '1', 16:42:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:52 INFO - 'PWD': '/builds/slave/test', 16:42:52 INFO - 'SHELL': '/bin/bash', 16:42:52 INFO - 'SHLVL': '1', 16:42:52 INFO - 'TERM': 'linux', 16:42:52 INFO - 'TMOUT': '86400', 16:42:52 INFO - 'USER': 'cltbld', 16:42:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', 16:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:52 INFO - '_': '/tools/buildbot/bin/python'} 16:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:52 INFO - Downloading/unpacking blobuploader==1.2.4 16:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:54 INFO - Downloading blobuploader-1.2.4.tar.gz 16:42:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:42:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:42:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:55 INFO - Downloading docopt-0.6.1.tar.gz 16:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:42:55 INFO - Installing collected packages: blobuploader, requests, docopt 16:42:55 INFO - Running setup.py install for blobuploader 16:42:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:42:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:42:55 INFO - Running setup.py install for requests 16:42:55 INFO - Running setup.py install for docopt 16:42:55 INFO - Successfully installed blobuploader requests docopt 16:42:55 INFO - Cleaning up... 16:42:55 INFO - Return code: 0 16:42:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:55 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 0x7f96aae95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c52790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4f930>, '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 0x2c50830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c50cc0>, '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': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', '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 16:42:55 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 16:42:55 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 16:42:55 INFO - Using env: {'DISPLAY': ':0', 16:42:55 INFO - 'HOME': '/home/cltbld', 16:42:55 INFO - 'LANG': 'en_US.UTF-8', 16:42:55 INFO - 'LANGUAGE': 'en_US:en', 16:42:55 INFO - 'LOGNAME': 'cltbld', 16:42:55 INFO - 'MAIL': '/var/mail/cltbld', 16:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:55 INFO - 'MOZ_NO_REMOTE': '1', 16:42:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:55 INFO - 'NO_EM_RESTART': '1', 16:42:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:55 INFO - 'PWD': '/builds/slave/test', 16:42:55 INFO - 'SHELL': '/bin/bash', 16:42:55 INFO - 'SHLVL': '1', 16:42:55 INFO - 'TERM': 'linux', 16:42:55 INFO - 'TMOUT': '86400', 16:42:55 INFO - 'USER': 'cltbld', 16:42:55 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', 16:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:55 INFO - '_': '/tools/buildbot/bin/python'} 16:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:42:56 INFO - Running setup.py (path:/tmp/pip-pYXwcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:42:56 INFO - Running setup.py (path:/tmp/pip-vuKLv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:42:56 INFO - Running setup.py (path:/tmp/pip-ACbgPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:42:56 INFO - Running setup.py (path:/tmp/pip-oTMO_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:42:56 INFO - Running setup.py (path:/tmp/pip-qejqpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:42:56 INFO - Running setup.py (path:/tmp/pip-CMs_7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:42:56 INFO - Running setup.py (path:/tmp/pip-tirXur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:42:56 INFO - Running setup.py (path:/tmp/pip-OWnPjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:42:56 INFO - Running setup.py (path:/tmp/pip-2IIHlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:42:56 INFO - Running setup.py (path:/tmp/pip-0LUU2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:42:56 INFO - Running setup.py (path:/tmp/pip-b40WLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:42:56 INFO - Running setup.py (path:/tmp/pip-1xMHWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:42:57 INFO - Running setup.py (path:/tmp/pip-u8nhxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:42:57 INFO - Running setup.py (path:/tmp/pip-dJYMrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:57 INFO - Running setup.py (path:/tmp/pip-t2dXXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:42:57 INFO - Running setup.py (path:/tmp/pip-EJkpme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:42:57 INFO - Running setup.py (path:/tmp/pip-ZOjRQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:42:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:42:57 INFO - Running setup.py install for manifestparser 16:42:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:42:57 INFO - Running setup.py install for mozcrash 16:42:57 INFO - Running setup.py install for mozdebug 16:42:57 INFO - Running setup.py install for mozdevice 16:42:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:42:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:42:57 INFO - Running setup.py install for mozfile 16:42:57 INFO - Running setup.py install for mozhttpd 16:42:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:42:58 INFO - Running setup.py install for mozinfo 16:42:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:42:58 INFO - Running setup.py install for mozInstall 16:42:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:42:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:42:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:42:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:42:58 INFO - Running setup.py install for mozleak 16:42:58 INFO - Running setup.py install for mozlog 16:42:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:42:58 INFO - Running setup.py install for moznetwork 16:42:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:42:58 INFO - Running setup.py install for mozprocess 16:42:58 INFO - Running setup.py install for mozprofile 16:42:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:42:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:42:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:42:58 INFO - Running setup.py install for mozrunner 16:42:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:42:58 INFO - Running setup.py install for mozscreenshot 16:42:58 INFO - Running setup.py install for moztest 16:42:59 INFO - Running setup.py install for mozversion 16:42:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:42:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:42:59 INFO - Cleaning up... 16:42:59 INFO - Return code: 0 16:42:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:42:59 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')]} 16:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:59 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')]} 16:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:59 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 0x7f96aae95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c52790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4f930>, '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 0x2c50830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c50cc0>, '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': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', '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 16:42:59 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 16:42:59 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 16:42:59 INFO - Using env: {'DISPLAY': ':0', 16:42:59 INFO - 'HOME': '/home/cltbld', 16:42:59 INFO - 'LANG': 'en_US.UTF-8', 16:42:59 INFO - 'LANGUAGE': 'en_US:en', 16:42:59 INFO - 'LOGNAME': 'cltbld', 16:42:59 INFO - 'MAIL': '/var/mail/cltbld', 16:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:59 INFO - 'MOZ_NO_REMOTE': '1', 16:42:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:59 INFO - 'NO_EM_RESTART': '1', 16:42:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:59 INFO - 'PWD': '/builds/slave/test', 16:42:59 INFO - 'SHELL': '/bin/bash', 16:42:59 INFO - 'SHLVL': '1', 16:42:59 INFO - 'TERM': 'linux', 16:42:59 INFO - 'TMOUT': '86400', 16:42:59 INFO - 'USER': 'cltbld', 16:42:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', 16:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:59 INFO - '_': '/tools/buildbot/bin/python'} 16:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:42:59 INFO - Running setup.py (path:/tmp/pip-uuqL_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:42:59 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)) 16:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:42:59 INFO - Running setup.py (path:/tmp/pip-6vXliI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:42:59 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)) 16:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:42:59 INFO - Running setup.py (path:/tmp/pip-Zt9_mC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:42:59 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)) 16:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:42:59 INFO - Running setup.py (path:/tmp/pip-fGIj9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:42:59 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)) 16:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:42:59 INFO - Running setup.py (path:/tmp/pip-MwsFfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:42:59 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)) 16:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:42:59 INFO - Running setup.py (path:/tmp/pip-kyq8ZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:42:59 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)) 16:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:42:59 INFO - Running setup.py (path:/tmp/pip-jnK1Ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:42:59 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)) 16:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:42:59 INFO - Running setup.py (path:/tmp/pip-tnxtlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:43:00 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)) 16:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:43:00 INFO - Running setup.py (path:/tmp/pip-7d7ZMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:43:00 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)) 16:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:43:00 INFO - Running setup.py (path:/tmp/pip-35SdBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:43:00 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)) 16:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:43:00 INFO - Running setup.py (path:/tmp/pip-7xELBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:43:00 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)) 16:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:43:00 INFO - Running setup.py (path:/tmp/pip-7JDHdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:43:00 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)) 16:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:43:00 INFO - Running setup.py (path:/tmp/pip-Q3GKBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:43:00 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)) 16:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:43:00 INFO - Running setup.py (path:/tmp/pip-EX1Tcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:43:00 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)) 16:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:00 INFO - Running setup.py (path:/tmp/pip-M7wvs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:00 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)) 16:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:43:00 INFO - Running setup.py (path:/tmp/pip-yi4XT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:43:00 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)) 16:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:43:00 INFO - Running setup.py (path:/tmp/pip-kYpFrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:43:00 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)) 16:43:00 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)) 16:43:00 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)) 16:43:00 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)) 16:43:00 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)) 16:43:00 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)) 16:43:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:43:00 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 16:43:00 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 16:43:00 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 16:43:00 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 16:43:00 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 16:43:00 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 16:43:02 INFO - Downloading blessings-1.6.tar.gz 16:43:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:43:02 INFO - Installing collected packages: blessings 16:43:02 INFO - Running setup.py install for blessings 16:43:02 INFO - Successfully installed blessings 16:43:02 INFO - Cleaning up... 16:43:02 INFO - Return code: 0 16:43:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:43:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:43:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:43:03 INFO - Reading from file tmpfile_stdout 16:43:03 INFO - Current package versions: 16:43:03 INFO - argparse == 1.2.1 16:43:03 INFO - blessings == 1.6 16:43:03 INFO - blobuploader == 1.2.4 16:43:03 INFO - docopt == 0.6.1 16:43:03 INFO - functools32 == 3.2.3-2 16:43:03 INFO - jsonschema == 2.5.1 16:43:03 INFO - manifestparser == 1.1 16:43:03 INFO - mozInstall == 1.12 16:43:03 INFO - mozcrash == 0.17 16:43:03 INFO - mozdebug == 0.1 16:43:03 INFO - mozdevice == 0.48 16:43:03 INFO - mozfile == 1.2 16:43:03 INFO - mozhttpd == 0.7 16:43:03 INFO - mozinfo == 0.9 16:43:03 INFO - mozleak == 0.1 16:43:03 INFO - mozlog == 3.4 16:43:03 INFO - moznetwork == 0.27 16:43:03 INFO - mozprocess == 0.23 16:43:03 INFO - mozprofile == 0.28 16:43:03 INFO - mozrunner == 6.12 16:43:03 INFO - mozscreenshot == 0.1 16:43:03 INFO - mozsystemmonitor == 0.3 16:43:03 INFO - moztest == 0.7 16:43:03 INFO - mozversion == 1.4 16:43:03 INFO - psutil == 3.1.1 16:43:03 INFO - requests == 1.2.3 16:43:03 INFO - wsgiref == 0.1.2 16:43:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:43:03 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')]} 16:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:03 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')]} 16:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:03 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 0x7f96aae95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c52790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4f930>, '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 0x2c50830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c50cc0>, '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': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', '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 16:43:03 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 16:43:03 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 16:43:03 INFO - Using env: {'DISPLAY': ':0', 16:43:03 INFO - 'HOME': '/home/cltbld', 16:43:03 INFO - 'LANG': 'en_US.UTF-8', 16:43:03 INFO - 'LANGUAGE': 'en_US:en', 16:43:03 INFO - 'LOGNAME': 'cltbld', 16:43:03 INFO - 'MAIL': '/var/mail/cltbld', 16:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:03 INFO - 'MOZ_NO_REMOTE': '1', 16:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:03 INFO - 'NO_EM_RESTART': '1', 16:43:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:03 INFO - 'PWD': '/builds/slave/test', 16:43:03 INFO - 'SHELL': '/bin/bash', 16:43:03 INFO - 'SHLVL': '1', 16:43:03 INFO - 'TERM': 'linux', 16:43:03 INFO - 'TMOUT': '86400', 16:43:03 INFO - 'USER': 'cltbld', 16:43:03 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', 16:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:03 INFO - '_': '/tools/buildbot/bin/python'} 16:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:03 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)) 16:43:03 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)) 16:43:03 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)) 16:43:03 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)) 16:43:03 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)) 16:43:03 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)) 16:43:03 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)) 16:43:03 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)) 16:43:03 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)) 16:43:03 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)) 16:43:03 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)) 16:43:03 INFO - Cleaning up... 16:43:03 INFO - Return code: 0 16:43:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:43:03 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')]} 16:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:03 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')]} 16:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:03 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 0x7f96aae95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c52790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4f930>, '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 0x2c50830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c50cc0>, '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': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', '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 16:43:03 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 16:43:03 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 16:43:03 INFO - Using env: {'DISPLAY': ':0', 16:43:03 INFO - 'HOME': '/home/cltbld', 16:43:03 INFO - 'LANG': 'en_US.UTF-8', 16:43:03 INFO - 'LANGUAGE': 'en_US:en', 16:43:03 INFO - 'LOGNAME': 'cltbld', 16:43:03 INFO - 'MAIL': '/var/mail/cltbld', 16:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:03 INFO - 'MOZ_NO_REMOTE': '1', 16:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:03 INFO - 'NO_EM_RESTART': '1', 16:43:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:03 INFO - 'PWD': '/builds/slave/test', 16:43:03 INFO - 'SHELL': '/bin/bash', 16:43:03 INFO - 'SHLVL': '1', 16:43:03 INFO - 'TERM': 'linux', 16:43:03 INFO - 'TMOUT': '86400', 16:43:03 INFO - 'USER': 'cltbld', 16:43:03 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', 16:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:03 INFO - '_': '/tools/buildbot/bin/python'} 16:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:43:03 INFO - Cleaning up... 16:43:03 INFO - Return code: 0 16:43:03 INFO - Running post-action listener: _resource_record_post_action 16:43:03 INFO - Running post-action listener: _start_resource_monitoring 16:43:03 INFO - Starting resource monitoring. 16:43:03 INFO - [mozharness: 2016-10-04 23:43:03.506993Z] Finished create-virtualenv step (success) 16:43:03 INFO - [mozharness: 2016-10-04 23:43:03.507508Z] Running install step. 16:43:03 INFO - Running pre-action listener: _resource_record_pre_action 16:43:03 INFO - Running main action method: install 16:43:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:43:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:43:03 INFO - Reading from file tmpfile_stdout 16:43:03 INFO - Detecting whether we're running mozinstall >=1.0... 16:43:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:43:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:43:03 INFO - Reading from file tmpfile_stdout 16:43:03 INFO - Output received: 16:43:03 INFO - Usage: mozinstall [options] installer 16:43:03 INFO - Options: 16:43:03 INFO - -h, --help show this help message and exit 16:43:03 INFO - -d DEST, --destination=DEST 16:43:03 INFO - Directory to install application into. [default: 16:43:03 INFO - "/builds/slave/test"] 16:43:03 INFO - --app=APP Application being installed. [default: firefox] 16:43:03 INFO - mkdir: /builds/slave/test/build/application 16:43:03 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'] 16:43:03 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 16:43:20 INFO - Reading from file tmpfile_stdout 16:43:20 INFO - Output received: 16:43:20 INFO - /builds/slave/test/build/application/firefox/firefox 16:43:20 INFO - Running post-action listener: _resource_record_post_action 16:43:20 INFO - [mozharness: 2016-10-04 23:43:20.805999Z] Finished install step (success) 16:43:20 INFO - [mozharness: 2016-10-04 23:43:20.806245Z] Running run-tests step. 16:43:20 INFO - Running pre-action listener: _resource_record_pre_action 16:43:20 INFO - Running main action method: run_tests 16:43:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:43:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:43:20 INFO - Python 2.7.3 16:43:20 INFO - Return code: 0 16:43:20 INFO - grabbing minidump binary from tooltool 16:43:20 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')]} 16:43:20 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 0x2c4f930>, '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 0x2c50830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c50cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:43:20 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 16:43:20 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 16:43:20 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 16:43:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:43:20 INFO - Return code: 0 16:43:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:43:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:43:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:43:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:43:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:43:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 16:43:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 16:43:20 INFO - Using env: {'DISPLAY': ':0', 16:43:20 INFO - 'HOME': '/home/cltbld', 16:43:20 INFO - 'LANG': 'en_US.UTF-8', 16:43:20 INFO - 'LANGUAGE': 'en_US:en', 16:43:20 INFO - 'LOGNAME': 'cltbld', 16:43:20 INFO - 'MAIL': '/var/mail/cltbld', 16:43:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:43:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:20 INFO - 'MOZ_NO_REMOTE': '1', 16:43:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:43:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:20 INFO - 'NO_EM_RESTART': '1', 16:43:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:20 INFO - 'PWD': '/builds/slave/test', 16:43:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:43:20 INFO - 'SHELL': '/bin/bash', 16:43:20 INFO - 'SHLVL': '1', 16:43:20 INFO - 'TERM': 'linux', 16:43:20 INFO - 'TMOUT': '86400', 16:43:20 INFO - 'USER': 'cltbld', 16:43:20 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825', 16:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:20 INFO - '_': '/tools/buildbot/bin/python'} 16:43:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 16:43:21 INFO - mozversion application_buildid: 20161004123002 16:43:21 INFO - mozversion application_changeset: 3470e326025c62381dc5f7c06629dbe5dbd7f242 16:43:21 INFO - mozversion application_display_name: Nightly 16:43:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:43:21 INFO - mozversion application_name: Firefox 16:43:21 INFO - mozversion application_remotingname: firefox 16:43:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 16:43:21 INFO - mozversion application_vendor: Mozilla 16:43:21 INFO - mozversion application_version: 52.0a1 16:43:21 INFO - mozversion platform_buildid: 20161004123002 16:43:21 INFO - mozversion platform_changeset: 3470e326025c62381dc5f7c06629dbe5dbd7f242 16:43:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 16:43:21 INFO - mozversion platform_version: 52.0a1 16:43:21 INFO - using testdate: 1475624601 16:43:21 INFO - actual date: 1475624601 16:43:21 INFO - starting webserver on 'localhost:40487' 16:43:21 INFO - SUITE-START | Running 2 tests 16:43:21 INFO - TEST-START | dromaeo_css 16:43:21 INFO - operating with platform_type : linux_ 16:43:21 INFO - Initialising browser for dromaeo_css test... 16:43:21 INFO - TEST-INFO | started process 15967 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4s9EER/profile http://localhost:40487/getInfo.html) 16:43:26 INFO - PROCESS | 15967 | __metrics Screen width/height:1600/1200 16:43:26 INFO - PROCESS | 15967 | colorDepth:24 16:43:26 INFO - PROCESS | 15967 | Browser inner width/height: 1024/697 16:43:26 INFO - PROCESS | 15967 | __metrics 16:43:27 INFO - PROCESS | 15967 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:43:27 INFO - PROCESS | 15967 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:43:27 INFO - PROCESS | 15967 | console.error: PushService: 16:43:27 INFO - PROCESS | 15967 | stateChangeProcessEnqueue: Error transitioning state 16:43:27 INFO - PROCESS | 15967 | UnknownError 16:43:28 INFO - TEST-INFO | 15967: exit 0 16:43:28 INFO - Browser initialized. 16:43:28 INFO - Running cycle 1/1 for dromaeo_css test... 16:43:28 INFO - TEST-INFO | started process 16046 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4s9EER/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:43:40 INFO - PROCESS | 16046 | RSS: Main: 173363200 16:43:40 INFO - PROCESS | 16046 | 16:44:31 INFO - PROCESS | 16046 | 1475624671557 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] 16:46:41 INFO - PROCESS | 16046 | Cycle 1(1): loaded http://localhost:40487/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40487/tests/dromaeo/cssquery-ext.html) 16:46:45 INFO - PROCESS | 16046 | RSS: Main: 499159040 16:46:45 INFO - PROCESS | 16046 | 16:49:48 INFO - PROCESS | 16046 | Cycle 1(1): loaded http://localhost:40487/tests/dromaeo/cssquery-ext.html (next: http://localhost:40487/tests/dromaeo/cssquery-jquery.html) 16:49:48 INFO - PROCESS | 16046 | RSS: Main: 297267200 16:49:48 INFO - PROCESS | 16046 | 16:52:50 INFO - PROCESS | 16046 | Cycle 1(1): loaded http://localhost:40487/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40487/tests/dromaeo/cssquery-mootools.html) 16:52:51 INFO - PROCESS | 16046 | RSS: Main: 221360128 16:52:51 INFO - PROCESS | 16046 | 16:55:53 INFO - PROCESS | 16046 | Cycle 1(1): loaded http://localhost:40487/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40487/tests/dromaeo/cssquery-prototype.html) 16:55:53 INFO - PROCESS | 16046 | RSS: Main: 280350720 16:55:53 INFO - PROCESS | 16046 | 16:58:56 INFO - PROCESS | 16046 | Cycle 1(1): loaded http://localhost:40487/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40487/tests/dromaeo/cssquery-yui.html) 16:58:57 INFO - PROCESS | 16046 | RSS: Main: 222392320 16:58:57 INFO - PROCESS | 16046 | 17:02:00 INFO - PROCESS | 16046 | Cycle 1(1): loaded http://localhost:40487/tests/dromaeo/cssquery-yui.html (next: http://localhost:40487/tests/dromaeo/cssquery-dojo.html) 17:02:00 INFO - PROCESS | 16046 | RSS: Main: 311894016 17:02:00 INFO - PROCESS | 16046 | 17:02:00 INFO - PROCESS | 16046 | __start_tp_report 17:02:00 INFO - PROCESS | 16046 | _x_x_mozilla_page_load 17:02:00 INFO - PROCESS | 16046 | _x_x_mozilla_page_load_details 17:02:00 INFO - PROCESS | 16046 | |i|pagename|runs| 17:02:00 INFO - PROCESS | 16046 | |0;dojo.html;2992.2369795702098;3039.042701549013;3047.1467988963086;3071.8771249150036;3095.566620673106;5018.824341148061;5106.234064890268;5175.896482070361;5215.374155101384;5276.208568714695;5185.896282074356;5202.3497062867145;5245.10833158363;5267;5371.838844834651;4694.201985662428;4784.043191361724;4814.229723244282;4818.012307476976;4823.517648235166;4749.667523273372;4774.952250477503;4790.401199850019;4819.734914579697;4935.728534930578;4841.515848415148;4854.87862803431;4866.197077482211;4920.0159968006365;4942.678725882806;4636.374089497908;4678.157931572316;4703.929441058387;4824.565789078964;4833.32333473314;4651.255799072166;4653.7440440775745;4658.301254811805;4717.1980763269985;4810;5137.255098010804;5138.537531622172;5158.896822063575;5185.714785686786;5227.764750586195;5390.730463476811;5428.809991650273;5543.528800052;5552.666839989613;5552.666839989613;5533.529649979716;5558.888822223533;5573.386927437979;5591.217229587861;5591.692456914868;5190.662606930538;5221.269022336875;5222.582193424517;5222.869428264248;5282.418933917266;5521.779128834802;5579.163125531121;5697.0599851024945;5702.942970570324;5703.058995265735;5384.892302154013;5469.753861076261;5471.534919531805;5481.2874326338115;5543.61194716366;5552.056150454432;5559.8888022239325;5565.916511252334;5566.944330556724;5567.47109024642;5523.171524271311;5530.087535556588;5535.723213839292;5538.44615538451;5598.384177740445;5277.63056586043;5392.460753924576;5482.780688772485;5501.202325662756;5514.724263786795;4306.375575541529;4368.497622773421;4369.737815731066;4375.16871794358;4375.693701440869;3881.107345310594;3886.455896174538;3904.2777086239134;3945;3946.1713040261866;5159.329287192641;5264.578833693296;5270.156774915995;5275.868103297372;5276.868078298074;5482.780688772405;5525.11598144295;5584.748686309126;5588.44115588446;5591.329040515164;5248.606354523426;5259.316288882421;5261.76322065508;5262.368515778131;5263.736813159327;4812.205986012269;4813.663043586916;4826.276058591239;4829.203181475087;4829.855104346875;5632.887342253132;5633.155026746021;5667.1782591524;5754.021816291157;5756.625819321815;5527.944720552743;5530.55755539564;5530.585206109477;5533.142362933751;5590.776368945197;5701.629394089371;5705.486506214461;5712.02895507773;5713.628614140068;5715.142728590578;5302.575793936553;5331.893362132813;5333.919991200058;5390.407055223844;5431.131019036935;5481.5340696041285;5487.396386397413;5487.780488780404;5489.807856724996;5496.725163741877;5352.759125839424;5365.812196573102;5366.275552800322;5366.382865970308;5368.785248590013;5337.119375303031;5339.626226164131;5346.465353464778;5348.973255133699;5350.866228344167;5237;5346.304980352529;5346.866328341823;5348.5186333230195;5349.839504814861;5340;5384.7576859040655;5393.9730301348245;5438.15708565173;5442.891142177214;5351.063563876384;5353.116735738559;5353.598480113929;5387.245785590099;5395.541378982673 17:02:00 INFO - PROCESS | 16046 | |1;ext.html;591.8047044475323;606.704685496465;611.2054329371815;613.7452957022836;626.9843253918651;41978.79010604946;43586.56413435865;43758;47578.52421475784;47610.285845712344;45467.54532454674;46054;46093.30860037102;46110.76944615272;46129;7929.008873890763;8996.145366190201;9112.407693499934;9114.316426268024;9123.452592844418;8054.637541310626;10547.789044219111;10817.350958942488;10820.72948176294;11137.554497820078;11159.107271418308;11236.157288203376;11236.49435775388;11238.325700457957;11239.719007024809;10890.782184356309;10980.121590272758;10995.175361847894;10998.12015038803;10999.395033273127;10753.83869241962;10833.187510936712;10833.945830270877;10838.566457341696;10840.945795271053;42351;42678.35982460265;42692.57307426948;42717.57282427198;42747.35878961818;3456.602490713575;3593.6765691087667;3685.6682898538993;3713.442983552489;3889.533256009269;31697.52453713196;31754.206144846332;32051;32071.679283207337;32765.6723432765;4242;4317.201317756194;4388.078503514266;4472.172648060086;4496.617787488068;330247;330614;333874;334961;336028;59927;60350.69824650937;60526.394736052076;60772.69613651992;60869.69565152146;36036;36552.97917229102;64244.67877660675;64318.35681643217;64346.35653643497;16857.83142168587;17374.65250694979;17393;17420.128993550272;17426.21582028812;12031.518739250332;12279.324637144864;12815.231086134861;13231.470741170246;13345.199288042748;18558.401823744687;19397.321093761933;19466.610667786565;19528.414147575313;19561.90219048924;6858.862822743517;6935.791926242221;7034.753783617549;7088.149422069385;7253.637318134072;883.1786438612024;962.3549391452035;1013.6553571785628;1024.7284469615408;1085.1644233939821;31398;31607.683923160475;31697.366052679277;31911.20221994422;32062.83968580142;1061.3260579531898;1091.8525998990035;1094.9288296260877;1117.782032503654;1130.2032067392468;15971.281292341873;16744.330226790793;16783.496495105166;16835.57911052209;16907.577310567332;461952;466867;467074;467507;468334;57348.42651573514;57710.134347984815;57825;57932.710336448894;57947.71026144927;1212.345333519907;1263.040089531944;1311.7573248948975;1324.4635922451423;1375.5460697969845;31116.53325200169;32103;33138;33444.66555334415;34474.482882756274;55045.44954550403;55695;55925;55947;55960;460145;464242;464280;464314.9253582171;688685;42194.57805421906;42390.78804605957;43045.784771075945;43545.56454435415;43550.12899741924;46780.53219467762;47073;47097.7645111786;47707.52292477031;48308.27537586869;39693.099742583196;40428.59571404248;40436.393454097626;40941.59058409378;42443.57556424396;40217.39673904835;41141;41824;42224.78887605542;42482.57517424786;39079.609203907596;39361.80319098386;39585.80207098946;39942.2011559773;40730;32715.34569308648;35297.2351382435;35892.64107358893;38219.808900955315;38996.22007559776;25676;25694.87152564225;25779.613305800052;25802;25960.74039259659 17:02:00 INFO - PROCESS | 16046 | |2;jquery.html;373.98691045813405;391.9392494163404;405.5964315506072;405.68762053219024;418.58978201362663;13289.202647841124;15048.548543543697;18824.529386765338;18989.52526186846;19216.615667686638;18125.728114078265;18461.261549538;18562.07189640516;18597.814021859776;19315;5263.31576895005;5702.7433765480655;5958.52331813456;5965.254343207099;5966.343702192756;5382.838514844561;5922.88154236915;5931.4068593140555;5931.495822855062;5942.108683697436;5656.632318899258;5765.596408251424;5898.823035308927;5902;5904.3800400957925;5752.252207213078;5801.593888427812;5803.071508558632;5808.738606762706;5814.825555233349;5023.8492845214705;5176.482351764831;5207.192885102815;5226.05930932432;5239.79040838366;21996;22600.66099008516;22682;22745.77254227453;22933.655995160087;2314.0281081945623;2418.2226063843063;2426.7694569015916;2946.4254470378287;3047.481928072233;13817.309134543233;14140.787888181685;14157.646058848508;14588.635284117981;15020.849791502054;1807.8734488585803;1874.709420039896;1879.3328368429284;1951.9316823911095;1958.921643134273;78806.6059669698;80099;80120.59939700323;81152.18847811564;81186;9999.950000249952;10404.531796069195;10432.5826966922;10659.94670026645;10992.120630349553;14953.626159346104;14955.850441495664;14973.70052598942;14996.325165367585;15006.849931500763;7460.253974602496;7525;7575.24247575238;7654.961725191339;7795.064592248967;7083.15002199729;7134.536255143399;7328.78013659591;7353.742619008309;7384.298491643285;6335.936640633627;6391.840203994844;6420.293767685551;6427.967860160669;6433.871322573522;1886.0663971334004;1899.43017094871;1905.6760350740408;1925.1817977359567;1957.1388589020785;895.9328050396247;977.4770497783652;990.7919336939179;1012.5797793915442;1014.5789497358513;18421.631567368844;19176;19314;19401.708974365396;19527;959.0744931141481;962.6005207838808;1030.860833787444;1031.8555402243692;1066.4507778494083;9997.550110245056;10879.945600271947;11058.391788451552;11112.16658750597;11138.832917506244;423039;429790;431190;432476;433359;74624.62687686636;76437.61781191059;76440;77011.61494192493;77559.22440775632;998.4059484606647;1003.242551873331;1036.0623635609786;1043.4574021508772;1043.7495001199657;16372.508824735278;16992.745108823623;17207.56981075483;17239.310427582757;17301.13494325304;39040.21919561536;39057.80471097626;39438.605613944645;39441.46423161258;39802.60197398105;48707;48789.5121048785;48823.267650985974;48862;49348.2597761041;8106.148854370442;8266.669333226604;8299.087100418828;8582.914170858461;8915.55422228873;12358.938205308916;12567.685807854878;12629.81055284153;12680.11239213283;12937.935310323388;10653.840192396965;11287.492062857027;11299.209055366046;11560.6531804046;11561.595344162914;10814.45927703596;11102.50116234298;11203.327800332007;11393.316401015965;11534.94232528832;11477.885221148015;11546.94226528862;11563.6530904073;11599.536018559163;11832.290062596272;8336.124706905688;8436.662533498591;8463.619137138721;8472.66109355619;8540.779397356857;11059.72350691239;11378.772424551296;11474.254173478697;11486;11751.647450576496 17:02:00 INFO - PROCESS | 16046 | |3;mootools.html;1356.4980957045896;1446.211814561064;1482.0885155629285;1650.5956040770013;1788.2668106076512;7526;8241.958790206048;8538.48769073856;8546.359023073272;8779.165979231979;8571.22858942695;8658.523781192032;8669.566521673923;8677.869831952527;8684.8697269541;2252.076648574089;2274.7042884425;2278.840481166319;2281.247188427823;2281.6235321171985;2207.87856667884;2229.4314949687887;2270.6821045053707;2271.2277825539313;2271.239134889814;2232.0298265907377;2250.9887450562724;2257.0407576779885;2257.7290725113007;2263.6151854184827;2139.764625891151;2158.9784102158933;2160.438286045624;2166.2526428382184;2169.7287839020123;2118.8875840183873;2122.61792877282;2125.7555381131215;2125.787421257877;2129.169623846701;8434.915650843473;8596.183362580545;8598.398112132154;8695;8710.956445217796;4942.604591632661;5086.79652813887;5089;5105;5111.948880511221;3331.267121233325;3465.376232278189;3523.541939547868;3526.2066035142143;3532.6467353264725;1068.3216157739814;1086.1202426034938;1109.3842917180962;1138.1861968692424;1146.2434793036555;12059.939700301442;12060.638180854588;12105.334206618632;12123.454444550016;12156.756864862653;4226.936595951063;4306.590873866978;4483.708558943724;4499.932501012488;4502.954970450253;9445.10271524218;9454;9475.526223688788;9539.284553658503;9556.092171243721;5206.036883176549;5217.373915130209;5218.347706536683;5220.582353411718;5223.425423203445;4218.261804184255;4350.21696094706;4610.608098311681;4731.124741922756;4896.828610998669;3591;3594.712423006153;3719.6652301293016;3736.5516138063062;3742.9438558421643;1093.578972095733;1097.182598963777;1104.939228342433;1110.9333439993466;1131.852859128308;912.1562554637067;923.3951761596165;925.0795458518683;945.8344789661782;974.0648976982035;5675.01286143123;5793.652380857162;5924.644521328734;6096.146539484475;6214.751409943552;434.4374035623875;442.92913133899066;444.4422250076198;445.69247219419145;455.151143118089;4142.896427589274;4216.578342165759;4236.957630423718;4237.8304867805555;4272.230998420252;10494.265401421828;10626.096781773636;10771.246012779031;10775.892241077645;10776.137908967265;10651.041406273473;10668.62659806903;10677.092447141924;10708.625198118028;10721.83917241242;7667.386609071261;7964.084130324971;8021;8107.594620268963;8128.390370722102;6023.879522409439;6064.696765161636;6081;6096.664683442275;6123.418275263843;9946.104850563484;9976.800463990825;10007.249456290661;10069.496525173858;10120.797584048425;9504.144626983605;9866.210703143875;9943.701688949342;10130.594776208869;10213.897861021294;6899.931000689929;7126.750563730245;7334.193238743627;7794.064712234568;8002.639881205476;7892.802679933047;8368.456050356708;8380.24577788002;8381.203785640355;8381.287590554872;7250.709971601288;7316.561006339637;7341.926580734124;7566.583837888748;7700.653470593725;7128.679209435484;7549.245075492407;7571.432142589218;7703.922960770545;7718.266764657348;6700.631465269457;6857.074294970115;6918.273581273894;6922.480813938874;6923.342282483156;5143.382794064736;5178.587458482548;5230.110881150137;5237.81667641646;5314.5216930476445;5243.449437808975;5267.894642107213;5327.840164795062;5428.945710543002;5437.918431223614 17:02:00 INFO - PROCESS | 16046 | |4;prototype.html;324.45586048398;336.4398276869013;346.57890662844636;348.2894894415393;350.7474618274844;5217.843464696056;5243.737813109344;5261.526462618363;5266.657667251626;5306.044911915854;5189.740512974346;5199.09015922214;5201.115810312246;5204.115300398932;5240.292560504331;4181.811818468176;4184.539700632943;4186.330187170053;4196.971741923233;4237.512686041114;3620.7284453665948;4005.6394924456795;4071.5521292657786;4166.458360413158;4194.916101677964;4118.341065429532;4131.194417088669;4132.648724858391;4135.29699951009;4148.751074935513;4159.979200103995;4182.581741825824;4182.64447521961;4191.517975432834;4200.222958752641;3562.768420052714;3600.8559657613664;3643.7813731176216;3677.7057835373107;3749.887503374903;5014.398272207322;5034.244863270502;5058.620603454756;5060.898782024376;5128.71792051437;4687.7656117194;4694.906101877943;4705.694129881581;4710.882227944295;4738.549837765441;5251.162093267364;5380.771537077761;5406.405295417501;5411.64824286424;5447.673139611636;4035.656969157625;4036.495438070241;4037.4953130858644;4046.7571945683353;4060.898477538085;5443.700596467233;5590.496855283044;5692.8861422771315;5721.256236689203;5731.914021289684;4111.376006477425;4161.750294982311;4184.5311266353;4186.539480657125;4199.538050814408;4199.538050814408;4216.557261487561;4231.386448964883;4235.343521754133;4243.5119961204855;4569.657275704336;4733.692309999839;4756.382829837872;4762.309465127606;4764.976175119103;5438.3473983121485;5461.863453413696;5466;5470.206820011076;5473.124300112043;1449.398499622666;1460;1461.7880407340876;1462.444271176946;1464.2385959301105;921.1574328302113;947.1144479911305;965.3628605120587;967.2165545907696;969.3699095587924;4646.697964632355;4679.81280748773;4696.2955556666775;4699.718016918996;4726.8109275628585;4892.730899800474;4895.534924182197;4900.166971614834;4912.926306105412;4953.405591328991;4650.581447669726;4658.836940707059;4675.43372970052;4745.928811067837;5002.2496625506465;2932.8240305581735;2959.6300462442196;2960.6743258241577;2960.807547509405;2962.740835145055;5732.7706891723865;5749.712514374264;5767;5792.899349123653;5809.535237181015;5588.944110558842;5668.404817494104;5698.943010569924;5728.226689396878;5731.423858438962;5699.458551437607;5739.85650358736;5742.54059675225;5743.368229494752;5750.654960702372;5377.300950876361;5578.916316255179;5600.187972744011;5611.971940140274;5646.153077038477;5464.316960379952;5514.91727624078;5518.724063796713;5529.751161197836;5530.5022547970875;5504.889902202013;5554.2779438672715;5629.577781666473;5706.629069110494;5785.508231800176;4060.451839001697;4062.817173227271;4066.12578295656;4075.2868248057066;4079.163771426791;5590.944090559043;5599.552035837041;5607.299087614048;5608.439156084359;5633.6619802811965;5202.24567437727;5455.345358556999;5459.945400546103;5482.5888058394985;5485.204645326485;5448.564114870722;5463.72681365938;5466.91799622998;5469.906018796177;5503.697296648723;5310.6813591184655;5463.7814487420055;5473.589480788877;5479.4520547944885;5547.694876781816;5474.220878214516;5480.698106795236;5482.479164479368;5485.803360429195;5494.890102197854;5344.064788661891;5347.839564813062;5352.759125839424;5421.83734487966;5451.127819549012 17:02:00 INFO - PROCESS | 16046 | |5;yui.html;708.564232996707;713.9326706573673;723.6490302203433;735.4153448008834;774.2528460036064;15538.689226215469;16375;16735.33058677653;17397.391091311805;17467.737983930252;15957.361705531794;15975.201239938015;16087.356505739786;16210.675786484264;16233.431829885956;663.0783211336246;783.8510682970217;805.5851236613149;808.308895894011;809.8461292354434;673.515069150211;783.3263393481601;798.7803354077618;819.2258315891485;819.2790344496834;855.0423525651248;857.0700789643245;857.4512312120248;857.7341024282492;858.8668756342777;680.880845851974;852.8038551133212;853.9316854651613;854.7093988044095;855.550835811201;516.2153526639524;606.0364021206259;624.6002558362652;627.3851625407127;628.6291088257904;15432.305546250445;15473;15497.845021549752;15503;15520.767188492182;13697;14199.78700319496;14477.276136193148;14531.564053078318;14738.115713057143;11936.701582460508;12004.279743215347;12092.455839487156;12161.209521381083;12190.2076365036;4283.914321713548;4288.69979101463;4328.675349348811;4529.932051019237;4537.228671125917;78395.6080219601;78435.21564784336;79001.60499197467;80517;83485.58257208735;10795.082417994558;10839.83740243897;10971.177161712903;11198.776024479464;11725.824112638316;21209.89395053015;21471.14115435396;21510.13959441636;21569;21592.35222943314;8274.544900030436;8340.708075217339;8698.956505217433;8877.289816814638;8978.955105224431;4519.29950857611;4533.297338912474;4605.447346318396;4616.976915115471;4669.836555720533;3666.431703086026;3831.8084095795098;3842.0779013037227;3844.8077596120083;3847.480590120354;653.1672118049524;657.9768460044677;667.9165104361955;668.204836244867;668.391763495217;673.5857447669746;683.1370920702649;702.7786247332074;716;717.1752484642599;8131.5267713114745;9062.888714600396;9739.69868210661;9927.255455840841;9971.850422243671;578.6556998585835;586.4340911020801;628.5505863307666;642.5181114164377;685.7917505631857;4522.29904364824;4994.225894986283;5010.423801262901;5087.798512461475;5187.844364669066;113613;113872.43063784628;120086;121007;124254;62744.372556274764;78436;103219.96780032254;105066.51203015492;105687;93291;94370;97802.5109874446;99876.5006174979;100804.49597751965;9679.612815487302;10168.33905796121;10175.949120254352;10230.6419275325;10438.217133715154;53549.464505354445;54137.18794218011;54236.728816355666;55033.449665502834;56205.71897140488;47424.52575474201;48542.757286213346;60612.393876060676;63151.36848631639;68322;12693.174943628635;13027.153235039692;13092.672683182996;13188.274644894624;13795.517156899461;14535.636609084857;14878.628034298796;15032.774508382165;15610.765838512658;15785.28966196547;13622.523211687543;13811.51659691906;14074.718505629626;14128;14206.857931420553;12476.688082798002;12935.547255846;13016.544420945222;13297.80053299182;13429.462821487032;13692.589222323346;13747;13998.790018149939;14033.929830350782;14742.410303587736;10559.736006599896;11009.61466348674;11306.152038597302;11404.771904561696;11511.424428778695;11180;11358.318500889973;11359.772804544029;11361.886381136082;11606 17:02:00 INFO - PROCESS | 16046 | __end_tp_report 17:02:00 INFO - PROCESS | 16046 | __start_cc_report 17:02:00 INFO - PROCESS | 16046 | _x_x_mozilla_cycle_collect,3442 17:02:00 INFO - PROCESS | 16046 | __end_cc_report 17:02:00 INFO - PROCESS | 16046 | __startTimestamp1475625720659__endTimestamp 17:02:00 INFO - PROCESS | 16046 | 17:02:00 INFO - PROCESS | 16046 | ------- Summary: start ------- 17:02:00 INFO - PROCESS | 16046 | Number of tests: 6 17:02:00 INFO - PROCESS | 16046 | 17:02:00 INFO - PROCESS | 16046 | [#0] dojo.html Cycles:165 Average:5158.84 Median:5346.30 stddev:547.30 (10.2%) stddev-sans-first:521.92 17:02:00 INFO - PROCESS | 16046 | Values: 2992.2 3039.0 3047.1 3071.9 3095.6 5018.8 5106.2 5175.9 5215.4 5276.2 5185.9 5202.3 5245.1 5267.0 5371.8 4694.2 4784.0 4814.2 4818.0 4823.5 4749.7 4775.0 4790.4 4819.7 4935.7 4841.5 4854.9 4866.2 4920.0 4942.7 4636.4 4678.2 4703.9 4824.6 4833.3 4651.3 4653.7 4658.3 4717.2 4810.0 5137.3 5138.5 5158.9 5185.7 5227.8 5390.7 5428.8 5543.5 5552.7 5552.7 5533.5 5558.9 5573.4 5591.2 5591.7 5190.7 5221.3 5222.6 5222.9 5282.4 5521.8 5579.2 5697.1 5702.9 5703.1 5384.9 5469.8 5471.5 5481.3 5543.6 5552.1 5559.9 5565.9 5566.9 5567.5 5523.2 5530.1 5535.7 5538.4 5598.4 5277.6 5392.5 5482.8 5501.2 5514.7 4306.4 4368.5 4369.7 4375.2 4375.7 3881.1 3886.5 3904.3 3945.0 3946.2 5159.3 5264.6 5270.2 5275.9 5276.9 5482.8 5525.1 5584.7 5588.4 5591.3 5248.6 5259.3 5261.8 5262.4 5263.7 4812.2 4813.7 4826.3 4829.2 4829.9 5632.9 5633.2 5667.2 5754.0 5756.6 5527.9 5530.6 5530.6 5533.1 5590.8 5701.6 5705.5 5712.0 5713.6 5715.1 5302.6 5331.9 5333.9 5390.4 5431.1 5481.5 5487.4 5487.8 5489.8 5496.7 5352.8 5365.8 5366.3 5366.4 5368.8 5337.1 5339.6 5346.5 5349.0 5350.9 5237.0 5346.3 5346.9 5348.5 5349.8 5340.0 5384.8 5394.0 5438.2 5442.9 5351.1 5353.1 5353.6 5387.2 5395.5 17:02:00 INFO - PROCESS | 16046 | 17:02:00 INFO - PROCESS | 16046 | [#1] ext.html Cycles:180 Average:60464.45 Median:39473.80 stddev:117986.80 (298.9%) stddev-sans-first:118232.15 17:02:00 INFO - PROCESS | 16046 | Values: 591.8 606.7 611.2 613.7 627.0 41978.8 43586.6 43758.0 47578.5 47610.3 45467.5 46054.0 46093.3 46110.8 46129.0 7929.0 8996.1 9112.4 9114.3 9123.5 8054.6 10547.8 10817.4 10820.7 11137.6 11159.1 11236.2 11236.5 11238.3 11239.7 10890.8 10980.1 10995.2 10998.1 10999.4 10753.8 10833.2 10833.9 10838.6 10840.9 42351.0 42678.4 42692.6 42717.6 42747.4 3456.6 3593.7 3685.7 3713.4 3889.5 31697.5 31754.2 32051.0 32071.7 32765.7 4242.0 4317.2 4388.1 4472.2 4496.6 330247.0 330614.0 333874.0 334961.0 336028.0 59927.0 60350.7 60526.4 60772.7 60869.7 36036.0 36553.0 64244.7 64318.4 64346.4 16857.8 17374.7 17393.0 17420.1 17426.2 12031.5 12279.3 12815.2 13231.5 13345.2 18558.4 19397.3 19466.6 19528.4 19561.9 6858.9 6935.8 7034.8 7088.1 7253.6 883.2 962.4 1013.7 1024.7 1085.2 31398.0 31607.7 31697.4 31911.2 32062.8 1061.3 1091.9 1094.9 1117.8 1130.2 15971.3 16744.3 16783.5 16835.6 16907.6 461952.0 466867.0 467074.0 467507.0 468334.0 57348.4 57710.1 57825.0 57932.7 57947.7 1212.3 1263.0 1311.8 1324.5 1375.5 31116.5 32103.0 33138.0 33444.7 34474.5 55045.4 55695.0 55925.0 55947.0 55960.0 460145.0 464242.0 464280.0 464314.9 688685.0 42194.6 42390.8 43045.8 43545.6 43550.1 46780.5 47073.0 47097.8 47707.5 48308.3 39693.1 40428.6 40436.4 40941.6 42443.6 40217.4 41141.0 41824.0 42224.8 42482.6 39079.6 39361.8 39585.8 39942.2 40730.0 32715.3 35297.2 35892.6 38219.8 38996.2 25676.0 25694.9 25779.6 25802.0 25960.7 17:02:00 INFO - PROCESS | 16046 | 17:02:00 INFO - PROCESS | 16046 | [#2] jquery.html Cycles:180 Average:26516.24 Median:2996.95 stddev:70794.21 (2362.2%) stddev-sans-first:70965.60 17:02:00 INFO - PROCESS | 16046 | Values: 374.0 391.9 405.6 405.7 418.6 13289.2 15048.5 18824.5 18989.5 19216.6 18125.7 18461.3 18562.1 18597.8 19315.0 5263.3 5702.7 5958.5 5965.3 5966.3 5382.8 5922.9 5931.4 5931.5 5942.1 5656.6 5765.6 5898.8 5902.0 5904.4 5752.3 5801.6 5803.1 5808.7 5814.8 5023.8 5176.5 5207.2 5226.1 5239.8 21996.0 22600.7 22682.0 22745.8 22933.7 2314.0 2418.2 2426.8 2946.4 3047.5 13817.3 14140.8 14157.6 14588.6 15020.8 1807.9 1874.7 1879.3 1951.9 1958.9 78806.6 80099.0 80120.6 81152.2 81186.0 10000.0 10404.5 10432.6 10659.9 10992.1 14953.6 14955.9 14973.7 14996.3 15006.8 7460.3 7525.0 7575.2 7655.0 7795.1 7083.2 7134.5 7328.8 7353.7 7384.3 6335.9 6391.8 6420.3 6428.0 6433.9 1886.1 1899.4 1905.7 1925.2 1957.1 895.9 977.5 990.8 1012.6 1014.6 18421.6 19176.0 19314.0 19401.7 19527.0 959.1 962.6 1030.9 1031.9 1066.5 9997.6 10879.9 11058.4 11112.2 11138.8 423039.0 429790.0 431190.0 432476.0 433359.0 74624.6 76437.6 76440.0 77011.6 77559.2 998.4 1003.2 1036.1 1043.5 1043.7 16372.5 16992.7 17207.6 17239.3 17301.1 39040.2 39057.8 39438.6 39441.5 39802.6 48707.0 48789.5 48823.3 48862.0 49348.3 8106.1 8266.7 8299.1 8582.9 8915.6 12358.9 12567.7 12629.8 12680.1 12937.9 10653.8 11287.5 11299.2 11560.7 11561.6 10814.5 11102.5 11203.3 11393.3 11534.9 11477.9 11546.9 11563.7 11599.5 11832.3 8336.1 8436.7 8463.6 8472.7 8540.8 11059.7 11378.8 11474.3 11486.0 11751.6 17:02:00 INFO - PROCESS | 16046 | 17:02:00 INFO - PROCESS | 16046 | [#3] mootools.html Cycles:180 Average:5651.16 Median:5014.70 stddev:3236.61 (64.5%) stddev-sans-first:3229.60 17:02:00 INFO - PROCESS | 16046 | Values: 1356.5 1446.2 1482.1 1650.6 1788.3 7526.0 8242.0 8538.5 8546.4 8779.2 8571.2 8658.5 8669.6 8677.9 8684.9 2252.1 2274.7 2278.8 2281.2 2281.6 2207.9 2229.4 2270.7 2271.2 2271.2 2232.0 2251.0 2257.0 2257.7 2263.6 2139.8 2159.0 2160.4 2166.3 2169.7 2118.9 2122.6 2125.8 2125.8 2129.2 8434.9 8596.2 8598.4 8695.0 8711.0 4942.6 5086.8 5089.0 5105.0 5111.9 3331.3 3465.4 3523.5 3526.2 3532.6 1068.3 1086.1 1109.4 1138.2 1146.2 12059.9 12060.6 12105.3 12123.5 12156.8 4226.9 4306.6 4483.7 4499.9 4503.0 9445.1 9454.0 9475.5 9539.3 9556.1 5206.0 5217.4 5218.3 5220.6 5223.4 4218.3 4350.2 4610.6 4731.1 4896.8 3591.0 3594.7 3719.7 3736.6 3742.9 1093.6 1097.2 1104.9 1110.9 1131.9 912.2 923.4 925.1 945.8 974.1 5675.0 5793.7 5924.6 6096.1 6214.8 434.4 442.9 444.4 445.7 455.2 4142.9 4216.6 4237.0 4237.8 4272.2 10494.3 10626.1 10771.2 10775.9 10776.1 10651.0 10668.6 10677.1 10708.6 10721.8 7667.4 7964.1 8021.0 8107.6 8128.4 6023.9 6064.7 6081.0 6096.7 6123.4 9946.1 9976.8 10007.2 10069.5 10120.8 9504.1 9866.2 9943.7 10130.6 10213.9 6899.9 7126.8 7334.2 7794.1 8002.6 7892.8 8368.5 8380.2 8381.2 8381.3 7250.7 7316.6 7341.9 7566.6 7700.7 7128.7 7549.2 7571.4 7703.9 7718.3 6700.6 6857.1 6918.3 6922.5 6923.3 5143.4 5178.6 5230.1 5237.8 5314.5 5243.4 5267.9 5327.8 5428.9 5437.9 17:02:00 INFO - PROCESS | 16046 | 17:02:00 INFO - PROCESS | 16046 | [#4] prototype.html Cycles:180 Average:4580.06 Median:5194.42 stddev:1312.45 (25.3%) stddev-sans-first:1276.67 17:02:00 INFO - PROCESS | 16046 | Values: 324.5 336.4 346.6 348.3 350.7 5217.8 5243.7 5261.5 5266.7 5306.0 5189.7 5199.1 5201.1 5204.1 5240.3 4181.8 4184.5 4186.3 4197.0 4237.5 3620.7 4005.6 4071.6 4166.5 4194.9 4118.3 4131.2 4132.6 4135.3 4148.8 4160.0 4182.6 4182.6 4191.5 4200.2 3562.8 3600.9 3643.8 3677.7 3749.9 5014.4 5034.2 5058.6 5060.9 5128.7 4687.8 4694.9 4705.7 4710.9 4738.5 5251.2 5380.8 5406.4 5411.6 5447.7 4035.7 4036.5 4037.5 4046.8 4060.9 5443.7 5590.5 5692.9 5721.3 5731.9 4111.4 4161.8 4184.5 4186.5 4199.5 4199.5 4216.6 4231.4 4235.3 4243.5 4569.7 4733.7 4756.4 4762.3 4765.0 5438.3 5461.9 5466.0 5470.2 5473.1 1449.4 1460.0 1461.8 1462.4 1464.2 921.2 947.1 965.4 967.2 969.4 4646.7 4679.8 4696.3 4699.7 4726.8 4892.7 4895.5 4900.2 4912.9 4953.4 4650.6 4658.8 4675.4 4745.9 5002.2 2932.8 2959.6 2960.7 2960.8 2962.7 5732.8 5749.7 5767.0 5792.9 5809.5 5588.9 5668.4 5698.9 5728.2 5731.4 5699.5 5739.9 5742.5 5743.4 5750.7 5377.3 5578.9 5600.2 5612.0 5646.2 5464.3 5514.9 5518.7 5529.8 5530.5 5504.9 5554.3 5629.6 5706.6 5785.5 4060.5 4062.8 4066.1 4075.3 4079.2 5590.9 5599.6 5607.3 5608.4 5633.7 5202.2 5455.3 5459.9 5482.6 5485.2 5448.6 5463.7 5466.9 5469.9 5503.7 5310.7 5463.8 5473.6 5479.5 5547.7 5474.2 5480.7 5482.5 5485.8 5494.9 5344.1 5347.8 5352.8 5421.8 5451.1 17:02:00 INFO - PROCESS | 16046 | 17:02:00 INFO - PROCESS | 16046 | [#5] yui.html Cycles:180 Average:20851.07 Median:4423.99 stddev:30144.74 (681.4%) stddev-sans-first:30191.37 17:02:00 INFO - PROCESS | 16046 | Values: 708.6 713.9 723.6 735.4 774.3 15538.7 16375.0 16735.3 17397.4 17467.7 15957.4 15975.2 16087.4 16210.7 16233.4 663.1 783.9 805.6 808.3 809.8 673.5 783.3 798.8 819.2 819.3 855.0 857.1 857.5 857.7 858.9 680.9 852.8 853.9 854.7 855.6 516.2 606.0 624.6 627.4 628.6 15432.3 15473.0 15497.8 15503.0 15520.8 13697.0 14199.8 14477.3 14531.6 14738.1 11936.7 12004.3 12092.5 12161.2 12190.2 4283.9 4288.7 4328.7 4529.9 4537.2 78395.6 78435.2 79001.6 80517.0 83485.6 10795.1 10839.8 10971.2 11198.8 11725.8 21209.9 21471.1 21510.1 21569.0 21592.4 8274.5 8340.7 8699.0 8877.3 8979.0 4519.3 4533.3 4605.4 4617.0 4669.8 3666.4 3831.8 3842.1 3844.8 3847.5 653.2 658.0 667.9 668.2 668.4 673.6 683.1 702.8 716.0 717.2 8131.5 9062.9 9739.7 9927.3 9971.9 578.7 586.4 628.6 642.5 685.8 4522.3 4994.2 5010.4 5087.8 5187.8 113613.0 113872.4 120086.0 121007.0 124254.0 62744.4 78436.0 103220.0 105066.5 105687.0 93291.0 94370.0 97802.5 99876.5 100804.5 9679.6 10168.3 10175.9 10230.6 10438.2 53549.5 54137.2 54236.7 55033.4 56205.7 47424.5 48542.8 60612.4 63151.4 68322.0 12693.2 13027.2 13092.7 13188.3 13795.5 14535.6 14878.6 15032.8 15610.8 15785.3 13622.5 13811.5 14074.7 14128.0 14206.9 12476.7 12935.5 13016.5 13297.8 13429.5 13692.6 13747.0 13998.8 14033.9 14742.4 10559.7 11009.6 11306.2 11404.8 11511.4 11180.0 11358.3 11359.8 11361.9 11606.0 17:02:00 INFO - PROCESS | 16046 | -------- Summary: end -------- 17:02:00 INFO - PROCESS | 16046 | 17:02:01 INFO - TEST-INFO | 16046: exit 0 17:02:01 INFO - TEST-OK | dromaeo_css | took 1120604ms 17:02:01 INFO - TEST-START | kraken 17:02:01 INFO - operating with platform_type : linux_ 17:02:01 INFO - Initialising browser for kraken test... 17:02:01 INFO - TEST-INFO | started process 16353 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFhavSb/profile http://localhost:40487/getInfo.html) 17:02:06 INFO - PROCESS | 16353 | __metrics Screen width/height:1600/1200 17:02:06 INFO - PROCESS | 16353 | colorDepth:24 17:02:06 INFO - PROCESS | 16353 | Browser inner width/height: 1024/697 17:02:06 INFO - PROCESS | 16353 | __metrics 17:02:07 INFO - PROCESS | 16353 | 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" 17:02:07 INFO - PROCESS | 16353 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:02:08 INFO - PROCESS | 16353 | console.error: PushService: 17:02:08 INFO - PROCESS | 16353 | stateChangeProcessEnqueue: Error transitioning state 17:02:08 INFO - PROCESS | 16353 | UnknownError 17:02:08 INFO - TEST-INFO | 16353: exit 0 17:02:08 INFO - Browser initialized. 17:02:08 INFO - Running cycle 1/1 for kraken test... 17:02:08 INFO - TEST-INFO | started process 16435 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFhavSb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:02:21 INFO - PROCESS | 16435 | RSS: Main: 173826048 17:02:21 INFO - PROCESS | 16435 | 17:02:23 INFO - PROCESS | 16435 | Cycle 1(1): loaded http://localhost:40487/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40487/tests/kraken/driver.html?testName=audio-beat-detection) 17:02:24 INFO - PROCESS | 16435 | RSS: Main: 232611840 17:02:24 INFO - PROCESS | 16435 | 17:02:27 INFO - PROCESS | 16435 | Cycle 1(1): loaded http://localhost:40487/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40487/tests/kraken/driver.html?testName=audio-dft) 17:02:27 INFO - PROCESS | 16435 | RSS: Main: 217186304 17:02:27 INFO - PROCESS | 16435 | 17:02:30 INFO - PROCESS | 16435 | Cycle 1(1): loaded http://localhost:40487/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40487/tests/kraken/driver.html?testName=audio-fft) 17:02:31 INFO - PROCESS | 16435 | RSS: Main: 298622976 17:02:31 INFO - PROCESS | 16435 | 17:02:33 INFO - PROCESS | 16435 | Cycle 1(1): loaded http://localhost:40487/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40487/tests/kraken/driver.html?testName=audio-oscillator) 17:02:34 INFO - PROCESS | 16435 | RSS: Main: 208543744 17:02:34 INFO - PROCESS | 16435 | 17:02:36 INFO - PROCESS | 16435 | Cycle 1(1): loaded http://localhost:40487/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40487/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:02:36 INFO - PROCESS | 16435 | RSS: Main: 213393408 17:02:36 INFO - PROCESS | 16435 | 17:02:39 INFO - PROCESS | 16435 | Cycle 1(1): loaded http://localhost:40487/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40487/tests/kraken/driver.html?testName=imaging-darkroom) 17:02:40 INFO - PROCESS | 16435 | RSS: Main: 249196544 17:02:40 INFO - PROCESS | 16435 | 17:02:43 INFO - PROCESS | 16435 | Cycle 1(1): loaded http://localhost:40487/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40487/tests/kraken/driver.html?testName=imaging-desaturate) 17:02:44 INFO - PROCESS | 16435 | RSS: Main: 247955456 17:02:44 INFO - PROCESS | 16435 | 17:02:47 INFO - PROCESS | 16435 | Cycle 1(1): loaded http://localhost:40487/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40487/tests/kraken/driver.html?testName=json-parse-financial) 17:02:47 INFO - PROCESS | 16435 | RSS: Main: 248139776 17:02:47 INFO - PROCESS | 16435 | 17:02:49 INFO - PROCESS | 16435 | Cycle 1(1): loaded http://localhost:40487/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40487/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:02:50 INFO - PROCESS | 16435 | RSS: Main: 210268160 17:02:50 INFO - PROCESS | 16435 | 17:02:51 INFO - PROCESS | 16435 | Cycle 1(1): loaded http://localhost:40487/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40487/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:02:52 INFO - PROCESS | 16435 | RSS: Main: 216932352 17:02:52 INFO - PROCESS | 16435 | 17:02:54 INFO - PROCESS | 16435 | Cycle 1(1): loaded http://localhost:40487/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40487/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:02:54 INFO - PROCESS | 16435 | RSS: Main: 227618816 17:02:54 INFO - PROCESS | 16435 | 17:02:57 INFO - PROCESS | 16435 | Cycle 1(1): loaded http://localhost:40487/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:02:58 INFO - PROCESS | 16435 | RSS: Main: 235974656 17:02:58 INFO - PROCESS | 16435 | 17:03:01 INFO - PROCESS | 16435 | Cycle 1(1): loaded http://localhost:40487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:03:01 INFO - PROCESS | 16435 | RSS: Main: 232337408 17:03:01 INFO - PROCESS | 16435 | 17:03:03 INFO - PROCESS | 16435 | Cycle 1(1): loaded http://localhost:40487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40487/tests/kraken/driver.html?testName=ai-astar) 17:03:03 INFO - PROCESS | 16435 | RSS: Main: 284364800 17:03:03 INFO - PROCESS | 16435 | 17:03:03 INFO - PROCESS | 16435 | __start_tp_report 17:03:03 INFO - PROCESS | 16435 | _x_x_mozilla_page_load 17:03:03 INFO - PROCESS | 16435 | _x_x_mozilla_page_load_details 17:03:03 INFO - PROCESS | 16435 | |i|pagename|runs| 17:03:03 INFO - PROCESS | 16435 | |0;ai-astar;110;112;111;112;112;111;111;112;111;112 17:03:03 INFO - PROCESS | 16435 | |1;audio-beat-detection;146;124;124;162;129;133;139;121;155;127 17:03:03 INFO - PROCESS | 16435 | |2;audio-dft;161;160;161;160;160;160;162;160;160;162 17:03:03 INFO - PROCESS | 16435 | |3;audio-fft;74;75;75;113;78;76;75;76;103;75 17:03:03 INFO - PROCESS | 16435 | |4;audio-oscillator;83;83;120;82;83;83;110;82;81;125 17:03:03 INFO - PROCESS | 16435 | |5;imaging-gaussian-blur;117;117;116;117;116;117;116;116;117;117 17:03:03 INFO - PROCESS | 16435 | |6;imaging-darkroom;146;147;147;147;147;146;147;146;146;145 17:03:03 INFO - PROCESS | 16435 | |7;imaging-desaturate;96;95;95;95;95;95;96;96;96;96 17:03:03 INFO - PROCESS | 16435 | |8;json-parse-financial;54;51;52;51;53;56;53;53;54;53 17:03:03 INFO - PROCESS | 16435 | |9;json-stringify-tinderbox;62;62;61;63;62;62;63;63;63;63 17:03:03 INFO - PROCESS | 16435 | |10;stanford-crypto-aes;83;89;82;81;80;84;79;79;80;80 17:03:03 INFO - PROCESS | 16435 | |11;stanford-crypto-ccm;134;141;129;139;129;130;139;134;173;128 17:03:03 INFO - PROCESS | 16435 | |12;stanford-crypto-pbkdf2;171;168;166;169;168;162;167;163;165;164 17:03:03 INFO - PROCESS | 16435 | |13;stanford-crypto-sha256-iterative;64;66;73;65;65;65;66;65;65;65 17:03:03 INFO - PROCESS | 16435 | __end_tp_report 17:03:03 INFO - PROCESS | 16435 | __start_cc_report 17:03:03 INFO - PROCESS | 16435 | _x_x_mozilla_cycle_collect,1617 17:03:03 INFO - PROCESS | 16435 | __end_cc_report 17:03:03 INFO - PROCESS | 16435 | __startTimestamp1475625783601__endTimestamp 17:03:03 INFO - PROCESS | 16435 | 17:03:03 INFO - PROCESS | 16435 | ------- Summary: start ------- 17:03:03 INFO - PROCESS | 16435 | Number of tests: 14 17:03:03 INFO - PROCESS | 16435 | 17:03:03 INFO - PROCESS | 16435 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 17:03:03 INFO - PROCESS | 16435 | Values: 110.0 112.0 111.0 112.0 112.0 111.0 111.0 112.0 111.0 112.0 17:03:03 INFO - PROCESS | 16435 | 17:03:03 INFO - PROCESS | 16435 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:136.00 stddev:14.13 (10.4%) stddev-sans-first:14.52 17:03:03 INFO - PROCESS | 16435 | Values: 146.0 124.0 124.0 162.0 129.0 133.0 139.0 121.0 155.0 127.0 17:03:03 INFO - PROCESS | 16435 | 17:03:03 INFO - PROCESS | 16435 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 17:03:03 INFO - PROCESS | 16435 | Values: 161.0 160.0 161.0 160.0 160.0 160.0 162.0 160.0 160.0 162.0 17:03:03 INFO - PROCESS | 16435 | 17:03:03 INFO - PROCESS | 16435 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.00 stddev:13.94 (18.6%) stddev-sans-first:14.49 17:03:03 INFO - PROCESS | 16435 | Values: 74.0 75.0 75.0 113.0 78.0 76.0 75.0 76.0 103.0 75.0 17:03:03 INFO - PROCESS | 16435 | 17:03:03 INFO - PROCESS | 16435 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:82.50 stddev:17.73 (21.5%) stddev-sans-first:18.41 17:03:03 INFO - PROCESS | 16435 | Values: 83.0 83.0 120.0 82.0 83.0 83.0 110.0 82.0 81.0 125.0 17:03:03 INFO - PROCESS | 16435 | 17:03:03 INFO - PROCESS | 16435 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:03:03 INFO - PROCESS | 16435 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 17:03:03 INFO - PROCESS | 16435 | 17:03:03 INFO - PROCESS | 16435 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 17:03:03 INFO - PROCESS | 16435 | Values: 146.0 147.0 147.0 147.0 147.0 146.0 147.0 146.0 146.0 145.0 17:03:03 INFO - PROCESS | 16435 | 17:03:03 INFO - PROCESS | 16435 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 17:03:03 INFO - PROCESS | 16435 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 17:03:03 INFO - PROCESS | 16435 | 17:03:03 INFO - PROCESS | 16435 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:1.49 (2.8%) stddev-sans-first:1.54 17:03:03 INFO - PROCESS | 16435 | Values: 54.0 51.0 52.0 51.0 53.0 56.0 53.0 53.0 54.0 53.0 17:03:03 INFO - PROCESS | 16435 | 17:03:03 INFO - PROCESS | 16435 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 17:03:03 INFO - PROCESS | 16435 | Values: 62.0 62.0 61.0 63.0 62.0 62.0 63.0 63.0 63.0 63.0 17:03:03 INFO - PROCESS | 16435 | 17:03:03 INFO - PROCESS | 16435 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:81.50 stddev:3.06 (3.8%) stddev-sans-first:3.21 17:03:03 INFO - PROCESS | 16435 | Values: 83.0 89.0 82.0 81.0 80.0 84.0 79.0 79.0 80.0 80.0 17:03:03 INFO - PROCESS | 16435 | 17:03:03 INFO - PROCESS | 16435 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:136.50 stddev:13.30 (9.7%) stddev-sans-first:14.04 17:03:03 INFO - PROCESS | 16435 | Values: 134.0 141.0 129.0 139.0 129.0 130.0 139.0 134.0 173.0 128.0 17:03:03 INFO - PROCESS | 16435 | 17:03:03 INFO - PROCESS | 16435 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:167.50 stddev:2.83 (1.7%) stddev-sans-first:2.44 17:03:03 INFO - PROCESS | 16435 | Values: 171.0 168.0 166.0 169.0 168.0 162.0 167.0 163.0 165.0 164.0 17:03:03 INFO - PROCESS | 16435 | 17:03:03 INFO - PROCESS | 16435 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:65.00 stddev:2.56 (3.9%) stddev-sans-first:2.62 17:03:03 INFO - PROCESS | 16435 | Values: 64.0 66.0 73.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 17:03:03 INFO - PROCESS | 16435 | -------- Summary: end -------- 17:03:03 INFO - PROCESS | 16435 | 17:03:04 INFO - TEST-INFO | 16435: exit 0 17:03:04 INFO - TEST-OK | kraken | took 63116ms 17:03:04 INFO - SUITE-END | took 1183s 17:03:05 INFO - Completed test suite (00:19:44) 17:03:05 INFO - javascript benchmark 17:03:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2992.2369795702098, 3039.042701549013, 3047.1467988963086, 3071.8771249150036, 3095.566620673106, 5018.824341148061, 5106.234064890268, 5175.896482070361, 5215.374155101384, 5276.208568714695, 5185.896282074356, 5202.3497062867145, 5245.10833158363, 5267.0, 5371.838844834651, 4694.201985662428, 4784.043191361724, 4814.229723244282, 4818.012307476976, 4823.517648235166, 4749.667523273372, 4774.952250477503, 4790.401199850019, 4819.734914579697, 4935.728534930578, 4841.515848415148, 4854.87862803431, 4866.197077482211, 4920.0159968006365, 4942.678725882806, 4636.374089497908, 4678.157931572316, 4703.929441058387, 4824.565789078964, 4833.32333473314, 4651.255799072166, 4653.7440440775745, 4658.301254811805, 4717.1980763269985, 4810.0, 5137.255098010804, 5138.537531622172, 5158.896822063575, 5185.714785686786, 5227.764750586195, 5390.730463476811, 5428.809991650273, 5543.528800052, 5552.666839989613, 5552.666839989613, 5533.529649979716, 5558.888822223533, 5573.386927437979, 5591.217229587861, 5591.692456914868, 5190.662606930538, 5221.269022336875, 5222.582193424517, 5222.869428264248, 5282.418933917266, 5521.779128834802, 5579.163125531121, 5697.0599851024945, 5702.942970570324, 5703.058995265735, 5384.892302154013, 5469.753861076261, 5471.534919531805, 5481.2874326338115, 5543.61194716366, 5552.056150454432, 5559.8888022239325, 5565.916511252334, 5566.944330556724, 5567.47109024642, 5523.171524271311, 5530.087535556588, 5535.723213839292, 5538.44615538451, 5598.384177740445, 5277.63056586043, 5392.460753924576, 5482.780688772485, 5501.202325662756, 5514.724263786795, 4306.375575541529, 4368.497622773421, 4369.737815731066, 4375.16871794358, 4375.693701440869, 3881.107345310594, 3886.455896174538, 3904.2777086239134, 3945.0, 3946.1713040261866, 5159.329287192641, 5264.578833693296, 5270.156774915995, 5275.868103297372, 5276.868078298074, 5482.780688772405, 5525.11598144295, 5584.748686309126, 5588.44115588446, 5591.329040515164, 5248.606354523426, 5259.316288882421, 5261.76322065508, 5262.368515778131, 5263.736813159327, 4812.205986012269, 4813.663043586916, 4826.276058591239, 4829.203181475087, 4829.855104346875, 5632.887342253132, 5633.155026746021, 5667.1782591524, 5754.021816291157, 5756.625819321815, 5527.944720552743, 5530.55755539564, 5530.585206109477, 5533.142362933751, 5590.776368945197, 5701.629394089371, 5705.486506214461, 5712.02895507773, 5713.628614140068, 5715.142728590578, 5302.575793936553, 5331.893362132813, 5333.919991200058, 5390.407055223844, 5431.131019036935, 5481.5340696041285, 5487.396386397413, 5487.780488780404, 5489.807856724996, 5496.725163741877, 5352.759125839424, 5365.812196573102, 5366.275552800322, 5366.382865970308, 5368.785248590013, 5337.119375303031, 5339.626226164131, 5346.465353464778, 5348.973255133699, 5350.866228344167, 5237.0, 5346.304980352529, 5346.866328341823, 5348.5186333230195, 5349.839504814861, 5340.0, 5384.7576859040655, 5393.9730301348245, 5438.15708565173, 5442.891142177214, 5351.063563876384, 5353.116735738559, 5353.598480113929, 5387.245785590099, 5395.541378982673], "value": 5124.194484450638, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.8047044475323, 606.704685496465, 611.2054329371815, 613.7452957022836, 626.9843253918651, 41978.79010604946, 43586.56413435865, 43758.0, 47578.52421475784, 47610.285845712344, 45467.54532454674, 46054.0, 46093.30860037102, 46110.76944615272, 46129.0, 7929.008873890763, 8996.145366190201, 9112.407693499934, 9114.316426268024, 9123.452592844418, 8054.637541310626, 10547.789044219111, 10817.350958942488, 10820.72948176294, 11137.554497820078, 11159.107271418308, 11236.157288203376, 11236.49435775388, 11238.325700457957, 11239.719007024809, 10890.782184356309, 10980.121590272758, 10995.175361847894, 10998.12015038803, 10999.395033273127, 10753.83869241962, 10833.187510936712, 10833.945830270877, 10838.566457341696, 10840.945795271053, 42351.0, 42678.35982460265, 42692.57307426948, 42717.57282427198, 42747.35878961818, 3456.602490713575, 3593.6765691087667, 3685.6682898538993, 3713.442983552489, 3889.533256009269, 31697.52453713196, 31754.206144846332, 32051.0, 32071.679283207337, 32765.6723432765, 4242.0, 4317.201317756194, 4388.078503514266, 4472.172648060086, 4496.617787488068, 330247.0, 330614.0, 333874.0, 334961.0, 336028.0, 59927.0, 60350.69824650937, 60526.394736052076, 60772.69613651992, 60869.69565152146, 36036.0, 36552.97917229102, 64244.67877660675, 64318.35681643217, 64346.35653643497, 16857.83142168587, 17374.65250694979, 17393.0, 17420.128993550272, 17426.21582028812, 12031.518739250332, 12279.324637144864, 12815.231086134861, 13231.470741170246, 13345.199288042748, 18558.401823744687, 19397.321093761933, 19466.610667786565, 19528.414147575313, 19561.90219048924, 6858.862822743517, 6935.791926242221, 7034.753783617549, 7088.149422069385, 7253.637318134072, 883.1786438612024, 962.3549391452035, 1013.6553571785628, 1024.7284469615408, 1085.1644233939821, 31398.0, 31607.683923160475, 31697.366052679277, 31911.20221994422, 32062.83968580142, 1061.3260579531898, 1091.8525998990035, 1094.9288296260877, 1117.782032503654, 1130.2032067392468, 15971.281292341873, 16744.330226790793, 16783.496495105166, 16835.57911052209, 16907.577310567332, 461952.0, 466867.0, 467074.0, 467507.0, 468334.0, 57348.42651573514, 57710.134347984815, 57825.0, 57932.710336448894, 57947.71026144927, 1212.345333519907, 1263.040089531944, 1311.7573248948975, 1324.4635922451423, 1375.5460697969845, 31116.53325200169, 32103.0, 33138.0, 33444.66555334415, 34474.482882756274, 55045.44954550403, 55695.0, 55925.0, 55947.0, 55960.0, 460145.0, 464242.0, 464280.0, 464314.9253582171, 688685.0, 42194.57805421906, 42390.78804605957, 43045.784771075945, 43545.56454435415, 43550.12899741924, 46780.53219467762, 47073.0, 47097.7645111786, 47707.52292477031, 48308.27537586869, 39693.099742583196, 40428.59571404248, 40436.393454097626, 40941.59058409378, 42443.57556424396, 40217.39673904835, 41141.0, 41824.0, 42224.78887605542, 42482.57517424786, 39079.609203907596, 39361.80319098386, 39585.80207098946, 39942.2011559773, 40730.0, 32715.34569308648, 35297.2351382435, 35892.64107358893, 38219.808900955315, 38996.22007559776, 25676.0, 25694.87152564225, 25779.613305800052, 25802.0, 25960.74039259659], "value": 20751.84061230033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.98691045813405, 391.9392494163404, 405.5964315506072, 405.68762053219024, 418.58978201362663, 13289.202647841124, 15048.548543543697, 18824.529386765338, 18989.52526186846, 19216.615667686638, 18125.728114078265, 18461.261549538, 18562.07189640516, 18597.814021859776, 19315.0, 5263.31576895005, 5702.7433765480655, 5958.52331813456, 5965.254343207099, 5966.343702192756, 5382.838514844561, 5922.88154236915, 5931.4068593140555, 5931.495822855062, 5942.108683697436, 5656.632318899258, 5765.596408251424, 5898.823035308927, 5902.0, 5904.3800400957925, 5752.252207213078, 5801.593888427812, 5803.071508558632, 5808.738606762706, 5814.825555233349, 5023.8492845214705, 5176.482351764831, 5207.192885102815, 5226.05930932432, 5239.79040838366, 21996.0, 22600.66099008516, 22682.0, 22745.77254227453, 22933.655995160087, 2314.0281081945623, 2418.2226063843063, 2426.7694569015916, 2946.4254470378287, 3047.481928072233, 13817.309134543233, 14140.787888181685, 14157.646058848508, 14588.635284117981, 15020.849791502054, 1807.8734488585803, 1874.709420039896, 1879.3328368429284, 1951.9316823911095, 1958.921643134273, 78806.6059669698, 80099.0, 80120.59939700323, 81152.18847811564, 81186.0, 9999.950000249952, 10404.531796069195, 10432.5826966922, 10659.94670026645, 10992.120630349553, 14953.626159346104, 14955.850441495664, 14973.70052598942, 14996.325165367585, 15006.849931500763, 7460.253974602496, 7525.0, 7575.24247575238, 7654.961725191339, 7795.064592248967, 7083.15002199729, 7134.536255143399, 7328.78013659591, 7353.742619008309, 7384.298491643285, 6335.936640633627, 6391.840203994844, 6420.293767685551, 6427.967860160669, 6433.871322573522, 1886.0663971334004, 1899.43017094871, 1905.6760350740408, 1925.1817977359567, 1957.1388589020785, 895.9328050396247, 977.4770497783652, 990.7919336939179, 1012.5797793915442, 1014.5789497358513, 18421.631567368844, 19176.0, 19314.0, 19401.708974365396, 19527.0, 959.0744931141481, 962.6005207838808, 1030.860833787444, 1031.8555402243692, 1066.4507778494083, 9997.550110245056, 10879.945600271947, 11058.391788451552, 11112.16658750597, 11138.832917506244, 423039.0, 429790.0, 431190.0, 432476.0, 433359.0, 74624.62687686636, 76437.61781191059, 76440.0, 77011.61494192493, 77559.22440775632, 998.4059484606647, 1003.242551873331, 1036.0623635609786, 1043.4574021508772, 1043.7495001199657, 16372.508824735278, 16992.745108823623, 17207.56981075483, 17239.310427582757, 17301.13494325304, 39040.21919561536, 39057.80471097626, 39438.605613944645, 39441.46423161258, 39802.60197398105, 48707.0, 48789.5121048785, 48823.267650985974, 48862.0, 49348.2597761041, 8106.148854370442, 8266.669333226604, 8299.087100418828, 8582.914170858461, 8915.55422228873, 12358.938205308916, 12567.685807854878, 12629.81055284153, 12680.11239213283, 12937.935310323388, 10653.840192396965, 11287.492062857027, 11299.209055366046, 11560.6531804046, 11561.595344162914, 10814.45927703596, 11102.50116234298, 11203.327800332007, 11393.316401015965, 11534.94232528832, 11477.885221148015, 11546.94226528862, 11563.6530904073, 11599.536018559163, 11832.290062596272, 8336.124706905688, 8436.662533498591, 8463.619137138721, 8472.66109355619, 8540.779397356857, 11059.72350691239, 11378.772424551296, 11474.254173478697, 11486.0, 11751.647450576496], "value": 9112.909953873277, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.4980957045896, 1446.211814561064, 1482.0885155629285, 1650.5956040770013, 1788.2668106076512, 7526.0, 8241.958790206048, 8538.48769073856, 8546.359023073272, 8779.165979231979, 8571.22858942695, 8658.523781192032, 8669.566521673923, 8677.869831952527, 8684.8697269541, 2252.076648574089, 2274.7042884425, 2278.840481166319, 2281.247188427823, 2281.6235321171985, 2207.87856667884, 2229.4314949687887, 2270.6821045053707, 2271.2277825539313, 2271.239134889814, 2232.0298265907377, 2250.9887450562724, 2257.0407576779885, 2257.7290725113007, 2263.6151854184827, 2139.764625891151, 2158.9784102158933, 2160.438286045624, 2166.2526428382184, 2169.7287839020123, 2118.8875840183873, 2122.61792877282, 2125.7555381131215, 2125.787421257877, 2129.169623846701, 8434.915650843473, 8596.183362580545, 8598.398112132154, 8695.0, 8710.956445217796, 4942.604591632661, 5086.79652813887, 5089.0, 5105.0, 5111.948880511221, 3331.267121233325, 3465.376232278189, 3523.541939547868, 3526.2066035142143, 3532.6467353264725, 1068.3216157739814, 1086.1202426034938, 1109.3842917180962, 1138.1861968692424, 1146.2434793036555, 12059.939700301442, 12060.638180854588, 12105.334206618632, 12123.454444550016, 12156.756864862653, 4226.936595951063, 4306.590873866978, 4483.708558943724, 4499.932501012488, 4502.954970450253, 9445.10271524218, 9454.0, 9475.526223688788, 9539.284553658503, 9556.092171243721, 5206.036883176549, 5217.373915130209, 5218.347706536683, 5220.582353411718, 5223.425423203445, 4218.261804184255, 4350.21696094706, 4610.608098311681, 4731.124741922756, 4896.828610998669, 3591.0, 3594.712423006153, 3719.6652301293016, 3736.5516138063062, 3742.9438558421643, 1093.578972095733, 1097.182598963777, 1104.939228342433, 1110.9333439993466, 1131.852859128308, 912.1562554637067, 923.3951761596165, 925.0795458518683, 945.8344789661782, 974.0648976982035, 5675.01286143123, 5793.652380857162, 5924.644521328734, 6096.146539484475, 6214.751409943552, 434.4374035623875, 442.92913133899066, 444.4422250076198, 445.69247219419145, 455.151143118089, 4142.896427589274, 4216.578342165759, 4236.957630423718, 4237.8304867805555, 4272.230998420252, 10494.265401421828, 10626.096781773636, 10771.246012779031, 10775.892241077645, 10776.137908967265, 10651.041406273473, 10668.62659806903, 10677.092447141924, 10708.625198118028, 10721.83917241242, 7667.386609071261, 7964.084130324971, 8021.0, 8107.594620268963, 8128.390370722102, 6023.879522409439, 6064.696765161636, 6081.0, 6096.664683442275, 6123.418275263843, 9946.104850563484, 9976.800463990825, 10007.249456290661, 10069.496525173858, 10120.797584048425, 9504.144626983605, 9866.210703143875, 9943.701688949342, 10130.594776208869, 10213.897861021294, 6899.931000689929, 7126.750563730245, 7334.193238743627, 7794.064712234568, 8002.639881205476, 7892.802679933047, 8368.456050356708, 8380.24577788002, 8381.203785640355, 8381.287590554872, 7250.709971601288, 7316.561006339637, 7341.926580734124, 7566.583837888748, 7700.653470593725, 7128.679209435484, 7549.245075492407, 7571.432142589218, 7703.922960770545, 7718.266764657348, 6700.631465269457, 6857.074294970115, 6918.273581273894, 6922.480813938874, 6923.342282483156, 5143.382794064736, 5178.587458482548, 5230.110881150137, 5237.81667641646, 5314.5216930476445, 5243.449437808975, 5267.894642107213, 5327.840164795062, 5428.945710543002, 5437.918431223614], "value": 4429.019321556131, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.45586048398, 336.4398276869013, 346.57890662844636, 348.2894894415393, 350.7474618274844, 5217.843464696056, 5243.737813109344, 5261.526462618363, 5266.657667251626, 5306.044911915854, 5189.740512974346, 5199.09015922214, 5201.115810312246, 5204.115300398932, 5240.292560504331, 4181.811818468176, 4184.539700632943, 4186.330187170053, 4196.971741923233, 4237.512686041114, 3620.7284453665948, 4005.6394924456795, 4071.5521292657786, 4166.458360413158, 4194.916101677964, 4118.341065429532, 4131.194417088669, 4132.648724858391, 4135.29699951009, 4148.751074935513, 4159.979200103995, 4182.581741825824, 4182.64447521961, 4191.517975432834, 4200.222958752641, 3562.768420052714, 3600.8559657613664, 3643.7813731176216, 3677.7057835373107, 3749.887503374903, 5014.398272207322, 5034.244863270502, 5058.620603454756, 5060.898782024376, 5128.71792051437, 4687.7656117194, 4694.906101877943, 4705.694129881581, 4710.882227944295, 4738.549837765441, 5251.162093267364, 5380.771537077761, 5406.405295417501, 5411.64824286424, 5447.673139611636, 4035.656969157625, 4036.495438070241, 4037.4953130858644, 4046.7571945683353, 4060.898477538085, 5443.700596467233, 5590.496855283044, 5692.8861422771315, 5721.256236689203, 5731.914021289684, 4111.376006477425, 4161.750294982311, 4184.5311266353, 4186.539480657125, 4199.538050814408, 4199.538050814408, 4216.557261487561, 4231.386448964883, 4235.343521754133, 4243.5119961204855, 4569.657275704336, 4733.692309999839, 4756.382829837872, 4762.309465127606, 4764.976175119103, 5438.3473983121485, 5461.863453413696, 5466.0, 5470.206820011076, 5473.124300112043, 1449.398499622666, 1460.0, 1461.7880407340876, 1462.444271176946, 1464.2385959301105, 921.1574328302113, 947.1144479911305, 965.3628605120587, 967.2165545907696, 969.3699095587924, 4646.697964632355, 4679.81280748773, 4696.2955556666775, 4699.718016918996, 4726.8109275628585, 4892.730899800474, 4895.534924182197, 4900.166971614834, 4912.926306105412, 4953.405591328991, 4650.581447669726, 4658.836940707059, 4675.43372970052, 4745.928811067837, 5002.2496625506465, 2932.8240305581735, 2959.6300462442196, 2960.6743258241577, 2960.807547509405, 2962.740835145055, 5732.7706891723865, 5749.712514374264, 5767.0, 5792.899349123653, 5809.535237181015, 5588.944110558842, 5668.404817494104, 5698.943010569924, 5728.226689396878, 5731.423858438962, 5699.458551437607, 5739.85650358736, 5742.54059675225, 5743.368229494752, 5750.654960702372, 5377.300950876361, 5578.916316255179, 5600.187972744011, 5611.971940140274, 5646.153077038477, 5464.316960379952, 5514.91727624078, 5518.724063796713, 5529.751161197836, 5530.5022547970875, 5504.889902202013, 5554.2779438672715, 5629.577781666473, 5706.629069110494, 5785.508231800176, 4060.451839001697, 4062.817173227271, 4066.12578295656, 4075.2868248057066, 4079.163771426791, 5590.944090559043, 5599.552035837041, 5607.299087614048, 5608.439156084359, 5633.6619802811965, 5202.24567437727, 5455.345358556999, 5459.945400546103, 5482.5888058394985, 5485.204645326485, 5448.564114870722, 5463.72681365938, 5466.91799622998, 5469.906018796177, 5503.697296648723, 5310.6813591184655, 5463.7814487420055, 5473.589480788877, 5479.4520547944885, 5547.694876781816, 5474.220878214516, 5480.698106795236, 5482.479164479368, 5485.803360429195, 5494.890102197854, 5344.064788661891, 5347.839564813062, 5352.759125839424, 5421.83734487966, 5451.127819549012], "value": 4169.300169968761, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.564232996707, 713.9326706573673, 723.6490302203433, 735.4153448008834, 774.2528460036064, 15538.689226215469, 16375.0, 16735.33058677653, 17397.391091311805, 17467.737983930252, 15957.361705531794, 15975.201239938015, 16087.356505739786, 16210.675786484264, 16233.431829885956, 663.0783211336246, 783.8510682970217, 805.5851236613149, 808.308895894011, 809.8461292354434, 673.515069150211, 783.3263393481601, 798.7803354077618, 819.2258315891485, 819.2790344496834, 855.0423525651248, 857.0700789643245, 857.4512312120248, 857.7341024282492, 858.8668756342777, 680.880845851974, 852.8038551133212, 853.9316854651613, 854.7093988044095, 855.550835811201, 516.2153526639524, 606.0364021206259, 624.6002558362652, 627.3851625407127, 628.6291088257904, 15432.305546250445, 15473.0, 15497.845021549752, 15503.0, 15520.767188492182, 13697.0, 14199.78700319496, 14477.276136193148, 14531.564053078318, 14738.115713057143, 11936.701582460508, 12004.279743215347, 12092.455839487156, 12161.209521381083, 12190.2076365036, 4283.914321713548, 4288.69979101463, 4328.675349348811, 4529.932051019237, 4537.228671125917, 78395.6080219601, 78435.21564784336, 79001.60499197467, 80517.0, 83485.58257208735, 10795.082417994558, 10839.83740243897, 10971.177161712903, 11198.776024479464, 11725.824112638316, 21209.89395053015, 21471.14115435396, 21510.13959441636, 21569.0, 21592.35222943314, 8274.544900030436, 8340.708075217339, 8698.956505217433, 8877.289816814638, 8978.955105224431, 4519.29950857611, 4533.297338912474, 4605.447346318396, 4616.976915115471, 4669.836555720533, 3666.431703086026, 3831.8084095795098, 3842.0779013037227, 3844.8077596120083, 3847.480590120354, 653.1672118049524, 657.9768460044677, 667.9165104361955, 668.204836244867, 668.391763495217, 673.5857447669746, 683.1370920702649, 702.7786247332074, 716.0, 717.1752484642599, 8131.5267713114745, 9062.888714600396, 9739.69868210661, 9927.255455840841, 9971.850422243671, 578.6556998585835, 586.4340911020801, 628.5505863307666, 642.5181114164377, 685.7917505631857, 4522.29904364824, 4994.225894986283, 5010.423801262901, 5087.798512461475, 5187.844364669066, 113613.0, 113872.43063784628, 120086.0, 121007.0, 124254.0, 62744.372556274764, 78436.0, 103219.96780032254, 105066.51203015492, 105687.0, 93291.0, 94370.0, 97802.5109874446, 99876.5006174979, 100804.49597751965, 9679.612815487302, 10168.33905796121, 10175.949120254352, 10230.6419275325, 10438.217133715154, 53549.464505354445, 54137.18794218011, 54236.728816355666, 55033.449665502834, 56205.71897140488, 47424.52575474201, 48542.757286213346, 60612.393876060676, 63151.36848631639, 68322.0, 12693.174943628635, 13027.153235039692, 13092.672683182996, 13188.274644894624, 13795.517156899461, 14535.636609084857, 14878.628034298796, 15032.774508382165, 15610.765838512658, 15785.28966196547, 13622.523211687543, 13811.51659691906, 14074.718505629626, 14128.0, 14206.857931420553, 12476.688082798002, 12935.547255846, 13016.544420945222, 13297.80053299182, 13429.462821487032, 13692.589222323346, 13747.0, 13998.790018149939, 14033.929830350782, 14742.410303587736, 10559.736006599896, 11009.61466348674, 11306.152038597302, 11404.771904561696, 11511.424428778695, 11180.0, 11358.318500889973, 11359.772804544029, 11361.886381136082, 11606.0], "value": 7594.282803843148, "unit": "score"}], "name": "dromaeo_css", "value": 7170.361024799004, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 111.0, 112.0, 112.0, 111.0, 111.0, 112.0, 111.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 124.0, 124.0, 162.0, 129.0, 133.0, 139.0, 121.0, 155.0, 127.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 160.0, 160.0, 162.0, 160.0, 160.0, 162.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 113.0, 78.0, 76.0, 75.0, 76.0, 103.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 120.0, 82.0, 83.0, 83.0, 110.0, 82.0, 81.0, 125.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 52.0, 51.0, 53.0, 56.0, 53.0, 53.0, 54.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 63.0, 62.0, 62.0, 63.0, 63.0, 63.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 89.0, 82.0, 81.0, 80.0, 84.0, 79.0, 79.0, 80.0, 80.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 141.0, 129.0, 139.0, 129.0, 130.0, 139.0, 134.0, 173.0, 128.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 166.0, 169.0, 168.0, 162.0, 167.0, 163.0, 165.0, 164.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 73.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1508.6000000000001, "alertThreshold": 2.0}]} 17:03:05 INFO - Return code: 0 17:03:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:03:05 INFO - # TBPL SUCCESS # 17:03:05 INFO - Running post-action listener: _resource_record_post_action 17:03:05 INFO - [mozharness: 2016-10-05 00:03:05.392987Z] Finished run-tests step (success) 17:03:05 INFO - Running post-run listener: _resource_record_post_run 17:03:05 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392523776; Read time: 16; Write time: 658072 17:03:05 INFO - TinderboxPrint: CPU usage
13.1% 17:03:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 17:03:05 INFO - TinderboxPrint: I/O write bytes / time
392,523,776 / 658,072 17:03:05 INFO - TinderboxPrint: CPU idle
8,325.7 (86.9%) 17:03:05 INFO - TinderboxPrint: CPU user
1,200.8 (12.5%) 17:03:05 INFO - TinderboxPrint: Swap in / out
0 / 0 17:03:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103026688; Read time: 0; Write time: 147800 17:03:05 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 288600064; Read time: 0; Write time: 510248 17:03:06 INFO - Running post-run listener: _upload_blobber_files 17:03:06 INFO - Blob upload gear active. 17:03:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:03:06 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 17:03:06 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:03:06 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:03:06 INFO - (blobuploader) - INFO - Open directory for files ... 17:03:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:03:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:03:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:03:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:03:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:03:07 INFO - (blobuploader) - INFO - Done attempting. 17:03:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:03:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:03:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:03:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:03:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:03:08 INFO - (blobuploader) - INFO - Done attempting. 17:03:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:03:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:03:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:03:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:03:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:03:11 INFO - (blobuploader) - INFO - Done attempting. 17:03:11 INFO - (blobuploader) - INFO - Iteration through files over. 17:03:11 INFO - Return code: 0 17:03:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:03:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:03:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d9fbdf6432329d7b3911458e9d5c253d8ea90f22524818f44d053aee6bb0465f64e4c45a1e4b1f7d25f3181f0c50eb746f3dd36c16b514f43f2d9888af7b5365", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d42d189207205f34ff3adfc8a2f27d4a368dc60a31c1fbb9f96f0729c30b34bc1f3c729d1d25cdeb05403aa1672cd2115672ec89c5367a58c1a5ed70d2b1a9a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/49a9740d377a7c3d0ae7d7650069a8884533722f547380bbfa9e4a2ae1a40f5efb82f047e24d50394460c6ce66eb5e9c8950aa06e94ac19068983dfdb0ffb2b1"} 17:03:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:03:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:03:11 INFO - Contents: 17:03:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d9fbdf6432329d7b3911458e9d5c253d8ea90f22524818f44d053aee6bb0465f64e4c45a1e4b1f7d25f3181f0c50eb746f3dd36c16b514f43f2d9888af7b5365", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d42d189207205f34ff3adfc8a2f27d4a368dc60a31c1fbb9f96f0729c30b34bc1f3c729d1d25cdeb05403aa1672cd2115672ec89c5367a58c1a5ed70d2b1a9a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/49a9740d377a7c3d0ae7d7650069a8884533722f547380bbfa9e4a2ae1a40f5efb82f047e24d50394460c6ce66eb5e9c8950aa06e94ac19068983dfdb0ffb2b1"} 17:03:11 INFO - Running post-run listener: copy_logs_to_upload_dir 17:03:11 INFO - Copying logs to upload dir... 17:03:11 INFO - mkdir: /builds/slave/test/build/upload/logs 17:03:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.660015 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-04 17:03:11.613352) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 17:03:11.621233) ========= 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=5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825 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/sha512/d9fbdf6432329d7b3911458e9d5c253d8ea90f22524818f44d053aee6bb0465f64e4c45a1e4b1f7d25f3181f0c50eb746f3dd36c16b514f43f2d9888af7b5365", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d42d189207205f34ff3adfc8a2f27d4a368dc60a31c1fbb9f96f0729c30b34bc1f3c729d1d25cdeb05403aa1672cd2115672ec89c5367a58c1a5ed70d2b1a9a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/49a9740d377a7c3d0ae7d7650069a8884533722f547380bbfa9e4a2ae1a40f5efb82f047e24d50394460c6ce66eb5e9c8950aa06e94ac19068983dfdb0ffb2b1"} build_url:https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/IRg7IPPpT12DJlsQJF4FFQ/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/sha512/d9fbdf6432329d7b3911458e9d5c253d8ea90f22524818f44d053aee6bb0465f64e4c45a1e4b1f7d25f3181f0c50eb746f3dd36c16b514f43f2d9888af7b5365", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d42d189207205f34ff3adfc8a2f27d4a368dc60a31c1fbb9f96f0729c30b34bc1f3c729d1d25cdeb05403aa1672cd2115672ec89c5367a58c1a5ed70d2b1a9a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/49a9740d377a7c3d0ae7d7650069a8884533722f547380bbfa9e4a2ae1a40f5efb82f047e24d50394460c6ce66eb5e9c8950aa06e94ac19068983dfdb0ffb2b1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 17:03:11.646729) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 17:03:11.647062) ========= 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=5cf47e208febbcd81da23b2e0000026f-1475624544.342566-843623825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 17:03:11.729585) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 17:03:11.729917) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 17:03:11.730204) ========= ========= Total master_lag: 0.17 =========