builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1475524208.47 results: success (0) buildid: 20161003114457 builduid: f11930f6402a49dca0c7c4e041c68c18 revision: 7735d1c35d290bff03210283511daeb288a4f830 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 12:50:08.473357) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 12:50:08.473809) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 12:50:08.474081) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 12:50:08.561885) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:50:08.562166) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 12:50:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-10-03 12:50:09 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084403 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:50:08.663854) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:50:08.664143) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020393 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:50:08.713330) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:50:08.713684) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 7735d1c35d290bff03210283511daeb288a4f830 --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 7735d1c35d290bff03210283511daeb288a4f830 --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=56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 12:50:09,415 truncating revision to first 12 chars 2016-10-03 12:50:09,415 Setting DEBUG logging. 2016-10-03 12:50:09,415 attempt 1/10 2016-10-03 12:50:09,415 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/7735d1c35d29?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 12:50:09,982 unpacking tar archive at: autoland-7735d1c35d29/testing/mozharness/ program finished with exit code 0 elapsedTime=0.890293 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:50:09.618041) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 12:50:09.618415) ========= script_repo_revision: 7735d1c35d290bff03210283511daeb288a4f830 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 12:50:09.618898) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 12:50:09.619218) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 12:50:09.630240) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-03 12:50:09.630620) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:50:10 INFO - MultiFileLogger online at 20161003 12:50:10 in /builds/slave/test 12:50:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 12:50:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:50:10 INFO - {'append_to_log': False, 12:50:10 INFO - 'base_work_dir': '/builds/slave/test', 12:50:10 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 12:50:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:50:10 INFO - 'branch': 'Autoland-Non-PGO', 12:50:10 INFO - 'buildbot_json_path': 'buildprops.json', 12:50:10 INFO - 'config_files': ('talos/linux_config.py',), 12:50:10 INFO - 'default_actions': ('clobber', 12:50:10 INFO - 'read-buildbot-config', 12:50:10 INFO - 'download-and-extract', 12:50:10 INFO - 'populate-webroot', 12:50:10 INFO - 'create-virtualenv', 12:50:10 INFO - 'install', 12:50:10 INFO - 'run-tests'), 12:50:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:50:10 INFO - 'download_minidump_stackwalk': True, 12:50:10 INFO - 'download_symbols': 'ondemand', 12:50:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:50:10 INFO - 'tooltool.py': '/tools/tooltool.py', 12:50:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:50:10 INFO - '/tools/misc-python/virtualenv.py')}, 12:50:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:50:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:50:10 INFO - 'installer_path': 'installer.exe', 12:50:10 INFO - 'log_level': 'info', 12:50:10 INFO - 'log_name': 'talos', 12:50:10 INFO - 'log_to_console': True, 12:50:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:50:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:50:10 INFO - 'opt_config_files': (), 12:50:10 INFO - 'pip_index': False, 12:50:10 INFO - 'sps_profile': False, 12:50:10 INFO - 'sps_profile_interval': 0, 12:50:10 INFO - 'suite': 'dromaeojs', 12:50:10 INFO - 'system_bits': '32', 12:50:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:50:10 INFO - 'title': 'talos-linux64-ix-037', 12:50:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:50:10 INFO - 'use_talos_json': True, 12:50:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:50:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:50:10 INFO - 'work_dir': 'build'} 12:50:10 INFO - [mozharness: 2016-10-03 19:50:10.430374Z] Running clobber step. 12:50:10 INFO - Running pre-action listener: _resource_record_pre_action 12:50:10 INFO - Running main action method: clobber 12:50:10 INFO - rmtree: /builds/slave/test/build 12:50:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:50:11 INFO - Running post-action listener: _resource_record_post_action 12:50:11 INFO - [mozharness: 2016-10-03 19:50:11.415030Z] Finished clobber step (success) 12:50:11 INFO - [mozharness: 2016-10-03 19:50:11.415129Z] Running read-buildbot-config step. 12:50:11 INFO - Running pre-action listener: _resource_record_pre_action 12:50:11 INFO - Running main action method: read_buildbot_config 12:50:11 INFO - Using buildbot properties: 12:50:11 INFO - { 12:50:11 INFO - "project": "", 12:50:11 INFO - "product": "firefox", 12:50:11 INFO - "script_repo_revision": "production", 12:50:11 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 12:50:11 INFO - "repository": "", 12:50:11 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 12:50:11 INFO - "buildid": "20161003114457", 12:50:11 INFO - "pgo_build": "False", 12:50:11 INFO - "basedir": "/builds/slave/test", 12:50:11 INFO - "buildnumber": 753, 12:50:11 INFO - "slavename": "talos-linux64-ix-037", 12:50:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:50:11 INFO - "platform": "ubuntu64_hw", 12:50:11 INFO - "scheduler": "tests-autoland-linux64-talos", 12:50:11 INFO - "branch": "autoland", 12:50:11 INFO - "repo_path": "integration/autoland", 12:50:11 INFO - "revision": "7735d1c35d290bff03210283511daeb288a4f830", 12:50:11 INFO - "stage_platform": "linux64", 12:50:11 INFO - "builduid": "f11930f6402a49dca0c7c4e041c68c18", 12:50:11 INFO - "slavebuilddir": "test" 12:50:11 INFO - } 12:50:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:50:11 INFO - Running post-action listener: _resource_record_post_action 12:50:11 INFO - [mozharness: 2016-10-03 19:50:11.417612Z] Finished read-buildbot-config step (success) 12:50:11 INFO - [mozharness: 2016-10-03 19:50:11.417701Z] Running download-and-extract step. 12:50:11 INFO - Running pre-action listener: _resource_record_pre_action 12:50:11 INFO - Running main action method: download_and_extract 12:50:11 INFO - mkdir: /builds/slave/test/build/tests 12:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:11 INFO - trying https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:50:11 INFO - Downloading https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:50:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:50:11 INFO - Downloaded 1361 bytes. 12:50:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:50:11 INFO - Using the following test package requirements: 12:50:11 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:50:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:50:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:50:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:50:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:50:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:50:11 INFO - u'jsshell-linux-x86_64.zip'], 12:50:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:50:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:50:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:50:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:50:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:50:11 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:50:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:50:11 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:50:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:50:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:50:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:50:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:50:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:50:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:50:11 INFO - Fetch https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:50:12 INFO - Http code: 200 12:50:12 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 12:50:12 INFO - x-amz-cf-id: wxoFgegobWnPbzsJzFUTORN-PYmRC0NZeUsopXv04P-XvEaT0i8u-w== 12:50:12 INFO - x-amz-version-id: _eZSFpMFC4V6hlPLb2l5F1SYYPDx7560 12:50:12 INFO - Expected file size: 20420680 12:50:12 INFO - Obtained file size: 20420680 12:50:16 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:50:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:50:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:50:16 INFO - Fetch https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:50:17 INFO - Http code: 200 12:50:17 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 12:50:17 INFO - x-amz-cf-id: tT91crwFg2lncc01Ss9QxRu1DSucPC2kEYZ9BJEIhmwNfxQ7dnYrzg== 12:50:17 INFO - x-amz-version-id: _eZSFpMFC4V6hlPLb2l5F1SYYPDx7560 12:50:17 INFO - Expected file size: 20420680 12:50:17 INFO - Obtained file size: 20420680 12:50:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:50:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:50:22 INFO - Fetch https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:50:22 INFO - Http code: 200 12:50:22 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 12:50:22 INFO - x-amz-cf-id: SQs8JoNjkUEveaUW1RKV_rG_bHCkcp_3rRqZzKUUlyeluIoQ9tmqYw== 12:50:22 INFO - x-amz-version-id: k8DlhoRNNwFEyA6hY1.MJ4wCs9lRS9iO 12:50:22 INFO - Expected file size: 14408522 12:50:22 INFO - Obtained file size: 14408522 12:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:23 INFO - trying https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:50:23 INFO - Downloading https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:50:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:50:24 INFO - Downloaded 55828716 bytes. 12:50:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:50:24 INFO - mkdir: /builds/slave/test/properties 12:50:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:50:24 INFO - Writing to file /builds/slave/test/properties/build_url 12:50:24 INFO - Contents: 12:50:24 INFO - build_url:https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:50:25 INFO - Running post-action listener: _resource_record_post_action 12:50:25 INFO - Running post-action listener: set_extra_try_arguments 12:50:25 INFO - [mozharness: 2016-10-03 19:50:25.529013Z] Finished download-and-extract step (success) 12:50:25 INFO - [mozharness: 2016-10-03 19:50:25.529238Z] Running populate-webroot step. 12:50:25 INFO - Running pre-action listener: _resource_record_pre_action 12:50:25 INFO - Running main action method: populate_webroot 12:50:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:50:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:50:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:50:25 INFO - '--tppagecycles', 12:50:25 INFO - '7'], 12:50:25 INFO - 'tests': ['tsvgm']}}, 12:50:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:50:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:50:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:50:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:50:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:50:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:50:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:25 INFO - 'talos_options': ['--disable-e10s'], 12:50:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:25 INFO - 'talos_options': ['--disable-e10s'], 12:50:25 INFO - 'tests': ['damp', 'tps']}, 12:50:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:25 INFO - 'tests': ['damp', 'tps']}, 12:50:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:50:25 INFO - 'tests': ['dromaeo_dom']}, 12:50:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:50:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:50:25 INFO - 'tests': ['basic_compositor_video']}, 12:50:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:50:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:50:25 INFO - 'tests': ['a11yr', 12:50:25 INFO - 'ts_paint', 12:50:25 INFO - 'tpaint', 12:50:25 INFO - 'sessionrestore', 12:50:25 INFO - 'sessionrestore_no_auto_restore', 12:50:25 INFO - 'tabpaint']}, 12:50:25 INFO - 'other-e10s': {'tests': ['a11yr', 12:50:25 INFO - 'ts_paint', 12:50:25 INFO - 'tpaint', 12:50:25 INFO - 'sessionrestore', 12:50:25 INFO - 'sessionrestore_no_auto_restore', 12:50:25 INFO - 'tabpaint']}, 12:50:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:50:25 INFO - 'ts_paint', 12:50:25 INFO - 'tpaint', 12:50:25 INFO - 'sessionrestore', 12:50:25 INFO - 'sessionrestore_no_auto_restore', 12:50:25 INFO - 'tabpaint']}, 12:50:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:50:25 INFO - 'ts_paint', 12:50:25 INFO - 'tpaint', 12:50:25 INFO - 'sessionrestore', 12:50:25 INFO - 'sessionrestore_no_auto_restore', 12:50:25 INFO - 'tabpaint']}, 12:50:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:50:25 INFO - 'tests': ['a11yr', 12:50:25 INFO - 'ts_paint', 12:50:25 INFO - 'tpaint', 12:50:25 INFO - 'sessionrestore', 12:50:25 INFO - 'sessionrestore_no_auto_restore', 12:50:25 INFO - 'tabpaint']}, 12:50:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:50:25 INFO - 'tests': ['a11yr', 12:50:25 INFO - 'ts_paint', 12:50:25 INFO - 'tpaint', 12:50:25 INFO - 'sessionrestore', 12:50:25 INFO - 'sessionrestore_no_auto_restore', 12:50:25 INFO - 'tabpaint']}, 12:50:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:50:25 INFO - 'tests': ['tsvgx', 12:50:25 INFO - 'tsvgr_opacity', 12:50:25 INFO - 'tart', 12:50:25 INFO - 'tscrollx', 12:50:25 INFO - 'cart']}, 12:50:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:50:25 INFO - 'tsvgr_opacity', 12:50:25 INFO - 'tart', 12:50:25 INFO - 'tscrollx', 12:50:25 INFO - 'cart']}, 12:50:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:25 INFO - 'talos_options': ['--disable-e10s'], 12:50:25 INFO - 'tests': ['tp5o']}, 12:50:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:25 INFO - 'tests': ['tp5o']}, 12:50:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:25 INFO - 'talos_options': ['--disable-e10s', 12:50:25 INFO - '--xperf_path', 12:50:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:25 INFO - 'tests': ['tp5n']}, 12:50:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:25 INFO - 'talos_options': ['--xperf_path', 12:50:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:25 INFO - 'tests': ['tp5n']}}, 12:50:25 INFO - 'talos.zip': {'path': '', 12:50:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:50:25 INFO - Running post-action listener: _resource_record_post_action 12:50:25 INFO - [mozharness: 2016-10-03 19:50:25.544474Z] Finished populate-webroot step (success) 12:50:25 INFO - [mozharness: 2016-10-03 19:50:25.544562Z] Running create-virtualenv step. 12:50:25 INFO - Running pre-action listener: _resource_record_pre_action 12:50:25 INFO - Running main action method: create_virtualenv 12:50:25 INFO - Creating virtualenv /builds/slave/test/build/venv 12:50:25 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:50:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:50:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:50:25 INFO - Using real prefix '/usr' 12:50:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:50:26 INFO - Installing distribute.............................................................................................................................................................................................done. 12:50:28 INFO - Installing pip.................done. 12:50:28 INFO - Return code: 0 12:50:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:50:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:50:28 INFO - Reading from file tmpfile_stdout 12:50:28 INFO - Output received: 12:50:28 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:50:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f66e0fe5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f60>, '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 0x1098d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10991d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:50:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:50:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:50:28 INFO - Using env: {'DISPLAY': ':0', 12:50:28 INFO - 'HOME': '/home/cltbld', 12:50:28 INFO - 'LANG': 'en_US.UTF-8', 12:50:28 INFO - 'LANGUAGE': 'en_US:en', 12:50:28 INFO - 'LOGNAME': 'cltbld', 12:50:28 INFO - 'MAIL': '/var/mail/cltbld', 12:50:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:28 INFO - 'MOZ_NO_REMOTE': '1', 12:50:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:28 INFO - 'NO_EM_RESTART': '1', 12:50:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:28 INFO - 'PWD': '/builds/slave/test', 12:50:28 INFO - 'SHELL': '/bin/bash', 12:50:28 INFO - 'SHLVL': '1', 12:50:28 INFO - 'TERM': 'linux', 12:50:28 INFO - 'TMOUT': '86400', 12:50:28 INFO - 'USER': 'cltbld', 12:50:28 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 12:50:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:28 INFO - '_': '/tools/buildbot/bin/python'} 12:50:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:28 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:50:28 INFO - Cleaning up... 12:50:28 INFO - Return code: 0 12:50:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f66e0fe5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f60>, '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 0x1098d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10991d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:50:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:50:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:50:28 INFO - Using env: {'DISPLAY': ':0', 12:50:28 INFO - 'HOME': '/home/cltbld', 12:50:28 INFO - 'LANG': 'en_US.UTF-8', 12:50:28 INFO - 'LANGUAGE': 'en_US:en', 12:50:28 INFO - 'LOGNAME': 'cltbld', 12:50:28 INFO - 'MAIL': '/var/mail/cltbld', 12:50:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:28 INFO - 'MOZ_NO_REMOTE': '1', 12:50:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:28 INFO - 'NO_EM_RESTART': '1', 12:50:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:28 INFO - 'PWD': '/builds/slave/test', 12:50:28 INFO - 'SHELL': '/bin/bash', 12:50:28 INFO - 'SHLVL': '1', 12:50:28 INFO - 'TERM': 'linux', 12:50:28 INFO - 'TMOUT': '86400', 12:50:28 INFO - 'USER': 'cltbld', 12:50:28 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 12:50:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:28 INFO - '_': '/tools/buildbot/bin/python'} 12:50:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:28 INFO - Downloading/unpacking psutil>=3.1.1 12:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:50:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:30 INFO - Installing collected packages: psutil 12:50:30 INFO - Running setup.py install for psutil 12:50:30 INFO - building 'psutil._psutil_linux' extension 12:50:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:50:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:50:31 INFO - building 'psutil._psutil_posix' extension 12:50:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:50:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:50:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:31 INFO - Successfully installed psutil 12:50:31 INFO - Cleaning up... 12:50:31 INFO - Return code: 0 12:50:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:31 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 0x7f66e0fe5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f60>, '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 0x1098d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10991d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:50:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:50:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:50:31 INFO - Using env: {'DISPLAY': ':0', 12:50:31 INFO - 'HOME': '/home/cltbld', 12:50:31 INFO - 'LANG': 'en_US.UTF-8', 12:50:31 INFO - 'LANGUAGE': 'en_US:en', 12:50:31 INFO - 'LOGNAME': 'cltbld', 12:50:31 INFO - 'MAIL': '/var/mail/cltbld', 12:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:31 INFO - 'MOZ_NO_REMOTE': '1', 12:50:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:31 INFO - 'NO_EM_RESTART': '1', 12:50:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:31 INFO - 'PWD': '/builds/slave/test', 12:50:31 INFO - 'SHELL': '/bin/bash', 12:50:31 INFO - 'SHLVL': '1', 12:50:31 INFO - 'TERM': 'linux', 12:50:31 INFO - 'TMOUT': '86400', 12:50:31 INFO - 'USER': 'cltbld', 12:50:31 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 12:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:31 INFO - '_': '/tools/buildbot/bin/python'} 12:50:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:50:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:50:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:50:33 INFO - Installing collected packages: mozsystemmonitor 12:50:33 INFO - Running setup.py install for mozsystemmonitor 12:50:33 INFO - Successfully installed mozsystemmonitor 12:50:33 INFO - Cleaning up... 12:50:33 INFO - Return code: 0 12:50:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:33 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 0x7f66e0fe5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f60>, '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 0x1098d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10991d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:50:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:50:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:50:33 INFO - Using env: {'DISPLAY': ':0', 12:50:33 INFO - 'HOME': '/home/cltbld', 12:50:33 INFO - 'LANG': 'en_US.UTF-8', 12:50:33 INFO - 'LANGUAGE': 'en_US:en', 12:50:33 INFO - 'LOGNAME': 'cltbld', 12:50:33 INFO - 'MAIL': '/var/mail/cltbld', 12:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:33 INFO - 'MOZ_NO_REMOTE': '1', 12:50:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:33 INFO - 'NO_EM_RESTART': '1', 12:50:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:33 INFO - 'PWD': '/builds/slave/test', 12:50:33 INFO - 'SHELL': '/bin/bash', 12:50:33 INFO - 'SHLVL': '1', 12:50:33 INFO - 'TERM': 'linux', 12:50:33 INFO - 'TMOUT': '86400', 12:50:33 INFO - 'USER': 'cltbld', 12:50:33 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 12:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:33 INFO - '_': '/tools/buildbot/bin/python'} 12:50:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:33 INFO - Downloading/unpacking jsonschema==2.5.1 12:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:50:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:35 INFO - Downloading functools32-3.2.3-2.tar.gz 12:50:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:50:36 INFO - warning: no files found matching '*.txt' 12:50:36 INFO - no previously-included directories found matching 'build' 12:50:36 INFO - no previously-included directories found matching 'dist' 12:50:36 INFO - no previously-included directories found matching '.git*' 12:50:36 INFO - Installing collected packages: jsonschema, functools32 12:50:36 INFO - Running setup.py install for functools32 12:50:36 INFO - warning: no files found matching '*.txt' 12:50:36 INFO - no previously-included directories found matching 'build' 12:50:36 INFO - no previously-included directories found matching 'dist' 12:50:36 INFO - no previously-included directories found matching '.git*' 12:50:36 INFO - Successfully installed jsonschema functools32 12:50:36 INFO - Cleaning up... 12:50:36 INFO - Return code: 0 12:50:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:36 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 0x7f66e0fe5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f60>, '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 0x1098d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10991d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:50:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:50:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:50:36 INFO - Using env: {'DISPLAY': ':0', 12:50:36 INFO - 'HOME': '/home/cltbld', 12:50:36 INFO - 'LANG': 'en_US.UTF-8', 12:50:36 INFO - 'LANGUAGE': 'en_US:en', 12:50:36 INFO - 'LOGNAME': 'cltbld', 12:50:36 INFO - 'MAIL': '/var/mail/cltbld', 12:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:36 INFO - 'MOZ_NO_REMOTE': '1', 12:50:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:36 INFO - 'NO_EM_RESTART': '1', 12:50:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:36 INFO - 'PWD': '/builds/slave/test', 12:50:36 INFO - 'SHELL': '/bin/bash', 12:50:36 INFO - 'SHLVL': '1', 12:50:36 INFO - 'TERM': 'linux', 12:50:36 INFO - 'TMOUT': '86400', 12:50:36 INFO - 'USER': 'cltbld', 12:50:36 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 12:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:36 INFO - '_': '/tools/buildbot/bin/python'} 12:50:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:50:36 INFO - Cleaning up... 12:50:36 INFO - Return code: 0 12:50:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:36 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 0x7f66e0fe5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f60>, '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 0x1098d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10991d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:50:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:50:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:50:36 INFO - Using env: {'DISPLAY': ':0', 12:50:36 INFO - 'HOME': '/home/cltbld', 12:50:36 INFO - 'LANG': 'en_US.UTF-8', 12:50:36 INFO - 'LANGUAGE': 'en_US:en', 12:50:36 INFO - 'LOGNAME': 'cltbld', 12:50:36 INFO - 'MAIL': '/var/mail/cltbld', 12:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:36 INFO - 'MOZ_NO_REMOTE': '1', 12:50:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:36 INFO - 'NO_EM_RESTART': '1', 12:50:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:36 INFO - 'PWD': '/builds/slave/test', 12:50:36 INFO - 'SHELL': '/bin/bash', 12:50:36 INFO - 'SHLVL': '1', 12:50:36 INFO - 'TERM': 'linux', 12:50:36 INFO - 'TMOUT': '86400', 12:50:36 INFO - 'USER': 'cltbld', 12:50:36 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 12:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:36 INFO - '_': '/tools/buildbot/bin/python'} 12:50:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:36 INFO - Downloading/unpacking blobuploader==1.2.4 12:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:38 INFO - Downloading blobuploader-1.2.4.tar.gz 12:50:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:50:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:50:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:39 INFO - Downloading docopt-0.6.1.tar.gz 12:50:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:50:39 INFO - Installing collected packages: blobuploader, requests, docopt 12:50:39 INFO - Running setup.py install for blobuploader 12:50:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:50:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:50:39 INFO - Running setup.py install for requests 12:50:39 INFO - Running setup.py install for docopt 12:50:39 INFO - Successfully installed blobuploader requests docopt 12:50:39 INFO - Cleaning up... 12:50:39 INFO - Return code: 0 12:50:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:39 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 0x7f66e0fe5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f60>, '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 0x1098d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10991d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:50:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:50:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:50:39 INFO - Using env: {'DISPLAY': ':0', 12:50:39 INFO - 'HOME': '/home/cltbld', 12:50:39 INFO - 'LANG': 'en_US.UTF-8', 12:50:39 INFO - 'LANGUAGE': 'en_US:en', 12:50:39 INFO - 'LOGNAME': 'cltbld', 12:50:39 INFO - 'MAIL': '/var/mail/cltbld', 12:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:39 INFO - 'MOZ_NO_REMOTE': '1', 12:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:39 INFO - 'NO_EM_RESTART': '1', 12:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:39 INFO - 'PWD': '/builds/slave/test', 12:50:39 INFO - 'SHELL': '/bin/bash', 12:50:39 INFO - 'SHLVL': '1', 12:50:39 INFO - 'TERM': 'linux', 12:50:39 INFO - 'TMOUT': '86400', 12:50:39 INFO - 'USER': 'cltbld', 12:50:39 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 12:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:39 INFO - '_': '/tools/buildbot/bin/python'} 12:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:50:40 INFO - Running setup.py (path:/tmp/pip-UAb_gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:50:40 INFO - Running setup.py (path:/tmp/pip-b1xlCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:50:40 INFO - Running setup.py (path:/tmp/pip-SfCLvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:50:40 INFO - Running setup.py (path:/tmp/pip-VVIu3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:50:40 INFO - Running setup.py (path:/tmp/pip-1jsUd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:50:40 INFO - Running setup.py (path:/tmp/pip-YnJS4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:50:40 INFO - Running setup.py (path:/tmp/pip-O0HamG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:50:40 INFO - Running setup.py (path:/tmp/pip-sOD74e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:50:40 INFO - Running setup.py (path:/tmp/pip-ey5qOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:50:40 INFO - Running setup.py (path:/tmp/pip-p17Xwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:50:40 INFO - Running setup.py (path:/tmp/pip-uC6Kzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:50:40 INFO - Running setup.py (path:/tmp/pip-S_ebej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:50:41 INFO - Running setup.py (path:/tmp/pip-L4PokQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:50:41 INFO - Running setup.py (path:/tmp/pip-kSITBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:50:41 INFO - Running setup.py (path:/tmp/pip-A5a_yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:50:41 INFO - Running setup.py (path:/tmp/pip-mI6dQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:50:41 INFO - Running setup.py (path:/tmp/pip-TDWHo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:50:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:50:41 INFO - Running setup.py install for manifestparser 12:50:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:50:41 INFO - Running setup.py install for mozcrash 12:50:41 INFO - Running setup.py install for mozdebug 12:50:41 INFO - Running setup.py install for mozdevice 12:50:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:50:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:50:41 INFO - Running setup.py install for mozfile 12:50:41 INFO - Running setup.py install for mozhttpd 12:50:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Running setup.py install for mozinfo 12:50:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Running setup.py install for mozInstall 12:50:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Running setup.py install for mozleak 12:50:42 INFO - Running setup.py install for mozlog 12:50:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Running setup.py install for moznetwork 12:50:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Running setup.py install for mozprocess 12:50:42 INFO - Running setup.py install for mozprofile 12:50:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Running setup.py install for mozrunner 12:50:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Running setup.py install for mozscreenshot 12:50:42 INFO - Running setup.py install for moztest 12:50:43 INFO - Running setup.py install for mozversion 12:50:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:50:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:50:43 INFO - Cleaning up... 12:50:43 INFO - Return code: 0 12:50:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:43 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 0x7f66e0fe5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f60>, '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 0x1098d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10991d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:50:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:50:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:50:43 INFO - Using env: {'DISPLAY': ':0', 12:50:43 INFO - 'HOME': '/home/cltbld', 12:50:43 INFO - 'LANG': 'en_US.UTF-8', 12:50:43 INFO - 'LANGUAGE': 'en_US:en', 12:50:43 INFO - 'LOGNAME': 'cltbld', 12:50:43 INFO - 'MAIL': '/var/mail/cltbld', 12:50:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:43 INFO - 'MOZ_NO_REMOTE': '1', 12:50:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:43 INFO - 'NO_EM_RESTART': '1', 12:50:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:43 INFO - 'PWD': '/builds/slave/test', 12:50:43 INFO - 'SHELL': '/bin/bash', 12:50:43 INFO - 'SHLVL': '1', 12:50:43 INFO - 'TERM': 'linux', 12:50:43 INFO - 'TMOUT': '86400', 12:50:43 INFO - 'USER': 'cltbld', 12:50:43 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 12:50:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:43 INFO - '_': '/tools/buildbot/bin/python'} 12:50:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:50:43 INFO - Running setup.py (path:/tmp/pip-ARMliD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:50:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:50:43 INFO - Running setup.py (path:/tmp/pip-LtKUGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:50:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:50:43 INFO - Running setup.py (path:/tmp/pip-eKDgGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:50:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:50:43 INFO - Running setup.py (path:/tmp/pip-mgOcB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:50:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:50:43 INFO - Running setup.py (path:/tmp/pip-lbIVtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:50:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:50:43 INFO - Running setup.py (path:/tmp/pip-upqLin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:50:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:50:43 INFO - Running setup.py (path:/tmp/pip-1AeViB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:50:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:50:43 INFO - Running setup.py (path:/tmp/pip-QUNKdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:50:44 INFO - Running setup.py (path:/tmp/pip-TFczeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:50:44 INFO - Running setup.py (path:/tmp/pip-nFWwyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:50:44 INFO - Running setup.py (path:/tmp/pip-CmNxSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:50:44 INFO - Running setup.py (path:/tmp/pip-zwBTBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:50:44 INFO - Running setup.py (path:/tmp/pip-DSZTx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:50:44 INFO - Running setup.py (path:/tmp/pip-qJBohd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:50:44 INFO - Running setup.py (path:/tmp/pip-b7f5xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:50:44 INFO - Running setup.py (path:/tmp/pip-TDXZEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:50:44 INFO - Running setup.py (path:/tmp/pip-1Cf9z3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:50:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:50:46 INFO - Downloading blessings-1.6.tar.gz 12:50:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:50:46 INFO - Installing collected packages: blessings 12:50:46 INFO - Running setup.py install for blessings 12:50:46 INFO - Successfully installed blessings 12:50:46 INFO - Cleaning up... 12:50:46 INFO - Return code: 0 12:50:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:50:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:50:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:50:47 INFO - Reading from file tmpfile_stdout 12:50:47 INFO - Current package versions: 12:50:47 INFO - argparse == 1.2.1 12:50:47 INFO - blessings == 1.6 12:50:47 INFO - blobuploader == 1.2.4 12:50:47 INFO - docopt == 0.6.1 12:50:47 INFO - functools32 == 3.2.3-2 12:50:47 INFO - jsonschema == 2.5.1 12:50:47 INFO - manifestparser == 1.1 12:50:47 INFO - mozInstall == 1.12 12:50:47 INFO - mozcrash == 0.17 12:50:47 INFO - mozdebug == 0.1 12:50:47 INFO - mozdevice == 0.48 12:50:47 INFO - mozfile == 1.2 12:50:47 INFO - mozhttpd == 0.7 12:50:47 INFO - mozinfo == 0.9 12:50:47 INFO - mozleak == 0.1 12:50:47 INFO - mozlog == 3.4 12:50:47 INFO - moznetwork == 0.27 12:50:47 INFO - mozprocess == 0.23 12:50:47 INFO - mozprofile == 0.28 12:50:47 INFO - mozrunner == 6.12 12:50:47 INFO - mozscreenshot == 0.1 12:50:47 INFO - mozsystemmonitor == 0.3 12:50:47 INFO - moztest == 0.7 12:50:47 INFO - mozversion == 1.4 12:50:47 INFO - psutil == 3.1.1 12:50:47 INFO - requests == 1.2.3 12:50:47 INFO - wsgiref == 0.1.2 12:50:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:50: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')]} 12:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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')]} 12:50:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:47 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 0x7f66e0fe5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f60>, '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 0x1098d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10991d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:50:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:50:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:50:47 INFO - Using env: {'DISPLAY': ':0', 12:50:47 INFO - 'HOME': '/home/cltbld', 12:50:47 INFO - 'LANG': 'en_US.UTF-8', 12:50:47 INFO - 'LANGUAGE': 'en_US:en', 12:50:47 INFO - 'LOGNAME': 'cltbld', 12:50:47 INFO - 'MAIL': '/var/mail/cltbld', 12:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:47 INFO - 'MOZ_NO_REMOTE': '1', 12:50:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:47 INFO - 'NO_EM_RESTART': '1', 12:50:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:47 INFO - 'PWD': '/builds/slave/test', 12:50:47 INFO - 'SHELL': '/bin/bash', 12:50:47 INFO - 'SHLVL': '1', 12:50:47 INFO - 'TERM': 'linux', 12:50:47 INFO - 'TMOUT': '86400', 12:50:47 INFO - 'USER': 'cltbld', 12:50:47 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 12:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:47 INFO - '_': '/tools/buildbot/bin/python'} 12:50:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:50:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:50:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:50:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:50:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:50:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:50:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:50:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:50:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:50:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:50:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:50:47 INFO - Cleaning up... 12:50:47 INFO - Return code: 0 12:50:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:50: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')]} 12:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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')]} 12:50:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f66e0fe5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f60>, '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 0x1098d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10991d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:50: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', 'jsonschema'] in /builds/slave/test/build 12:50: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 jsonschema 12:50:47 INFO - Using env: {'DISPLAY': ':0', 12:50:47 INFO - 'HOME': '/home/cltbld', 12:50:47 INFO - 'LANG': 'en_US.UTF-8', 12:50:47 INFO - 'LANGUAGE': 'en_US:en', 12:50:47 INFO - 'LOGNAME': 'cltbld', 12:50:47 INFO - 'MAIL': '/var/mail/cltbld', 12:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:47 INFO - 'MOZ_NO_REMOTE': '1', 12:50:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:47 INFO - 'NO_EM_RESTART': '1', 12:50:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:47 INFO - 'PWD': '/builds/slave/test', 12:50:47 INFO - 'SHELL': '/bin/bash', 12:50:47 INFO - 'SHLVL': '1', 12:50:47 INFO - 'TERM': 'linux', 12:50:47 INFO - 'TMOUT': '86400', 12:50:47 INFO - 'USER': 'cltbld', 12:50:47 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 12:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:47 INFO - '_': '/tools/buildbot/bin/python'} 12:50:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:50:47 INFO - Cleaning up... 12:50:47 INFO - Return code: 0 12:50:47 INFO - Running post-action listener: _resource_record_post_action 12:50:47 INFO - Running post-action listener: _start_resource_monitoring 12:50:47 INFO - Starting resource monitoring. 12:50:47 INFO - [mozharness: 2016-10-03 19:50:47.529952Z] Finished create-virtualenv step (success) 12:50:47 INFO - [mozharness: 2016-10-03 19:50:47.530449Z] Running install step. 12:50:47 INFO - Running pre-action listener: _resource_record_pre_action 12:50:47 INFO - Running main action method: install 12:50:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:50:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:50:47 INFO - Reading from file tmpfile_stdout 12:50:47 INFO - Detecting whether we're running mozinstall >=1.0... 12:50:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:50:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:50:47 INFO - Reading from file tmpfile_stdout 12:50:47 INFO - Output received: 12:50:47 INFO - Usage: mozinstall [options] installer 12:50:47 INFO - Options: 12:50:47 INFO - -h, --help show this help message and exit 12:50:47 INFO - -d DEST, --destination=DEST 12:50:47 INFO - Directory to install application into. [default: 12:50:47 INFO - "/builds/slave/test"] 12:50:47 INFO - --app=APP Application being installed. [default: firefox] 12:50:47 INFO - mkdir: /builds/slave/test/build/application 12:50:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:50:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:51:03 INFO - Reading from file tmpfile_stdout 12:51:03 INFO - Output received: 12:51:03 INFO - /builds/slave/test/build/application/firefox/firefox 12:51:03 INFO - Running post-action listener: _resource_record_post_action 12:51:03 INFO - [mozharness: 2016-10-03 19:51:03.990672Z] Finished install step (success) 12:51:03 INFO - [mozharness: 2016-10-03 19:51:03.990919Z] Running run-tests step. 12:51:03 INFO - Running pre-action listener: _resource_record_pre_action 12:51:03 INFO - Running main action method: run_tests 12:51:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:51:03 INFO - Python 2.7.3 12:51:03 INFO - Return code: 0 12:51:03 INFO - grabbing minidump binary from tooltool 12:51: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')]} 12:51:03 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 0x1097f60>, '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 0x1098d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10991d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:51:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:51:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:51:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:51:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:51:04 INFO - Return code: 0 12:51:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:51:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:51:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:51:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:51:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:51:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:51:04 INFO - Using env: {'DISPLAY': ':0', 12:51:04 INFO - 'HOME': '/home/cltbld', 12:51:04 INFO - 'LANG': 'en_US.UTF-8', 12:51:04 INFO - 'LANGUAGE': 'en_US:en', 12:51:04 INFO - 'LOGNAME': 'cltbld', 12:51:04 INFO - 'MAIL': '/var/mail/cltbld', 12:51:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:51:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:04 INFO - 'MOZ_NO_REMOTE': '1', 12:51:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:04 INFO - 'NO_EM_RESTART': '1', 12:51:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:04 INFO - 'PWD': '/builds/slave/test', 12:51:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:51:04 INFO - 'SHELL': '/bin/bash', 12:51:04 INFO - 'SHLVL': '1', 12:51:04 INFO - 'TERM': 'linux', 12:51:04 INFO - 'TMOUT': '86400', 12:51:04 INFO - 'USER': 'cltbld', 12:51:04 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150', 12:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:04 INFO - '_': '/tools/buildbot/bin/python'} 12:51:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:51:04 INFO - mozversion application_buildid: 20161003114457 12:51:04 INFO - mozversion application_changeset: 7735d1c35d290bff03210283511daeb288a4f830 12:51:04 INFO - mozversion application_display_name: Nightly 12:51:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:51:04 INFO - mozversion application_name: Firefox 12:51:04 INFO - mozversion application_remotingname: firefox 12:51:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:51:04 INFO - mozversion application_vendor: Mozilla 12:51:04 INFO - mozversion application_version: 52.0a1 12:51:04 INFO - mozversion platform_buildid: 20161003114457 12:51:04 INFO - mozversion platform_changeset: 7735d1c35d290bff03210283511daeb288a4f830 12:51:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:51:04 INFO - mozversion platform_version: 52.0a1 12:51:04 INFO - using testdate: 1475524264 12:51:04 INFO - actual date: 1475524264 12:51:04 INFO - starting webserver on 'localhost:53156' 12:51:04 INFO - SUITE-START | Running 2 tests 12:51:04 INFO - TEST-START | dromaeo_css 12:51:04 INFO - operating with platform_type : linux_ 12:51:04 INFO - Initialising browser for dromaeo_css test... 12:51:04 INFO - TEST-INFO | started process 7080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu4uGiJ/profile http://localhost:53156/getInfo.html) 12:51:09 INFO - PROCESS | 7080 | __metrics Screen width/height:1600/1200 12:51:09 INFO - PROCESS | 7080 | colorDepth:24 12:51:09 INFO - PROCESS | 7080 | Browser inner width/height: 1024/697 12:51:09 INFO - PROCESS | 7080 | __metrics 12:51:09 INFO - PROCESS | 7080 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:51:09 INFO - PROCESS | 7080 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:51:10 INFO - PROCESS | 7080 | console.error: PushService: 12:51:10 INFO - PROCESS | 7080 | stateChangeProcessEnqueue: Error transitioning state 12:51:10 INFO - PROCESS | 7080 | UnknownError 12:51:10 INFO - TEST-INFO | 7080: exit 0 12:51:10 INFO - Browser initialized. 12:51:10 INFO - Running cycle 1/1 for dromaeo_css test... 12:51:10 INFO - TEST-INFO | started process 7159 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu4uGiJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:51:23 INFO - PROCESS | 7159 | RSS: Main: 175063040 12:51:23 INFO - PROCESS | 7159 | 12:52:14 INFO - PROCESS | 7159 | 1475524334756 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:54:27 INFO - PROCESS | 7159 | Cycle 1(1): loaded http://localhost:53156/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53156/tests/dromaeo/cssquery-ext.html) 12:54:28 INFO - PROCESS | 7159 | RSS: Main: 290131968 12:54:28 INFO - PROCESS | 7159 | 12:57:31 INFO - PROCESS | 7159 | Cycle 1(1): loaded http://localhost:53156/tests/dromaeo/cssquery-ext.html (next: http://localhost:53156/tests/dromaeo/cssquery-jquery.html) 12:57:32 INFO - PROCESS | 7159 | RSS: Main: 272719872 12:57:32 INFO - PROCESS | 7159 | 13:00:34 INFO - PROCESS | 7159 | Cycle 1(1): loaded http://localhost:53156/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53156/tests/dromaeo/cssquery-mootools.html) 13:00:35 INFO - PROCESS | 7159 | RSS: Main: 219000832 13:00:35 INFO - PROCESS | 7159 | 13:03:37 INFO - PROCESS | 7159 | Cycle 1(1): loaded http://localhost:53156/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53156/tests/dromaeo/cssquery-prototype.html) 13:03:37 INFO - PROCESS | 7159 | RSS: Main: 257986560 13:03:37 INFO - PROCESS | 7159 | 13:06:41 INFO - PROCESS | 7159 | Cycle 1(1): loaded http://localhost:53156/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53156/tests/dromaeo/cssquery-yui.html) 13:06:41 INFO - PROCESS | 7159 | RSS: Main: 221188096 13:06:41 INFO - PROCESS | 7159 | 13:09:45 INFO - PROCESS | 7159 | Cycle 1(1): loaded http://localhost:53156/tests/dromaeo/cssquery-yui.html (next: http://localhost:53156/tests/dromaeo/cssquery-dojo.html) 13:09:45 INFO - PROCESS | 7159 | RSS: Main: 308523008 13:09:45 INFO - PROCESS | 7159 | 13:09:45 INFO - PROCESS | 7159 | __start_tp_report 13:09:45 INFO - PROCESS | 7159 | _x_x_mozilla_page_load 13:09:45 INFO - PROCESS | 7159 | _x_x_mozilla_page_load_details 13:09:45 INFO - PROCESS | 7159 | |i|pagename|runs| 13:09:45 INFO - PROCESS | 7159 | |0;dojo.html;2577.690677118746;2603.466289410671;2632.355073007113;2639.445716399556;2652.7347265273474;4458.643308535317;4556.0660064686745;4626.352310676504;4628.583427491525;4647.883802904929;4541.88645283868;4583.037562111952;4622.029373831491;4634.374359461472;4669.322948172513;4218.810153543082;4259.2546304396765;4302.505211900624;4334.133173365324;4342.956570434302;4061.4923134608175;4317.805698743548;4360.97819510902;4409.735415875058;4455.175792478386;4168.083021735213;4301.010767523487;4342.696011279212;4347.1088426872575;4356.847510337139;4204.915901681979;4247.04441500663;4275.4228179195725;4281.293586558214;4292.356146578007;4242.490901091858;4306.267934451151;4307.030918043447;4316.201502722007;4322.697411181219;4588.609968152711;4605.539446055401;4641.466231383401;4641.651876109271;4678;4788.281757736333;4959.801607935714;4960.826371077031;4963.726995015273;5016.49835016499;4866.221404575251;4870.537298956593;4941.728204948727;4943.382077240345;5021;4611.746353950532;4619.607333376701;4621.838235661803;4625.537446255347;4680.180968330528;5051.949480505222;5057.241413787888;5058.342415485963;5064.721440320818;5124.180131178993;4736.644751643572;4782.3543821584335;4782.832600858953;4838.395200599925;4838.516148385133;4960.70235785854;4996.925046124311;4999.975000124976;5060.2156665716875;5063.746812659352;4905.632077594195;4927.408710954636;4936.037472692862;5001.549860512571;5002.549770520671;4727.621790256771;4773.331733557305;4872.756362181876;4912.533309335608;4920.138975679241;4125.8968525786495;4134.255833949918;4196.9370459443135;4215.030542975132;4263.850765223202;3658.2683463307444;3669.5046168766876;3673.430618254175;3717.219383929351;3720.8325625346924;4399.670024748157;4409.5149533551285;4412.624926881187;4413.249747542925;4465.12929978651;4885.65800393969;4943.233798761198;4956.776945037482;4997.125503036954;5003.524665156804;4361.127774445124;4361.193179261847;4366.737995720267;4384.145091707086;4413.337999300131;4500.324951257272;4506.774661266923;4508.774561271924;4511.390962220124;4565.7717114144825;4659.673822832369;4717.716936983792;4743.928841067318;4780.091782561302;4836.443808962014;5052.570531504716;5053.140966035709;5057.241413787961;5099.923501147411;5101.9489805101475;4810.903781924412;4819.518048195152;4824.589909857701;4825.227963525959;4886.731229782396;4714.952850471589;4754.5245475452175;4906.116898958079;4953.331300274417;5028.899422011613;4993.350864387607;4995.17579599362;5016.398032236009;5049.823256186016;5052.191649336089;4820.68665536739;4839.806407743792;4843.878903027453;4849.80600775965;4912.263160525949;4668.369770080995;4710.152172608963;4764.4282686077895;4820.493848146035;4873.147199240189;4741.122892264942;4779.617630589475;4795.6163506918665;4796.448408433075;4843;4868.780904859361;4894.804207831647;4901.705897646153;4911.238757992517;4960.627952903619;4609.516000819865;4639.744814035261;4642.953570464388;4705.835295764632;4789.976050119727 13:09:45 INFO - PROCESS | 7159 | |1;ext.html;561.4357570641505;569.08945686901;575.562572444942;575.5654480866945;577.4946921443735;27813.165605031856;37776.622233777685;39145.41281880774;39203.01992450187;42588.36117458241;39797.60202397982;39938.40092398616;40041.99790010502;40246;40294.59705402945;7761.3402860756905;7907.802304942365;7924.603769811515;7925.682972681115;7928.524288542677;7664.846703065935;7741.109772376192;7759.650815713307;7761.922380776176;7762.573058481781;7755.534667919915;7786.182450842665;7790.337821285198;7802;7806.804829879242;7754.1470438251745;7756.573388463632;7776.494527855672;7789.532628042336;7796.025496812898;7749.108852481981;7807.6876924922935;7808.960955195244;7811.648475818545;7815.882761758578;37526.81236593799;37927.48290068394;37994.43008354877;38026.61973380286;38063.61936380628;3019.9849000755075;3050.572919791231;3087.548852039538;3093.551435041906;3200.2159470929537;27560.724392756016;27646.308842278904;27712.722872771217;27721.445571088465;27960;3473.2879759649213;3545.85816567337;3574.7140228781636;3605.1167463971233;3621.7826930384263;254143;254148;255572;255597;255690;31288.53067203994;50793.49206507961;51004.48995510072;51101.23348149781;51149;31877.840610797262;34031.149221269174;34044;34061.82969085139;34064.48903266403;11994.940025299818;12071.57749478764;12142.150049496628;12144.635660930186;12154.33151176676;9826.361286516354;9912.107910287965;9923.851142232872;9924.156446701967;9926.354786938826;7513.962430187814;7545.660445279976;7570.205128461543;7591.734289299848;7678.462507624525;3111.2999575095873;3126.624805023366;3151.4642510773224;3181.840907954593;3193.3613277344625;828.2090603473669;829.6764261937849;944.15026476172;950.6672664567346;953.3469573342283;24623.38441538976;25029.749702503104;25103.62344564833;25411.237662870142;25781.3554661135;922.460360688991;940.0740270833223;940.6331530703031;993.0020329568737;1045.1482042135635;13768.303101345193;13793.86206137946;13892.86107138936;14071.648208794657;14124.50564230247;115725.42137289429;117373;117613;117829.4108529469;118506;48436.27345589819;48961.02077958421;48966;49001;49075.509244907094;1043.9217058720626;1085.0776839686202;1121.1143196874377;1157.5774842182711;1202.8195770634475;25215.117470888432;28588.285292867844;28707.85646071756;28734.281642959093;29076.27309317284;40150.39774403328;40493.59506404898;40624.39063413992;40657;40675.389869152576;291313;292574;292875;293236;293678;21895.781042189374;22466.663000054687;24018.639720404557;24667.38331541654;24960.37599060038;40232;40505;40574.79712601418;41619.16761664689;41694.79152604217;34580.135496612784;34840.47739283862;35016.47475287822;35230.295394092485;35241;34465.65534344625;34835.303293934485;34888.47667285043;35210.82394588113;35249;27449.45101098007;27775.722242778123;28026.43947121087;28075.71924280813;28292.15123546297;29329.413411732072;31320.686793131776;31660.366792664478;31973.520397194527;32221.67778322187;24158.75841241565;24225.152119675728;24546.386340341633;24737.752622473545;24946.12688555892 13:09:45 INFO - PROCESS | 7159 | |2;jquery.html;367.419477225983;371.2834229936223;377.68085967357575;387.68791123145854;390.1280637774573;15264.618384540392;16381.262843172057;16871.746923796152;16965.3213871445;16972.15139243039;15915.681686366295;16783.748243776354;17161.91419042903;17298.827011729878;17318.393856215036;4893;5205.713685747282;5206.479352064801;5206.531412172903;5210.322658054448;3681.3557627415094;3905.433712111742;5106;5804.738786754585;6084.1786358841655;6050.96974515129;6051.757929682807;6057.757689692407;6066.393360663942;6067.302260240085;5813.09896965971;6030.577859549811;6052.364501727299;6053.303870054956;6073.089036644495;4729.432468103815;5339.199120131972;5340.893182136336;5345.251664766935;5350.598705097094;17676.381326653507;19054.14256358467;19080;19145.9042704787;19164.137613807274;1743.7471566622896;1796.5149409659318;1828.570285982793;1861.8789778664343;2396.892139853711;8584.785380365478;9177.541122943892;9392.718218453389;11844.526218951232;12610.558630447982;1639.7294446416327;1705.7015022371036;1723.147042214112;1725.9913700431543;1746.7292569651725;59239.70644109828;63305;69279;73281.26718732798;73436.6328168361;9682.806343873082;9743.707688769347;9893.901060989441;9958;10009.158056103031;13148.934255328662;13339.599812005656;13350.064240685046;13360.131591446525;13486.662833429244;5560.833175004756;5692.260006199168;5722.62802917809;5987.730552125077;6857.348551887562;5916.1421593868645;6240.126382306481;6334.904976425358;6395.392437718409;6407.807765767035;4088.8160032798596;4147.6267135957905;4224.471941007374;4265.87202383929;4332.588404101605;1561.5783738390571;1655.5695519165104;1684.1579210394802;1820.2082094289026;2958.349163184096;748.6818102306498;763.2138896936165;782.6399856066159;803.8504937938803;804.0552350987566;15006.875462294362;15378.769318460232;15799.210039497979;16171.514854554382;16652.250648720837;778.0624347661055;801.939854510914;814.1044850664222;820.4216027700576;884.7390019944132;8768.736937891874;9405.90594094064;9481.952590237004;9496.335256532115;9672.854907176397;387882;390118;401404;404887;404945;76295.61852190815;77951.61024194842;79485;79861;79868.6006569975;813.7151996801073;867.1545243387773;909.3543584055262;923.50592433048;931.3527098666498;12065.28045702289;15144.16707081077;15694.372225111325;15865.762013570036;15905;33901.83049084739;34202.82898585491;35474.64525354713;37351.62648373481;39407.80296098501;50035.49964500308;50091;50220.24669630032;50511.24233136432;52363.21455178099;4419.845305414295;4691.202495575692;7445.255474452511;7506.324430801035;7660.004199454035;8049.356051515748;10414.583416663552;10460.895391046297;10910.181736369645;11158.10735141203;9433.905660943303;9435.952820235854;9574.377665451724;9639.9036009639;9716.75708107303;9421.905780942103;9476.715698529055;9520.666776662783;9651.855222171813;10091.646792362526;9371.906280937103;9430.952845236005;9505.904940950502;9592.12953474066;9622.663206787729;7079.646017699198;7106;7276.417886569167;7330.890036649348;7394.225385907451;7228.915662650645;9534.380265282734;9703.5148242589;9771.853422198816;9995.850062248926 13:09:45 INFO - PROCESS | 7159 | |3;mootools.html;1100.7798440311938;1107.961221357252;1271.357964228065;1353.7766268565688;1417.2842714429212;6682.29835867233;6917.1699396072545;7235.457340699449;7829.217078292168;7836.804079897998;7161.212266650664;7444.739434119807;7454.440916931225;7693.0768307803;7697.615119244029;2108.20942146695;2136.2736669532433;2146.023559280524;2154.310620601408;2157.3959291398432;1689.7127488327014;1743.4856717268435;2068.7414073240843;2119.088791819517;2138.6685063815057;2042.295408084216;2103.673930540761;2112.197365001305;2114.7039414481983;2131.11558703138;2055.0444043519833;2062.5771716798095;2069.193014724259;2074.1081335026083;2083.3541602103246;2087.2590230468118;2092.288621868572;2096.968545471819;2098.181709133439;2102.306238941161;7585.582792946386;7641.541507509567;7645.197254288275;7647.847043059163;7650.081990161217;4205.537390887;4287.914241715148;4387.62705170061;4441.244988351956;4458.108378324348;2675.558532842079;2773.1403264987716;2805.228562145406;2818.873150708223;2822.957655635167;857.0786404615002;883.0330787787362;897.304588943574;897.6319708919311;916.2349438219095;9972.202223822149;10043;10053.994600539962;10070.647527336509;10072.093511583993;3737.8131093445218;3860.6718428933295;4061.8578349757618;4076.0421300994244;4097.1191193893455;8740.257078148301;8744.519051452231;8752.47485150893;8756.299496040301;8759.649614015496;4505.977470112694;4507.752073635981;4508.143452743968;4509.932351014738;4511.075229577928;3999.760014399087;4143.274926887842;4146.398772178018;4146.875593732193;4147.357159640261;3511.473279008118;3548.077499850006;3569.464580312974;3605.2248766515327;3620.3121406933124;1045.3048722599538;1091.9071878890225;1126.2341607706837;1137.4597066393396;1168.567629976914;582.6125626458443;681.2574294019543;755.1052003375908;766.2988365645483;782.9491083079696;4741.383620129361;4862.95137048632;4939.777710003059;4942.728149951715;5006.949930500648;813.8535063688593;814.1329484099415;828.2007862412801;847.7499137754377;868.6264906090441;3300.2574420755136;3307.7353811695007;3323.0529299149625;3325.9501107483406;3389.694927456541;8865.468071915706;9350.485723285285;9351.158395744416;9353.801856563701;9360.859587106199;9245.491497967541;9269.629214831331;9274.072592740671;9302.441853488812;9313.627454901864;6992.580445173306;7041.225465198824;7076.32774886385;7145.17830449505;7155.284471552803;4558.635309175324;4614;4725.149473094876;4765;4899.730514821576;8191.971867569934;8313.750587482386;8329.958350208453;8446.577671116296;8592.527410992456;8500.36247281444;8577.185167409087;8615.526146062026;8747.431416957877;8861.582146856472;6633.9668301658185;6646.83382915431;6710.765123220664;6715;6727.596344219362;6795.354441328066;6991.545549539263;7039.296070392919;7041.119860017498;7157.463190260647;5086.923696144487;6386.521010924106;6405.551611387158;6567.573107747981;6597.868042639217;6421.646809425526;6527.706253218522;6531.9020214695865;6538.346165383424;6548.279689234276;5956.255468066492;6095.451409373178;6105.725242364193;6114.633122012693;6119.571629985859;4351.456067991501;4395.868123956287;4399.296112621965;4449.510553839011;4573.885652858705;4207.705460617727;4222.577742225752;4289.506706728766;4333.414988976448;4441.622462090759 13:09:45 INFO - PROCESS | 7159 | |4;prototype.html;289.96810350861404;299.7362321157381;303.89819410497483;304.6100990731864;304.9252933031408;4540.97729511352;4687.742174180418;4692.366530518383;4739.691920025196;4751.144793937095;4437.93343099853;4611.400517932672;4623.398958135438;4642.187617166991;4653.9534604653945;3723.7765734055906;3728.4780130781714;3731.776093434403;3740.9625903740884;3746.7189960752985;3505.8422370993367;3645.9453108203397;3726.4224045273027;3741.5884252732176;3751.9249615007684;3592.2815436912724;3674.1078344652524;3678.613745556718;3696.4085746280603;3704.2961837250837;3671.375866102769;3672.437735396661;3676.5293882446967;3682.963170368289;3694.4458331250257;3268.8365581721055;3280.3767284215924;3284;3285.950710739341;3286.753493487998;4467.508574056851;4522.2086134926585;4538.2738761797955;4557.9061025354;4561.224591819366;4213.389058586518;4217.91564168718;4218.873433796991;4222.1555688862045;4230.323148296288;4880.560749532524;4884.780184891689;4891.192953162724;4894.804207831682;4898.21628539432;3483.1017095682914;3561.5931706975857;3591.9102022449647;3594.6944509716445;3595.964040359589;5055.595552355802;5061.670991385548;5064.151584671568;5087.109755792721;5091.949080509185;3641.5630124385243;3642.617525159873;3649.8138105115413;3656.305301992613;3659.6706296432917;3695.316366472211;3710.293265098031;3715.461258117558;3748.3253014457114;3755.9248815023548;4111.013356794348;4136.751794892316;4149.460570125864;4169.10364271683;4254.404383386328;4830.275458681155;4841.515848415131;4852.95147048525;4864.586510146677;4865.513448655106;1203.3802591665299;1234.2532767675427;1262.7372627372627;1270.3838638260436;1283.2300619628336;888.813349196663;891.8094344050635;904.4799240436644;908.731924082384;914.2685851318919;4362.454693163355;4375.27807911691;4406.1187762447635;4417.4036505072045;4418.33724941255;5019.874503137451;5020.623453241022;5033.313839863687;5040.344755181803;5041.319421878;4416.939934415717;4417.845375411845;4423.845165419195;4425.5574442556135;4430.734155950653;2213.8450308478573;2362.4566349739657;2365.3258821235863;2382.9761702383103;2384.475415408607;4275.315949448135;4286.335617979218;4294.1411717655965;4294.613484786384;4305.634021108241;4545.38637283969;4546;4546.771792027697;4555.567221113989;4566;4117.91764164715;4212.85255016073;4221.219074471172;4236.406903033516;4291.249031419489;4379.795556222064;4432.977835110803;4490.416245888014;4501.864944051684;4512.954870451254;4385.886020925179;4406.317020861771;4418.381426600215;4420.7126536775;4445.510993790615;4325.805338759827;4339.392485052158;4345.34819777036;4538.478075021415;4917.729524876167;3629.455581662666;3630.219502806909;3631.2011357501306;3633.945490817587;3647.398179300386;4868.442098528437;5093.83512007388;5118.948810511847;5135.278302499682;5138.948610513997;4834.501304595587;4875.902481950412;4970.285251588196;4980.900381992267;4983.327250821093;4976.800927962841;4984.32711583946;4984.853483698842;4988.254111061099;5001.199808030698;4789.377380940595;4822.276658501253;4927.482614325444;4932.161532539405;4951.455339912534;4955.281484184845;4991.450940396626;4996.60027197816;5008.649394542347;5013.473585273494;4899.951000489949;4902.975485122552;4907.68100073494;4908.509149085063;4920.901581968269 13:09:45 INFO - PROCESS | 7159 | |5;yui.html;553.3746866041375;585.8213244960291;631.7220423013874;671.0571646836194;676.566997121842;11947.820782688255;12831.550895718652;13348.532801351954;13925.930370348135;14155.858441415583;13894.305284735749;14027.36876840542;14055.578332650037;14058.507952221675;14069.085509441878;744.2594618354744;766.1380946435261;769.0809482668213;770.5838847022601;771.7916162636085;608.1151923950641;626.0015275635377;749.9025126733517;773.9690412383526;779.5439667794319;816.677412422093;816.7549735079482;818.5457071325412;818.7420962396826;819.7991492084448;811.2576992052324;812.4312980913326;812.5774597209477;813.1989989859953;813.3899575318511;470.68934503227706;479.5228747396328;573.3750212268606;585.844751140948;592.3987153039668;12457.813132803016;12468.875311246953;12471.688207794787;12492.125551211418;12504.37478126099;10695.732606684818;11592;11682.941585292105;11683.41582920859;11744.823827642593;11191;11322.886771132265;11636.883631163664;11637.301761894314;11686.12354073448;3942.3889297158985;3971.0866500705;3972.483577134983;3973.245083434167;4037.071473561068;61955;62058.68970655118;62090.99999999955;62553.68723156401;63025.36974630241;9683.951580242054;9801.460919649488;9928.553215105338;10176.084152426318;10308.32995855267;17121.486355409357;17198.484045478657;17295.827041729422;17348.566285842953;17458.214380352914;6232.626042437469;6350.745970161234;6432.807015789534;6493.090967264587;6521.380468855451;3491.825408729553;3539.50446937429;3571.982140089283;3619.5113659656135;3784.6215378462484;2685.3823620567377;2774.987129697686;2794.385235248242;2807.6350074490188;2818.577213417963;483.45369732202386;483.97338146402285;491.027765025252;493.21578689883256;500.2321436594809;523.7224271136304;541.442314416152;550.6998685716214;557.565099222607;559.454531831461;7877.172896845748;7928.3260922821055;8148.714794982147;8189.918100819034;8249.917500825035;546.8769526856505;559.4098226371136;562.4263251483465;565.6803905793296;570.1077813222294;3631.7276204284785;3826.8851934441454;3972;3997.400389941474;4061.6953728470485;80219.59890200512;95304;96633.5168324154;99200.50399747955;101946;82439.17560824315;83658.58170709107;86656;87790;88027;71713.64143179251;76482;76606;77570.61214694004;82429.58785206036;7595.961210837287;7955.204479551999;8132.227438393344;8251.174882511701;8271.710490132817;30397.392052159274;30732.692673073878;36791;39957.60042399655;42604.36093458663;62711.372886270554;62818.37181628125;64041.3595864054;64529;66248;10004.399736015863;10387;10509.632162874263;10533.104686101768;10725.517351719347;11722;11949.76100478003;12525.812112818498;12742;12929.935350323189;11104.44477776124;11586.652400428;11593.652190433962;11677.357745323749;11882.821757673815;10606.522706478381;11550;12091.274523528617;12092.455839487067;12112.939435302767;10869.78260434771;11565.768684626091;11702.648920532398;12066.818997715216;12123;8963.372563920462;9493.193078588121;9909;10171.440570768678;10486.790264194826;8942.37403381783;9391.718248452557;9538.95230523843;9683.951580242054;9832.115109640166 13:09:45 INFO - PROCESS | 7159 | __end_tp_report 13:09:45 INFO - PROCESS | 7159 | __start_cc_report 13:09:45 INFO - PROCESS | 7159 | _x_x_mozilla_cycle_collect,1063 13:09:45 INFO - PROCESS | 7159 | __end_cc_report 13:09:45 INFO - PROCESS | 7159 | __startTimestamp1475525385254__endTimestamp 13:09:45 INFO - PROCESS | 7159 | 13:09:45 INFO - PROCESS | 7159 | ------- Summary: start ------- 13:09:45 INFO - PROCESS | 7159 | Number of tests: 6 13:09:45 INFO - PROCESS | 7159 | 13:09:45 INFO - PROCESS | 7159 | [#0] dojo.html Cycles:165 Average:4599.70 Median:4714.95 stddev:472.44 (10.0%) stddev-sans-first:446.46 13:09:45 INFO - PROCESS | 7159 | Values: 2577.7 2603.5 2632.4 2639.4 2652.7 4458.6 4556.1 4626.4 4628.6 4647.9 4541.9 4583.0 4622.0 4634.4 4669.3 4218.8 4259.3 4302.5 4334.1 4343.0 4061.5 4317.8 4361.0 4409.7 4455.2 4168.1 4301.0 4342.7 4347.1 4356.8 4204.9 4247.0 4275.4 4281.3 4292.4 4242.5 4306.3 4307.0 4316.2 4322.7 4588.6 4605.5 4641.5 4641.7 4678.0 4788.3 4959.8 4960.8 4963.7 5016.5 4866.2 4870.5 4941.7 4943.4 5021.0 4611.7 4619.6 4621.8 4625.5 4680.2 5051.9 5057.2 5058.3 5064.7 5124.2 4736.6 4782.4 4782.8 4838.4 4838.5 4960.7 4996.9 5000.0 5060.2 5063.7 4905.6 4927.4 4936.0 5001.5 5002.5 4727.6 4773.3 4872.8 4912.5 4920.1 4125.9 4134.3 4196.9 4215.0 4263.9 3658.3 3669.5 3673.4 3717.2 3720.8 4399.7 4409.5 4412.6 4413.2 4465.1 4885.7 4943.2 4956.8 4997.1 5003.5 4361.1 4361.2 4366.7 4384.1 4413.3 4500.3 4506.8 4508.8 4511.4 4565.8 4659.7 4717.7 4743.9 4780.1 4836.4 5052.6 5053.1 5057.2 5099.9 5101.9 4810.9 4819.5 4824.6 4825.2 4886.7 4715.0 4754.5 4906.1 4953.3 5028.9 4993.4 4995.2 5016.4 5049.8 5052.2 4820.7 4839.8 4843.9 4849.8 4912.3 4668.4 4710.2 4764.4 4820.5 4873.1 4741.1 4779.6 4795.6 4796.4 4843.0 4868.8 4894.8 4901.7 4911.2 4960.6 4609.5 4639.7 4643.0 4705.8 4790.0 13:09:45 INFO - PROCESS | 7159 | 13:09:45 INFO - PROCESS | 7159 | [#1] ext.html Cycles:180 Average:37377.16 Median:35220.56 stddev:61679.21 (175.1%) stddev-sans-first:61790.29 13:09:45 INFO - PROCESS | 7159 | Values: 561.4 569.1 575.6 575.6 577.5 27813.2 37776.6 39145.4 39203.0 42588.4 39797.6 39938.4 40042.0 40246.0 40294.6 7761.3 7907.8 7924.6 7925.7 7928.5 7664.8 7741.1 7759.7 7761.9 7762.6 7755.5 7786.2 7790.3 7802.0 7806.8 7754.1 7756.6 7776.5 7789.5 7796.0 7749.1 7807.7 7809.0 7811.6 7815.9 37526.8 37927.5 37994.4 38026.6 38063.6 3020.0 3050.6 3087.5 3093.6 3200.2 27560.7 27646.3 27712.7 27721.4 27960.0 3473.3 3545.9 3574.7 3605.1 3621.8 254143.0 254148.0 255572.0 255597.0 255690.0 31288.5 50793.5 51004.5 51101.2 51149.0 31877.8 34031.1 34044.0 34061.8 34064.5 11994.9 12071.6 12142.2 12144.6 12154.3 9826.4 9912.1 9923.9 9924.2 9926.4 7514.0 7545.7 7570.2 7591.7 7678.5 3111.3 3126.6 3151.5 3181.8 3193.4 828.2 829.7 944.2 950.7 953.3 24623.4 25029.7 25103.6 25411.2 25781.4 922.5 940.1 940.6 993.0 1045.1 13768.3 13793.9 13892.9 14071.6 14124.5 115725.4 117373.0 117613.0 117829.4 118506.0 48436.3 48961.0 48966.0 49001.0 49075.5 1043.9 1085.1 1121.1 1157.6 1202.8 25215.1 28588.3 28707.9 28734.3 29076.3 40150.4 40493.6 40624.4 40657.0 40675.4 291313.0 292574.0 292875.0 293236.0 293678.0 21895.8 22466.7 24018.6 24667.4 24960.4 40232.0 40505.0 40574.8 41619.2 41694.8 34580.1 34840.5 35016.5 35230.3 35241.0 34465.7 34835.3 34888.5 35210.8 35249.0 27449.5 27775.7 28026.4 28075.7 28292.2 29329.4 31320.7 31660.4 31973.5 32221.7 24158.8 24225.2 24546.4 24737.8 24946.1 13:09:45 INFO - PROCESS | 7159 | 13:09:45 INFO - PROCESS | 7159 | [#2] jquery.html Cycles:180 Average:24187.00 Median:5343.07 stddev:65722.44 (1230.0%) stddev-sans-first:65882.47 13:09:45 INFO - PROCESS | 7159 | Values: 367.4 371.3 377.7 387.7 390.1 15264.6 16381.3 16871.7 16965.3 16972.2 15915.7 16783.7 17161.9 17298.8 17318.4 4893.0 5205.7 5206.5 5206.5 5210.3 3681.4 3905.4 5106.0 5804.7 6084.2 6051.0 6051.8 6057.8 6066.4 6067.3 5813.1 6030.6 6052.4 6053.3 6073.1 4729.4 5339.2 5340.9 5345.3 5350.6 17676.4 19054.1 19080.0 19145.9 19164.1 1743.7 1796.5 1828.6 1861.9 2396.9 8584.8 9177.5 9392.7 11844.5 12610.6 1639.7 1705.7 1723.1 1726.0 1746.7 59239.7 63305.0 69279.0 73281.3 73436.6 9682.8 9743.7 9893.9 9958.0 10009.2 13148.9 13339.6 13350.1 13360.1 13486.7 5560.8 5692.3 5722.6 5987.7 6857.3 5916.1 6240.1 6334.9 6395.4 6407.8 4088.8 4147.6 4224.5 4265.9 4332.6 1561.6 1655.6 1684.2 1820.2 2958.3 748.7 763.2 782.6 803.9 804.1 15006.9 15378.8 15799.2 16171.5 16652.3 778.1 801.9 814.1 820.4 884.7 8768.7 9405.9 9482.0 9496.3 9672.9 387882.0 390118.0 401404.0 404887.0 404945.0 76295.6 77951.6 79485.0 79861.0 79868.6 813.7 867.2 909.4 923.5 931.4 12065.3 15144.2 15694.4 15865.8 15905.0 33901.8 34202.8 35474.6 37351.6 39407.8 50035.5 50091.0 50220.2 50511.2 52363.2 4419.8 4691.2 7445.3 7506.3 7660.0 8049.4 10414.6 10460.9 10910.2 11158.1 9433.9 9436.0 9574.4 9639.9 9716.8 9421.9 9476.7 9520.7 9651.9 10091.6 9371.9 9431.0 9505.9 9592.1 9622.7 7079.6 7106.0 7276.4 7330.9 7394.2 7228.9 9534.4 9703.5 9771.9 9995.9 13:09:45 INFO - PROCESS | 7159 | 13:09:45 INFO - PROCESS | 7159 | [#3] mootools.html Cycles:180 Average:4902.69 Median:4919.75 stddev:2764.51 (56.2%) stddev-sans-first:2757.50 13:09:45 INFO - PROCESS | 7159 | Values: 1100.8 1108.0 1271.4 1353.8 1417.3 6682.3 6917.2 7235.5 7829.2 7836.8 7161.2 7444.7 7454.4 7693.1 7697.6 2108.2 2136.3 2146.0 2154.3 2157.4 1689.7 1743.5 2068.7 2119.1 2138.7 2042.3 2103.7 2112.2 2114.7 2131.1 2055.0 2062.6 2069.2 2074.1 2083.4 2087.3 2092.3 2097.0 2098.2 2102.3 7585.6 7641.5 7645.2 7647.8 7650.1 4205.5 4287.9 4387.6 4441.2 4458.1 2675.6 2773.1 2805.2 2818.9 2823.0 857.1 883.0 897.3 897.6 916.2 9972.2 10043.0 10054.0 10070.6 10072.1 3737.8 3860.7 4061.9 4076.0 4097.1 8740.3 8744.5 8752.5 8756.3 8759.6 4506.0 4507.8 4508.1 4509.9 4511.1 3999.8 4143.3 4146.4 4146.9 4147.4 3511.5 3548.1 3569.5 3605.2 3620.3 1045.3 1091.9 1126.2 1137.5 1168.6 582.6 681.3 755.1 766.3 782.9 4741.4 4863.0 4939.8 4942.7 5006.9 813.9 814.1 828.2 847.7 868.6 3300.3 3307.7 3323.1 3326.0 3389.7 8865.5 9350.5 9351.2 9353.8 9360.9 9245.5 9269.6 9274.1 9302.4 9313.6 6992.6 7041.2 7076.3 7145.2 7155.3 4558.6 4614.0 4725.1 4765.0 4899.7 8192.0 8313.8 8330.0 8446.6 8592.5 8500.4 8577.2 8615.5 8747.4 8861.6 6634.0 6646.8 6710.8 6715.0 6727.6 6795.4 6991.5 7039.3 7041.1 7157.5 5086.9 6386.5 6405.6 6567.6 6597.9 6421.6 6527.7 6531.9 6538.3 6548.3 5956.3 6095.5 6105.7 6114.6 6119.6 4351.5 4395.9 4399.3 4449.5 4573.9 4207.7 4222.6 4289.5 4333.4 4441.6 13:09:45 INFO - PROCESS | 7159 | 13:09:45 INFO - PROCESS | 7159 | [#4] prototype.html Cycles:180 Average:4012.94 Median:4417.62 stddev:1145.88 (25.9%) stddev-sans-first:1114.50 13:09:45 INFO - PROCESS | 7159 | Values: 290.0 299.7 303.9 304.6 304.9 4541.0 4687.7 4692.4 4739.7 4751.1 4437.9 4611.4 4623.4 4642.2 4654.0 3723.8 3728.5 3731.8 3741.0 3746.7 3505.8 3645.9 3726.4 3741.6 3751.9 3592.3 3674.1 3678.6 3696.4 3704.3 3671.4 3672.4 3676.5 3683.0 3694.4 3268.8 3280.4 3284.0 3286.0 3286.8 4467.5 4522.2 4538.3 4557.9 4561.2 4213.4 4217.9 4218.9 4222.2 4230.3 4880.6 4884.8 4891.2 4894.8 4898.2 3483.1 3561.6 3591.9 3594.7 3596.0 5055.6 5061.7 5064.2 5087.1 5091.9 3641.6 3642.6 3649.8 3656.3 3659.7 3695.3 3710.3 3715.5 3748.3 3755.9 4111.0 4136.8 4149.5 4169.1 4254.4 4830.3 4841.5 4853.0 4864.6 4865.5 1203.4 1234.3 1262.7 1270.4 1283.2 888.8 891.8 904.5 908.7 914.3 4362.5 4375.3 4406.1 4417.4 4418.3 5019.9 5020.6 5033.3 5040.3 5041.3 4416.9 4417.8 4423.8 4425.6 4430.7 2213.8 2362.5 2365.3 2383.0 2384.5 4275.3 4286.3 4294.1 4294.6 4305.6 4545.4 4546.0 4546.8 4555.6 4566.0 4117.9 4212.9 4221.2 4236.4 4291.2 4379.8 4433.0 4490.4 4501.9 4513.0 4385.9 4406.3 4418.4 4420.7 4445.5 4325.8 4339.4 4345.3 4538.5 4917.7 3629.5 3630.2 3631.2 3633.9 3647.4 4868.4 5093.8 5118.9 5135.3 5138.9 4834.5 4875.9 4970.3 4980.9 4983.3 4976.8 4984.3 4984.9 4988.3 5001.2 4789.4 4822.3 4927.5 4932.2 4951.5 4955.3 4991.5 4996.6 5008.6 5013.5 4900.0 4903.0 4907.7 4908.5 4920.9 13:09:45 INFO - PROCESS | 7159 | 13:09:45 INFO - PROCESS | 7159 | [#5] yui.html Cycles:180 Average:17485.50 Median:496.72 stddev:25286.35 (5090.6%) stddev-sans-first:25325.32 13:09:45 INFO - PROCESS | 7159 | Values: 553.4 585.8 631.7 671.1 676.6 11947.8 12831.6 13348.5 13925.9 14155.9 13894.3 14027.4 14055.6 14058.5 14069.1 744.3 766.1 769.1 770.6 771.8 608.1 626.0 749.9 774.0 779.5 816.7 816.8 818.5 818.7 819.8 811.3 812.4 812.6 813.2 813.4 470.7 479.5 573.4 585.8 592.4 12457.8 12468.9 12471.7 12492.1 12504.4 10695.7 11592.0 11682.9 11683.4 11744.8 11191.0 11322.9 11636.9 11637.3 11686.1 3942.4 3971.1 3972.5 3973.2 4037.1 61955.0 62058.7 62091.0 62553.7 63025.4 9684.0 9801.5 9928.6 10176.1 10308.3 17121.5 17198.5 17295.8 17348.6 17458.2 6232.6 6350.7 6432.8 6493.1 6521.4 3491.8 3539.5 3572.0 3619.5 3784.6 2685.4 2775.0 2794.4 2807.6 2818.6 483.5 484.0 491.0 493.2 500.2 523.7 541.4 550.7 557.6 559.5 7877.2 7928.3 8148.7 8189.9 8249.9 546.9 559.4 562.4 565.7 570.1 3631.7 3826.9 3972.0 3997.4 4061.7 80219.6 95304.0 96633.5 99200.5 101946.0 82439.2 83658.6 86656.0 87790.0 88027.0 71713.6 76482.0 76606.0 77570.6 82429.6 7596.0 7955.2 8132.2 8251.2 8271.7 30397.4 30732.7 36791.0 39957.6 42604.4 62711.4 62818.4 64041.4 64529.0 66248.0 10004.4 10387.0 10509.6 10533.1 10725.5 11722.0 11949.8 12525.8 12742.0 12929.9 11104.4 11586.7 11593.7 11677.4 11882.8 10606.5 11550.0 12091.3 12092.5 12112.9 10869.8 11565.8 11702.6 12066.8 12123.0 8963.4 9493.2 9909.0 10171.4 10486.8 8942.4 9391.7 9539.0 9684.0 9832.1 13:09:45 INFO - PROCESS | 7159 | -------- Summary: end -------- 13:09:45 INFO - PROCESS | 7159 | 13:09:46 INFO - TEST-INFO | 7159: exit 0 13:09:46 INFO - TEST-OK | dromaeo_css | took 1122015ms 13:09:46 INFO - TEST-START | kraken 13:09:46 INFO - operating with platform_type : linux_ 13:09:46 INFO - Initialising browser for kraken test... 13:09:46 INFO - TEST-INFO | started process 7467 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaMe1Mz/profile http://localhost:53156/getInfo.html) 13:09:51 INFO - PROCESS | 7467 | __metrics Screen width/height:1600/1200 13:09:51 INFO - PROCESS | 7467 | colorDepth:24 13:09:51 INFO - PROCESS | 7467 | Browser inner width/height: 1024/697 13:09:51 INFO - PROCESS | 7467 | __metrics 13:09:51 INFO - PROCESS | 7467 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:09:51 INFO - PROCESS | 7467 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:09:52 INFO - PROCESS | 7467 | console.error: PushService: 13:09:52 INFO - PROCESS | 7467 | stateChangeProcessEnqueue: Error transitioning state 13:09:52 INFO - PROCESS | 7467 | UnknownError 13:09:52 INFO - TEST-INFO | 7467: exit 0 13:09:52 INFO - Browser initialized. 13:09:52 INFO - Running cycle 1/1 for kraken test... 13:09:52 INFO - TEST-INFO | started process 7551 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaMe1Mz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:10:05 INFO - PROCESS | 7551 | RSS: Main: 175333376 13:10:05 INFO - PROCESS | 7551 | 13:10:07 INFO - PROCESS | 7551 | Cycle 1(1): loaded http://localhost:53156/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53156/tests/kraken/driver.html?testName=audio-beat-detection) 13:10:08 INFO - PROCESS | 7551 | RSS: Main: 242454528 13:10:08 INFO - PROCESS | 7551 | 13:10:11 INFO - PROCESS | 7551 | Cycle 1(1): loaded http://localhost:53156/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53156/tests/kraken/driver.html?testName=audio-dft) 13:10:12 INFO - PROCESS | 7551 | RSS: Main: 218738688 13:10:12 INFO - PROCESS | 7551 | 13:10:15 INFO - PROCESS | 7551 | Cycle 1(1): loaded http://localhost:53156/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53156/tests/kraken/driver.html?testName=audio-fft) 13:10:16 INFO - PROCESS | 7551 | RSS: Main: 301244416 13:10:16 INFO - PROCESS | 7551 | 13:10:18 INFO - PROCESS | 7551 | Cycle 1(1): loaded http://localhost:53156/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53156/tests/kraken/driver.html?testName=audio-oscillator) 13:10:18 INFO - PROCESS | 7551 | RSS: Main: 209190912 13:10:18 INFO - PROCESS | 7551 | 13:10:21 INFO - PROCESS | 7551 | Cycle 1(1): loaded http://localhost:53156/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53156/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:10:21 INFO - PROCESS | 7551 | RSS: Main: 214929408 13:10:21 INFO - PROCESS | 7551 | 13:10:24 INFO - PROCESS | 7551 | Cycle 1(1): loaded http://localhost:53156/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53156/tests/kraken/driver.html?testName=imaging-darkroom) 13:10:25 INFO - PROCESS | 7551 | RSS: Main: 251129856 13:10:25 INFO - PROCESS | 7551 | 13:10:28 INFO - PROCESS | 7551 | Cycle 1(1): loaded http://localhost:53156/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53156/tests/kraken/driver.html?testName=imaging-desaturate) 13:10:29 INFO - PROCESS | 7551 | RSS: Main: 244445184 13:10:29 INFO - PROCESS | 7551 | 13:10:32 INFO - PROCESS | 7551 | Cycle 1(1): loaded http://localhost:53156/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53156/tests/kraken/driver.html?testName=json-parse-financial) 13:10:33 INFO - PROCESS | 7551 | RSS: Main: 248393728 13:10:33 INFO - PROCESS | 7551 | 13:10:34 INFO - PROCESS | 7551 | Cycle 1(1): loaded http://localhost:53156/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53156/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:10:35 INFO - PROCESS | 7551 | RSS: Main: 211333120 13:10:35 INFO - PROCESS | 7551 | 13:10:37 INFO - PROCESS | 7551 | Cycle 1(1): loaded http://localhost:53156/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53156/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:10:37 INFO - PROCESS | 7551 | RSS: Main: 219742208 13:10:37 INFO - PROCESS | 7551 | 13:10:40 INFO - PROCESS | 7551 | Cycle 1(1): loaded http://localhost:53156/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53156/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:10:40 INFO - PROCESS | 7551 | RSS: Main: 228417536 13:10:40 INFO - PROCESS | 7551 | 13:10:43 INFO - PROCESS | 7551 | Cycle 1(1): loaded http://localhost:53156/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53156/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:10:44 INFO - PROCESS | 7551 | RSS: Main: 235937792 13:10:44 INFO - PROCESS | 7551 | 13:10:47 INFO - PROCESS | 7551 | Cycle 1(1): loaded http://localhost:53156/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53156/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:10:47 INFO - PROCESS | 7551 | RSS: Main: 233431040 13:10:47 INFO - PROCESS | 7551 | 13:10:49 INFO - PROCESS | 7551 | Cycle 1(1): loaded http://localhost:53156/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53156/tests/kraken/driver.html?testName=ai-astar) 13:10:50 INFO - PROCESS | 7551 | RSS: Main: 283811840 13:10:50 INFO - PROCESS | 7551 | 13:10:50 INFO - PROCESS | 7551 | __start_tp_report 13:10:50 INFO - PROCESS | 7551 | _x_x_mozilla_page_load 13:10:50 INFO - PROCESS | 7551 | _x_x_mozilla_page_load_details 13:10:50 INFO - PROCESS | 7551 | |i|pagename|runs| 13:10:50 INFO - PROCESS | 7551 | |0;ai-astar;114;115;117;118;117;117;115;117;117;116 13:10:50 INFO - PROCESS | 7551 | |1;audio-beat-detection;151;130;133;171;129;128;135;129;164;130 13:10:50 INFO - PROCESS | 7551 | |2;audio-dft;160;160;161;164;162;160;162;163;163;162 13:10:50 INFO - PROCESS | 7551 | |3;audio-fft;76;76;75;104;76;79;78;75;100;77 13:10:50 INFO - PROCESS | 7551 | |4;audio-oscillator;84;82;113;83;83;82;106;82;83;106 13:10:50 INFO - PROCESS | 7551 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;118;117 13:10:50 INFO - PROCESS | 7551 | |6;imaging-darkroom;148;146;146;146;149;148;146;146;146;147 13:10:50 INFO - PROCESS | 7551 | |7;imaging-desaturate;96;96;97;95;96;95;95;95;95;95 13:10:50 INFO - PROCESS | 7551 | |8;json-parse-financial;64;64;63;63;63;65;64;65;65;64 13:10:50 INFO - PROCESS | 7551 | |9;json-stringify-tinderbox;66;67;67;66;68;67;66;67;70;66 13:10:50 INFO - PROCESS | 7551 | |10;stanford-crypto-aes;89;94;84;83;82;96;83;83;84;83 13:10:50 INFO - PROCESS | 7551 | |11;stanford-crypto-ccm;147;141;138;140;143;159;139;149;177;148 13:10:50 INFO - PROCESS | 7551 | |12;stanford-crypto-pbkdf2;178;175;176;178;175;175;173;173;172;177 13:10:50 INFO - PROCESS | 7551 | |13;stanford-crypto-sha256-iterative;73;74;72;70;71;70;72;70;70;74 13:10:50 INFO - PROCESS | 7551 | __end_tp_report 13:10:50 INFO - PROCESS | 7551 | __start_cc_report 13:10:50 INFO - PROCESS | 7551 | _x_x_mozilla_cycle_collect,1883 13:10:50 INFO - PROCESS | 7551 | __end_cc_report 13:10:50 INFO - PROCESS | 7551 | __startTimestamp1475525450063__endTimestamp 13:10:50 INFO - PROCESS | 7551 | 13:10:50 INFO - PROCESS | 7551 | ------- Summary: start ------- 13:10:50 INFO - PROCESS | 7551 | Number of tests: 14 13:10:50 INFO - PROCESS | 7551 | 13:10:50 INFO - PROCESS | 7551 | [#0] ai-astar Cycles:10 Average:116.30 Median:117.00 stddev:1.25 (1.1%) stddev-sans-first:1.01 13:10:50 INFO - PROCESS | 7551 | Values: 114.0 115.0 117.0 118.0 117.0 117.0 115.0 117.0 117.0 116.0 13:10:50 INFO - PROCESS | 7551 | 13:10:50 INFO - PROCESS | 7551 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:134.00 stddev:16.05 (12.0%) stddev-sans-first:16.52 13:10:50 INFO - PROCESS | 7551 | Values: 151.0 130.0 133.0 171.0 129.0 128.0 135.0 129.0 164.0 130.0 13:10:50 INFO - PROCESS | 7551 | 13:10:50 INFO - PROCESS | 7551 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.42 (0.9%) stddev-sans-first:1.36 13:10:50 INFO - PROCESS | 7551 | Values: 160.0 160.0 161.0 164.0 162.0 160.0 162.0 163.0 163.0 162.0 13:10:50 INFO - PROCESS | 7551 | 13:10:50 INFO - PROCESS | 7551 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:10.86 (14.3%) stddev-sans-first:11.33 13:10:50 INFO - PROCESS | 7551 | Values: 76.0 76.0 75.0 104.0 76.0 79.0 78.0 75.0 100.0 77.0 13:10:50 INFO - PROCESS | 7551 | 13:10:50 INFO - PROCESS | 7551 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:82.50 stddev:12.54 (15.2%) stddev-sans-first:13.08 13:10:50 INFO - PROCESS | 7551 | Values: 84.0 82.0 113.0 83.0 83.0 82.0 106.0 82.0 83.0 106.0 13:10:50 INFO - PROCESS | 7551 | 13:10:50 INFO - PROCESS | 7551 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 13:10:50 INFO - PROCESS | 7551 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 13:10:50 INFO - PROCESS | 7551 | 13:10:50 INFO - PROCESS | 7551 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:146.50 stddev:1.14 (0.8%) stddev-sans-first:1.12 13:10:50 INFO - PROCESS | 7551 | Values: 148.0 146.0 146.0 146.0 149.0 148.0 146.0 146.0 146.0 147.0 13:10:50 INFO - PROCESS | 7551 | 13:10:50 INFO - PROCESS | 7551 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 13:10:50 INFO - PROCESS | 7551 | Values: 96.0 96.0 97.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 13:10:50 INFO - PROCESS | 7551 | 13:10:50 INFO - PROCESS | 7551 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 13:10:50 INFO - PROCESS | 7551 | Values: 64.0 64.0 63.0 63.0 63.0 65.0 64.0 65.0 65.0 64.0 13:10:50 INFO - PROCESS | 7551 | 13:10:50 INFO - PROCESS | 7551 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:1.25 (1.9%) stddev-sans-first:1.27 13:10:50 INFO - PROCESS | 7551 | Values: 66.0 67.0 67.0 66.0 68.0 67.0 66.0 67.0 70.0 66.0 13:10:50 INFO - PROCESS | 7551 | 13:10:50 INFO - PROCESS | 7551 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:84.00 stddev:5.09 (6.1%) stddev-sans-first:5.29 13:10:50 INFO - PROCESS | 7551 | Values: 89.0 94.0 84.0 83.0 82.0 96.0 83.0 83.0 84.0 83.0 13:10:50 INFO - PROCESS | 7551 | 13:10:50 INFO - PROCESS | 7551 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:147.50 stddev:11.94 (8.1%) stddev-sans-first:12.66 13:10:50 INFO - PROCESS | 7551 | Values: 147.0 141.0 138.0 140.0 143.0 159.0 139.0 149.0 177.0 148.0 13:10:50 INFO - PROCESS | 7551 | 13:10:50 INFO - PROCESS | 7551 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:175.50 stddev:2.10 (1.2%) stddev-sans-first:1.96 13:10:50 INFO - PROCESS | 7551 | Values: 178.0 175.0 176.0 178.0 175.0 175.0 173.0 173.0 172.0 177.0 13:10:50 INFO - PROCESS | 7551 | 13:10:50 INFO - PROCESS | 7551 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.00 stddev:1.65 (2.3%) stddev-sans-first:1.67 13:10:50 INFO - PROCESS | 7551 | Values: 73.0 74.0 72.0 70.0 71.0 70.0 72.0 70.0 70.0 74.0 13:10:50 INFO - PROCESS | 7551 | -------- Summary: end -------- 13:10:50 INFO - PROCESS | 7551 | 13:10:51 INFO - TEST-INFO | 7551: exit 0 13:10:51 INFO - TEST-OK | kraken | took 65063ms 13:10:51 INFO - SUITE-END | took 1187s 13:10:51 INFO - Completed test suite (00:19:47) 13:10:51 INFO - javascript benchmark 13:10:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2577.690677118746, 2603.466289410671, 2632.355073007113, 2639.445716399556, 2652.7347265273474, 4458.643308535317, 4556.0660064686745, 4626.352310676504, 4628.583427491525, 4647.883802904929, 4541.88645283868, 4583.037562111952, 4622.029373831491, 4634.374359461472, 4669.322948172513, 4218.810153543082, 4259.2546304396765, 4302.505211900624, 4334.133173365324, 4342.956570434302, 4061.4923134608175, 4317.805698743548, 4360.97819510902, 4409.735415875058, 4455.175792478386, 4168.083021735213, 4301.010767523487, 4342.696011279212, 4347.1088426872575, 4356.847510337139, 4204.915901681979, 4247.04441500663, 4275.4228179195725, 4281.293586558214, 4292.356146578007, 4242.490901091858, 4306.267934451151, 4307.030918043447, 4316.201502722007, 4322.697411181219, 4588.609968152711, 4605.539446055401, 4641.466231383401, 4641.651876109271, 4678.0, 4788.281757736333, 4959.801607935714, 4960.826371077031, 4963.726995015273, 5016.49835016499, 4866.221404575251, 4870.537298956593, 4941.728204948727, 4943.382077240345, 5021.0, 4611.746353950532, 4619.607333376701, 4621.838235661803, 4625.537446255347, 4680.180968330528, 5051.949480505222, 5057.241413787888, 5058.342415485963, 5064.721440320818, 5124.180131178993, 4736.644751643572, 4782.3543821584335, 4782.832600858953, 4838.395200599925, 4838.516148385133, 4960.70235785854, 4996.925046124311, 4999.975000124976, 5060.2156665716875, 5063.746812659352, 4905.632077594195, 4927.408710954636, 4936.037472692862, 5001.549860512571, 5002.549770520671, 4727.621790256771, 4773.331733557305, 4872.756362181876, 4912.533309335608, 4920.138975679241, 4125.8968525786495, 4134.255833949918, 4196.9370459443135, 4215.030542975132, 4263.850765223202, 3658.2683463307444, 3669.5046168766876, 3673.430618254175, 3717.219383929351, 3720.8325625346924, 4399.670024748157, 4409.5149533551285, 4412.624926881187, 4413.249747542925, 4465.12929978651, 4885.65800393969, 4943.233798761198, 4956.776945037482, 4997.125503036954, 5003.524665156804, 4361.127774445124, 4361.193179261847, 4366.737995720267, 4384.145091707086, 4413.337999300131, 4500.324951257272, 4506.774661266923, 4508.774561271924, 4511.390962220124, 4565.7717114144825, 4659.673822832369, 4717.716936983792, 4743.928841067318, 4780.091782561302, 4836.443808962014, 5052.570531504716, 5053.140966035709, 5057.241413787961, 5099.923501147411, 5101.9489805101475, 4810.903781924412, 4819.518048195152, 4824.589909857701, 4825.227963525959, 4886.731229782396, 4714.952850471589, 4754.5245475452175, 4906.116898958079, 4953.331300274417, 5028.899422011613, 4993.350864387607, 4995.17579599362, 5016.398032236009, 5049.823256186016, 5052.191649336089, 4820.68665536739, 4839.806407743792, 4843.878903027453, 4849.80600775965, 4912.263160525949, 4668.369770080995, 4710.152172608963, 4764.4282686077895, 4820.493848146035, 4873.147199240189, 4741.122892264942, 4779.617630589475, 4795.6163506918665, 4796.448408433075, 4843.0, 4868.780904859361, 4894.804207831647, 4901.705897646153, 4911.238757992517, 4960.627952903619, 4609.516000819865, 4639.744814035261, 4642.953570464388, 4705.835295764632, 4789.976050119727], "value": 4570.2135223768655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.4357570641505, 569.08945686901, 575.562572444942, 575.5654480866945, 577.4946921443735, 27813.165605031856, 37776.622233777685, 39145.41281880774, 39203.01992450187, 42588.36117458241, 39797.60202397982, 39938.40092398616, 40041.99790010502, 40246.0, 40294.59705402945, 7761.3402860756905, 7907.802304942365, 7924.603769811515, 7925.682972681115, 7928.524288542677, 7664.846703065935, 7741.109772376192, 7759.650815713307, 7761.922380776176, 7762.573058481781, 7755.534667919915, 7786.182450842665, 7790.337821285198, 7802.0, 7806.804829879242, 7754.1470438251745, 7756.573388463632, 7776.494527855672, 7789.532628042336, 7796.025496812898, 7749.108852481981, 7807.6876924922935, 7808.960955195244, 7811.648475818545, 7815.882761758578, 37526.81236593799, 37927.48290068394, 37994.43008354877, 38026.61973380286, 38063.61936380628, 3019.9849000755075, 3050.572919791231, 3087.548852039538, 3093.551435041906, 3200.2159470929537, 27560.724392756016, 27646.308842278904, 27712.722872771217, 27721.445571088465, 27960.0, 3473.2879759649213, 3545.85816567337, 3574.7140228781636, 3605.1167463971233, 3621.7826930384263, 254143.0, 254148.0, 255572.0, 255597.0, 255690.0, 31288.53067203994, 50793.49206507961, 51004.48995510072, 51101.23348149781, 51149.0, 31877.840610797262, 34031.149221269174, 34044.0, 34061.82969085139, 34064.48903266403, 11994.940025299818, 12071.57749478764, 12142.150049496628, 12144.635660930186, 12154.33151176676, 9826.361286516354, 9912.107910287965, 9923.851142232872, 9924.156446701967, 9926.354786938826, 7513.962430187814, 7545.660445279976, 7570.205128461543, 7591.734289299848, 7678.462507624525, 3111.2999575095873, 3126.624805023366, 3151.4642510773224, 3181.840907954593, 3193.3613277344625, 828.2090603473669, 829.6764261937849, 944.15026476172, 950.6672664567346, 953.3469573342283, 24623.38441538976, 25029.749702503104, 25103.62344564833, 25411.237662870142, 25781.3554661135, 922.460360688991, 940.0740270833223, 940.6331530703031, 993.0020329568737, 1045.1482042135635, 13768.303101345193, 13793.86206137946, 13892.86107138936, 14071.648208794657, 14124.50564230247, 115725.42137289429, 117373.0, 117613.0, 117829.4108529469, 118506.0, 48436.27345589819, 48961.02077958421, 48966.0, 49001.0, 49075.509244907094, 1043.9217058720626, 1085.0776839686202, 1121.1143196874377, 1157.5774842182711, 1202.8195770634475, 25215.117470888432, 28588.285292867844, 28707.85646071756, 28734.281642959093, 29076.27309317284, 40150.39774403328, 40493.59506404898, 40624.39063413992, 40657.0, 40675.389869152576, 291313.0, 292574.0, 292875.0, 293236.0, 293678.0, 21895.781042189374, 22466.663000054687, 24018.639720404557, 24667.38331541654, 24960.37599060038, 40232.0, 40505.0, 40574.79712601418, 41619.16761664689, 41694.79152604217, 34580.135496612784, 34840.47739283862, 35016.47475287822, 35230.295394092485, 35241.0, 34465.65534344625, 34835.303293934485, 34888.47667285043, 35210.82394588113, 35249.0, 27449.45101098007, 27775.722242778123, 28026.43947121087, 28075.71924280813, 28292.15123546297, 29329.413411732072, 31320.686793131776, 31660.366792664478, 31973.520397194527, 32221.67778322187, 24158.75841241565, 24225.152119675728, 24546.386340341633, 24737.752622473545, 24946.12688555892], "value": 15389.794747901025, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.419477225983, 371.2834229936223, 377.68085967357575, 387.68791123145854, 390.1280637774573, 15264.618384540392, 16381.262843172057, 16871.746923796152, 16965.3213871445, 16972.15139243039, 15915.681686366295, 16783.748243776354, 17161.91419042903, 17298.827011729878, 17318.393856215036, 4893.0, 5205.713685747282, 5206.479352064801, 5206.531412172903, 5210.322658054448, 3681.3557627415094, 3905.433712111742, 5106.0, 5804.738786754585, 6084.1786358841655, 6050.96974515129, 6051.757929682807, 6057.757689692407, 6066.393360663942, 6067.302260240085, 5813.09896965971, 6030.577859549811, 6052.364501727299, 6053.303870054956, 6073.089036644495, 4729.432468103815, 5339.199120131972, 5340.893182136336, 5345.251664766935, 5350.598705097094, 17676.381326653507, 19054.14256358467, 19080.0, 19145.9042704787, 19164.137613807274, 1743.7471566622896, 1796.5149409659318, 1828.570285982793, 1861.8789778664343, 2396.892139853711, 8584.785380365478, 9177.541122943892, 9392.718218453389, 11844.526218951232, 12610.558630447982, 1639.7294446416327, 1705.7015022371036, 1723.147042214112, 1725.9913700431543, 1746.7292569651725, 59239.70644109828, 63305.0, 69279.0, 73281.26718732798, 73436.6328168361, 9682.806343873082, 9743.707688769347, 9893.901060989441, 9958.0, 10009.158056103031, 13148.934255328662, 13339.599812005656, 13350.064240685046, 13360.131591446525, 13486.662833429244, 5560.833175004756, 5692.260006199168, 5722.62802917809, 5987.730552125077, 6857.348551887562, 5916.1421593868645, 6240.126382306481, 6334.904976425358, 6395.392437718409, 6407.807765767035, 4088.8160032798596, 4147.6267135957905, 4224.471941007374, 4265.87202383929, 4332.588404101605, 1561.5783738390571, 1655.5695519165104, 1684.1579210394802, 1820.2082094289026, 2958.349163184096, 748.6818102306498, 763.2138896936165, 782.6399856066159, 803.8504937938803, 804.0552350987566, 15006.875462294362, 15378.769318460232, 15799.210039497979, 16171.514854554382, 16652.250648720837, 778.0624347661055, 801.939854510914, 814.1044850664222, 820.4216027700576, 884.7390019944132, 8768.736937891874, 9405.90594094064, 9481.952590237004, 9496.335256532115, 9672.854907176397, 387882.0, 390118.0, 401404.0, 404887.0, 404945.0, 76295.61852190815, 77951.61024194842, 79485.0, 79861.0, 79868.6006569975, 813.7151996801073, 867.1545243387773, 909.3543584055262, 923.50592433048, 931.3527098666498, 12065.28045702289, 15144.16707081077, 15694.372225111325, 15865.762013570036, 15905.0, 33901.83049084739, 34202.82898585491, 35474.64525354713, 37351.62648373481, 39407.80296098501, 50035.49964500308, 50091.0, 50220.24669630032, 50511.24233136432, 52363.21455178099, 4419.845305414295, 4691.202495575692, 7445.255474452511, 7506.324430801035, 7660.004199454035, 8049.356051515748, 10414.583416663552, 10460.895391046297, 10910.181736369645, 11158.10735141203, 9433.905660943303, 9435.952820235854, 9574.377665451724, 9639.9036009639, 9716.75708107303, 9421.905780942103, 9476.715698529055, 9520.666776662783, 9651.855222171813, 10091.646792362526, 9371.906280937103, 9430.952845236005, 9505.904940950502, 9592.12953474066, 9622.663206787729, 7079.646017699198, 7106.0, 7276.417886569167, 7330.890036649348, 7394.225385907451, 7228.915662650645, 9534.380265282734, 9703.5148242589, 9771.853422198816, 9995.850062248926], "value": 7934.0093414932635, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1100.7798440311938, 1107.961221357252, 1271.357964228065, 1353.7766268565688, 1417.2842714429212, 6682.29835867233, 6917.1699396072545, 7235.457340699449, 7829.217078292168, 7836.804079897998, 7161.212266650664, 7444.739434119807, 7454.440916931225, 7693.0768307803, 7697.615119244029, 2108.20942146695, 2136.2736669532433, 2146.023559280524, 2154.310620601408, 2157.3959291398432, 1689.7127488327014, 1743.4856717268435, 2068.7414073240843, 2119.088791819517, 2138.6685063815057, 2042.295408084216, 2103.673930540761, 2112.197365001305, 2114.7039414481983, 2131.11558703138, 2055.0444043519833, 2062.5771716798095, 2069.193014724259, 2074.1081335026083, 2083.3541602103246, 2087.2590230468118, 2092.288621868572, 2096.968545471819, 2098.181709133439, 2102.306238941161, 7585.582792946386, 7641.541507509567, 7645.197254288275, 7647.847043059163, 7650.081990161217, 4205.537390887, 4287.914241715148, 4387.62705170061, 4441.244988351956, 4458.108378324348, 2675.558532842079, 2773.1403264987716, 2805.228562145406, 2818.873150708223, 2822.957655635167, 857.0786404615002, 883.0330787787362, 897.304588943574, 897.6319708919311, 916.2349438219095, 9972.202223822149, 10043.0, 10053.994600539962, 10070.647527336509, 10072.093511583993, 3737.8131093445218, 3860.6718428933295, 4061.8578349757618, 4076.0421300994244, 4097.1191193893455, 8740.257078148301, 8744.519051452231, 8752.47485150893, 8756.299496040301, 8759.649614015496, 4505.977470112694, 4507.752073635981, 4508.143452743968, 4509.932351014738, 4511.075229577928, 3999.760014399087, 4143.274926887842, 4146.398772178018, 4146.875593732193, 4147.357159640261, 3511.473279008118, 3548.077499850006, 3569.464580312974, 3605.2248766515327, 3620.3121406933124, 1045.3048722599538, 1091.9071878890225, 1126.2341607706837, 1137.4597066393396, 1168.567629976914, 582.6125626458443, 681.2574294019543, 755.1052003375908, 766.2988365645483, 782.9491083079696, 4741.383620129361, 4862.95137048632, 4939.777710003059, 4942.728149951715, 5006.949930500648, 813.8535063688593, 814.1329484099415, 828.2007862412801, 847.7499137754377, 868.6264906090441, 3300.2574420755136, 3307.7353811695007, 3323.0529299149625, 3325.9501107483406, 3389.694927456541, 8865.468071915706, 9350.485723285285, 9351.158395744416, 9353.801856563701, 9360.859587106199, 9245.491497967541, 9269.629214831331, 9274.072592740671, 9302.441853488812, 9313.627454901864, 6992.580445173306, 7041.225465198824, 7076.32774886385, 7145.17830449505, 7155.284471552803, 4558.635309175324, 4614.0, 4725.149473094876, 4765.0, 4899.730514821576, 8191.971867569934, 8313.750587482386, 8329.958350208453, 8446.577671116296, 8592.527410992456, 8500.36247281444, 8577.185167409087, 8615.526146062026, 8747.431416957877, 8861.582146856472, 6633.9668301658185, 6646.83382915431, 6710.765123220664, 6715.0, 6727.596344219362, 6795.354441328066, 6991.545549539263, 7039.296070392919, 7041.119860017498, 7157.463190260647, 5086.923696144487, 6386.521010924106, 6405.551611387158, 6567.573107747981, 6597.868042639217, 6421.646809425526, 6527.706253218522, 6531.9020214695865, 6538.346165383424, 6548.279689234276, 5956.255468066492, 6095.451409373178, 6105.725242364193, 6114.633122012693, 6119.571629985859, 4351.456067991501, 4395.868123956287, 4399.296112621965, 4449.510553839011, 4573.885652858705, 4207.705460617727, 4222.577742225752, 4289.506706728766, 4333.414988976448, 4441.622462090759], "value": 3927.752078684992, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.96810350861404, 299.7362321157381, 303.89819410497483, 304.6100990731864, 304.9252933031408, 4540.97729511352, 4687.742174180418, 4692.366530518383, 4739.691920025196, 4751.144793937095, 4437.93343099853, 4611.400517932672, 4623.398958135438, 4642.187617166991, 4653.9534604653945, 3723.7765734055906, 3728.4780130781714, 3731.776093434403, 3740.9625903740884, 3746.7189960752985, 3505.8422370993367, 3645.9453108203397, 3726.4224045273027, 3741.5884252732176, 3751.9249615007684, 3592.2815436912724, 3674.1078344652524, 3678.613745556718, 3696.4085746280603, 3704.2961837250837, 3671.375866102769, 3672.437735396661, 3676.5293882446967, 3682.963170368289, 3694.4458331250257, 3268.8365581721055, 3280.3767284215924, 3284.0, 3285.950710739341, 3286.753493487998, 4467.508574056851, 4522.2086134926585, 4538.2738761797955, 4557.9061025354, 4561.224591819366, 4213.389058586518, 4217.91564168718, 4218.873433796991, 4222.1555688862045, 4230.323148296288, 4880.560749532524, 4884.780184891689, 4891.192953162724, 4894.804207831682, 4898.21628539432, 3483.1017095682914, 3561.5931706975857, 3591.9102022449647, 3594.6944509716445, 3595.964040359589, 5055.595552355802, 5061.670991385548, 5064.151584671568, 5087.109755792721, 5091.949080509185, 3641.5630124385243, 3642.617525159873, 3649.8138105115413, 3656.305301992613, 3659.6706296432917, 3695.316366472211, 3710.293265098031, 3715.461258117558, 3748.3253014457114, 3755.9248815023548, 4111.013356794348, 4136.751794892316, 4149.460570125864, 4169.10364271683, 4254.404383386328, 4830.275458681155, 4841.515848415131, 4852.95147048525, 4864.586510146677, 4865.513448655106, 1203.3802591665299, 1234.2532767675427, 1262.7372627372627, 1270.3838638260436, 1283.2300619628336, 888.813349196663, 891.8094344050635, 904.4799240436644, 908.731924082384, 914.2685851318919, 4362.454693163355, 4375.27807911691, 4406.1187762447635, 4417.4036505072045, 4418.33724941255, 5019.874503137451, 5020.623453241022, 5033.313839863687, 5040.344755181803, 5041.319421878, 4416.939934415717, 4417.845375411845, 4423.845165419195, 4425.5574442556135, 4430.734155950653, 2213.8450308478573, 2362.4566349739657, 2365.3258821235863, 2382.9761702383103, 2384.475415408607, 4275.315949448135, 4286.335617979218, 4294.1411717655965, 4294.613484786384, 4305.634021108241, 4545.38637283969, 4546.0, 4546.771792027697, 4555.567221113989, 4566.0, 4117.91764164715, 4212.85255016073, 4221.219074471172, 4236.406903033516, 4291.249031419489, 4379.795556222064, 4432.977835110803, 4490.416245888014, 4501.864944051684, 4512.954870451254, 4385.886020925179, 4406.317020861771, 4418.381426600215, 4420.7126536775, 4445.510993790615, 4325.805338759827, 4339.392485052158, 4345.34819777036, 4538.478075021415, 4917.729524876167, 3629.455581662666, 3630.219502806909, 3631.2011357501306, 3633.945490817587, 3647.398179300386, 4868.442098528437, 5093.83512007388, 5118.948810511847, 5135.278302499682, 5138.948610513997, 4834.501304595587, 4875.902481950412, 4970.285251588196, 4980.900381992267, 4983.327250821093, 4976.800927962841, 4984.32711583946, 4984.853483698842, 4988.254111061099, 5001.199808030698, 4789.377380940595, 4822.276658501253, 4927.482614325444, 4932.161532539405, 4951.455339912534, 4955.281484184845, 4991.450940396626, 4996.60027197816, 5008.649394542347, 5013.473585273494, 4899.951000489949, 4902.975485122552, 4907.68100073494, 4908.509149085063, 4920.901581968269], "value": 3656.879725071977, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.3746866041375, 585.8213244960291, 631.7220423013874, 671.0571646836194, 676.566997121842, 11947.820782688255, 12831.550895718652, 13348.532801351954, 13925.930370348135, 14155.858441415583, 13894.305284735749, 14027.36876840542, 14055.578332650037, 14058.507952221675, 14069.085509441878, 744.2594618354744, 766.1380946435261, 769.0809482668213, 770.5838847022601, 771.7916162636085, 608.1151923950641, 626.0015275635377, 749.9025126733517, 773.9690412383526, 779.5439667794319, 816.677412422093, 816.7549735079482, 818.5457071325412, 818.7420962396826, 819.7991492084448, 811.2576992052324, 812.4312980913326, 812.5774597209477, 813.1989989859953, 813.3899575318511, 470.68934503227706, 479.5228747396328, 573.3750212268606, 585.844751140948, 592.3987153039668, 12457.813132803016, 12468.875311246953, 12471.688207794787, 12492.125551211418, 12504.37478126099, 10695.732606684818, 11592.0, 11682.941585292105, 11683.41582920859, 11744.823827642593, 11191.0, 11322.886771132265, 11636.883631163664, 11637.301761894314, 11686.12354073448, 3942.3889297158985, 3971.0866500705, 3972.483577134983, 3973.245083434167, 4037.071473561068, 61955.0, 62058.68970655118, 62090.99999999955, 62553.68723156401, 63025.36974630241, 9683.951580242054, 9801.460919649488, 9928.553215105338, 10176.084152426318, 10308.32995855267, 17121.486355409357, 17198.484045478657, 17295.827041729422, 17348.566285842953, 17458.214380352914, 6232.626042437469, 6350.745970161234, 6432.807015789534, 6493.090967264587, 6521.380468855451, 3491.825408729553, 3539.50446937429, 3571.982140089283, 3619.5113659656135, 3784.6215378462484, 2685.3823620567377, 2774.987129697686, 2794.385235248242, 2807.6350074490188, 2818.577213417963, 483.45369732202386, 483.97338146402285, 491.027765025252, 493.21578689883256, 500.2321436594809, 523.7224271136304, 541.442314416152, 550.6998685716214, 557.565099222607, 559.454531831461, 7877.172896845748, 7928.3260922821055, 8148.714794982147, 8189.918100819034, 8249.917500825035, 546.8769526856505, 559.4098226371136, 562.4263251483465, 565.6803905793296, 570.1077813222294, 3631.7276204284785, 3826.8851934441454, 3972.0, 3997.400389941474, 4061.6953728470485, 80219.59890200512, 95304.0, 96633.5168324154, 99200.50399747955, 101946.0, 82439.17560824315, 83658.58170709107, 86656.0, 87790.0, 88027.0, 71713.64143179251, 76482.0, 76606.0, 77570.61214694004, 82429.58785206036, 7595.961210837287, 7955.204479551999, 8132.227438393344, 8251.174882511701, 8271.710490132817, 30397.392052159274, 30732.692673073878, 36791.0, 39957.60042399655, 42604.36093458663, 62711.372886270554, 62818.37181628125, 64041.3595864054, 64529.0, 66248.0, 10004.399736015863, 10387.0, 10509.632162874263, 10533.104686101768, 10725.517351719347, 11722.0, 11949.76100478003, 12525.812112818498, 12742.0, 12929.935350323189, 11104.44477776124, 11586.652400428, 11593.652190433962, 11677.357745323749, 11882.821757673815, 10606.522706478381, 11550.0, 12091.274523528617, 12092.455839487067, 12112.939435302767, 10869.78260434771, 11565.768684626091, 11702.648920532398, 12066.818997715216, 12123.0, 8963.372563920462, 9493.193078588121, 9909.0, 10171.440570768678, 10486.790264194826, 8942.37403381783, 9391.718248452557, 9538.95230523843, 9683.951580242054, 9832.115109640166], "value": 6402.587738284324, "unit": "score"}], "name": "dromaeo_css", "value": 6096.117543649533, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 117.0, 118.0, 117.0, 117.0, 115.0, 117.0, 117.0, 116.0], "value": 116.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 130.0, 133.0, 171.0, 129.0, 128.0, 135.0, 129.0, 164.0, 130.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 164.0, 162.0, 160.0, 162.0, 163.0, 163.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 104.0, 76.0, 79.0, 78.0, 75.0, 100.0, 77.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 113.0, 83.0, 83.0, 82.0, 106.0, 82.0, 83.0, 106.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 146.0, 149.0, 148.0, 146.0, 146.0, 146.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 63.0, 65.0, 64.0, 65.0, 65.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 68.0, 67.0, 66.0, 67.0, 70.0, 66.0], "value": 67.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 94.0, 84.0, 83.0, 82.0, 96.0, 83.0, 83.0, 84.0, 83.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 141.0, 138.0, 140.0, 143.0, 159.0, 139.0, 149.0, 177.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 175.0, 176.0, 178.0, 175.0, 175.0, 173.0, 173.0, 172.0, 177.0], "value": 175.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 72.0, 70.0, 71.0, 70.0, 72.0, 70.0, 70.0, 74.0], "value": 71.6, "unit": "score"}], "name": "kraken", "value": 1561.4999999999998, "alertThreshold": 2.0}]} 13:10:51 INFO - Return code: 0 13:10:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:10:51 INFO - # TBPL SUCCESS # 13:10:51 INFO - Running post-action listener: _resource_record_post_action 13:10:51 INFO - [mozharness: 2016-10-03 20:10:51.877614Z] Finished run-tests step (success) 13:10:51 INFO - Running post-run listener: _resource_record_post_run 13:10:51 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391573504; Read time: 12; Write time: 215320 13:10:51 INFO - TinderboxPrint: CPU usage
13.1% 13:10:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 13:10:51 INFO - TinderboxPrint: I/O write bytes / time
391,573,504 / 215,320 13:10:51 INFO - TinderboxPrint: CPU idle
8,352.5 (86.9%) 13:10:51 INFO - TinderboxPrint: CPU user
1,204.4 (12.5%) 13:10:51 INFO - TinderboxPrint: Swap in / out
0 / 0 13:10:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99168256; Read time: 0; Write time: 53316 13:10:51 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291430400; Read time: 0; Write time: 161976 13:10:52 INFO - Running post-run listener: _upload_blobber_files 13:10:52 INFO - Blob upload gear active. 13:10:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:10:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:10:52 INFO - (blobuploader) - INFO - Open directory for files ... 13:10:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:10:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:10:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:10:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:10:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:10:53 INFO - (blobuploader) - INFO - Done attempting. 13:10:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:10:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:10:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:10:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:10:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:10:54 INFO - (blobuploader) - INFO - Done attempting. 13:10:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:10:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:10:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:10:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:10:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:10:57 INFO - (blobuploader) - INFO - Done attempting. 13:10:57 INFO - (blobuploader) - INFO - Iteration through files over. 13:10:57 INFO - Return code: 0 13:10:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:10:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:10:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1f7bc5c00528b434ee2f590a4d67acec4db4a4e84144ee4c03db0a3076016510b261ea25e33890affcf7eed67853a902c672bedf973afa4946da88a772c2b94c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cd83eda695addacaca7f04d609d31a5047c20eb7053ca8771f9073f6a50194be79c4d5d9c09d8f77001388feea8ff93c190924c958273e1e7daee0417f6c58b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/072e83db2d3c8834f9bb31fe2dd61a2b710942527c148a17ecc23002b03cb3c39e65dc03c6b7f39938b4550e795a0cd5e6617790c016035cb1bef2b0a991d41c"} 13:10:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:10:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:10:57 INFO - Contents: 13:10:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1f7bc5c00528b434ee2f590a4d67acec4db4a4e84144ee4c03db0a3076016510b261ea25e33890affcf7eed67853a902c672bedf973afa4946da88a772c2b94c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cd83eda695addacaca7f04d609d31a5047c20eb7053ca8771f9073f6a50194be79c4d5d9c09d8f77001388feea8ff93c190924c958273e1e7daee0417f6c58b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/072e83db2d3c8834f9bb31fe2dd61a2b710942527c148a17ecc23002b03cb3c39e65dc03c6b7f39938b4550e795a0cd5e6617790c016035cb1bef2b0a991d41c"} 13:10:57 INFO - Running post-run listener: copy_logs_to_upload_dir 13:10:57 INFO - Copying logs to upload dir... 13:10:57 INFO - mkdir: /builds/slave/test/build/upload/logs 13:10:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.114144 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-03 13:10:56.766223) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 13:10:56.770142) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1f7bc5c00528b434ee2f590a4d67acec4db4a4e84144ee4c03db0a3076016510b261ea25e33890affcf7eed67853a902c672bedf973afa4946da88a772c2b94c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cd83eda695addacaca7f04d609d31a5047c20eb7053ca8771f9073f6a50194be79c4d5d9c09d8f77001388feea8ff93c190924c958273e1e7daee0417f6c58b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/072e83db2d3c8834f9bb31fe2dd61a2b710942527c148a17ecc23002b03cb3c39e65dc03c6b7f39938b4550e795a0cd5e6617790c016035cb1bef2b0a991d41c"} build_url:https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011361 build_url: 'https://queue.taskcluster.net/v1/task/D4yJrgboTRCM1oszbA3G_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1f7bc5c00528b434ee2f590a4d67acec4db4a4e84144ee4c03db0a3076016510b261ea25e33890affcf7eed67853a902c672bedf973afa4946da88a772c2b94c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cd83eda695addacaca7f04d609d31a5047c20eb7053ca8771f9073f6a50194be79c4d5d9c09d8f77001388feea8ff93c190924c958273e1e7daee0417f6c58b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/072e83db2d3c8834f9bb31fe2dd61a2b710942527c148a17ecc23002b03cb3c39e65dc03c6b7f39938b4550e795a0cd5e6617790c016035cb1bef2b0a991d41c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 13:10:56.796431) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 13:10:56.796826) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1475522019.473772-124733150 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 13:10:56.880982) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 13:10:56.881335) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 13:10:56.881719) ========= ========= Total master_lag: 0.18 =========