builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-034 starttime: 1475153272.53 results: success (0) buildid: 20160929050519 builduid: 9836f6b5518842d0b79032d5afef57ed revision: 0f2c7b2a783bbc5954e93216e7cb3b396a78003e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 05:47:52.533680) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 05:47:52.534128) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 05:47:52.534419) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 05:47:52.555083) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 05:47:52.555447) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-29 05:47:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-09-29 05:47:53 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136024 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 05:47:52.707908) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 05:47:52.708266) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020822 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 05:47:52.757537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 05:47:52.760946) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0f2c7b2a783bbc5954e93216e7cb3b396a78003e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0f2c7b2a783bbc5954e93216e7cb3b396a78003e --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=d6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-29 05:47:53,627 truncating revision to first 12 chars 2016-09-29 05:47:53,627 Setting DEBUG logging. 2016-09-29 05:47:53,628 attempt 1/10 2016-09-29 05:47:53,628 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0f2c7b2a783b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-29 05:47:54,430 unpacking tar archive at: fx-team-0f2c7b2a783b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.126367 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 05:47:53.905645) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 05:47:53.905952) ========= script_repo_revision: 0f2c7b2a783bbc5954e93216e7cb3b396a78003e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 05:47:53.906352) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 05:47:53.906622) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 05:47:53.917742) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-29 05:47:53.918023) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=d6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:47:54 INFO - MultiFileLogger online at 20160929 05:47:54 in /builds/slave/test 05:47:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:47:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:47:54 INFO - {'append_to_log': False, 05:47:54 INFO - 'base_work_dir': '/builds/slave/test', 05:47:54 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:47:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:47:54 INFO - 'branch': 'Fx-Team-Non-PGO', 05:47:54 INFO - 'buildbot_json_path': 'buildprops.json', 05:47:54 INFO - 'config_files': ('talos/linux_config.py',), 05:47:54 INFO - 'default_actions': ('clobber', 05:47:54 INFO - 'read-buildbot-config', 05:47:54 INFO - 'download-and-extract', 05:47:54 INFO - 'populate-webroot', 05:47:54 INFO - 'create-virtualenv', 05:47:54 INFO - 'install', 05:47:54 INFO - 'run-tests'), 05:47:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:47:54 INFO - 'download_minidump_stackwalk': True, 05:47:54 INFO - 'download_symbols': 'ondemand', 05:47:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:47:54 INFO - 'tooltool.py': '/tools/tooltool.py', 05:47:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:47:54 INFO - '/tools/misc-python/virtualenv.py')}, 05:47:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:47:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:47:54 INFO - 'installer_path': 'installer.exe', 05:47:54 INFO - 'log_level': 'info', 05:47:54 INFO - 'log_name': 'talos', 05:47:54 INFO - 'log_to_console': True, 05:47:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:47:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:47:54 INFO - 'opt_config_files': (), 05:47:54 INFO - 'pip_index': False, 05:47:54 INFO - 'sps_profile': False, 05:47:54 INFO - 'sps_profile_interval': 0, 05:47:54 INFO - 'suite': 'dromaeojs', 05:47:54 INFO - 'system_bits': '32', 05:47:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:47:54 INFO - 'title': 'talos-linux64-ix-034', 05:47:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:47:54 INFO - 'use_talos_json': True, 05:47:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:47:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:47:54 INFO - 'work_dir': 'build'} 05:47:54 INFO - [mozharness: 2016-09-29 12:47:54.886524Z] Running clobber step. 05:47:54 INFO - Running pre-action listener: _resource_record_pre_action 05:47:54 INFO - Running main action method: clobber 05:47:54 INFO - rmtree: /builds/slave/test/build 05:47:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:47:55 INFO - Running post-action listener: _resource_record_post_action 05:47:55 INFO - [mozharness: 2016-09-29 12:47:55.345770Z] Finished clobber step (success) 05:47:55 INFO - [mozharness: 2016-09-29 12:47:55.345870Z] Running read-buildbot-config step. 05:47:55 INFO - Running pre-action listener: _resource_record_pre_action 05:47:55 INFO - Running main action method: read_buildbot_config 05:47:55 INFO - Using buildbot properties: 05:47:55 INFO - { 05:47:55 INFO - "project": "", 05:47:55 INFO - "product": "firefox", 05:47:55 INFO - "script_repo_revision": "production", 05:47:55 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:47:55 INFO - "repository": "", 05:47:55 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:47:55 INFO - "buildid": "20160929050519", 05:47:55 INFO - "pgo_build": "False", 05:47:55 INFO - "basedir": "/builds/slave/test", 05:47:55 INFO - "buildnumber": 3358, 05:47:55 INFO - "slavename": "talos-linux64-ix-034", 05:47:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:47:55 INFO - "platform": "ubuntu64_hw", 05:47:55 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:47:55 INFO - "branch": "fx-team", 05:47:55 INFO - "repo_path": "integration/fx-team", 05:47:55 INFO - "revision": "0f2c7b2a783bbc5954e93216e7cb3b396a78003e", 05:47:55 INFO - "stage_platform": "linux64", 05:47:55 INFO - "builduid": "9836f6b5518842d0b79032d5afef57ed", 05:47:55 INFO - "slavebuilddir": "test" 05:47:55 INFO - } 05:47:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:47:55 INFO - Running post-action listener: _resource_record_post_action 05:47:55 INFO - [mozharness: 2016-09-29 12:47:55.348304Z] Finished read-buildbot-config step (success) 05:47:55 INFO - [mozharness: 2016-09-29 12:47:55.348392Z] Running download-and-extract step. 05:47:55 INFO - Running pre-action listener: _resource_record_pre_action 05:47:55 INFO - Running main action method: download_and_extract 05:47:55 INFO - mkdir: /builds/slave/test/build/tests 05:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:55 INFO - trying https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:47:55 INFO - Downloading https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/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 05:47:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/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 05:47:55 INFO - Downloaded 1361 bytes. 05:47:55 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:47:55 INFO - Using the following test package requirements: 05:47:55 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:55 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:47:55 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:47:55 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:55 INFO - u'jsshell-linux-x86_64.zip'], 05:47:55 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:47:55 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:55 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:47:55 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:47:55 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:47:55 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:47:55 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:47:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:47:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:47:55 INFO - Fetch https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:47:56 INFO - Http code: 200 05:47:56 INFO - Content-Encoding: None 05:47:56 INFO - Content-Type: application/zip 05:47:56 INFO - via: 1.1 81871f1c889cc44b6c25e3ef722a3801.cloudfront.net (CloudFront) 05:47:56 INFO - x-amz-cf-id: 1haK4ZOLNZEiBVOYm5dG3G9LLJhcpnFT3gT7GJsO4nQFQCJk-D7WVA== 05:47:56 INFO - x-amz-version-id: lm5jR9.4ydagh4sP1ItXnwnGs7j2jDMA 05:47:56 INFO - x-cache: Hit from cloudfront 05:47:56 INFO - Expected file size: 20417494 05:47:56 INFO - Obtained file size: 20417494 05:48:00 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 05:48:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:48:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:48:00 INFO - Fetch https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:48:01 INFO - Http code: 200 05:48:01 INFO - Content-Encoding: None 05:48:01 INFO - Content-Type: application/zip 05:48:01 INFO - via: 1.1 02192a27c967e955f8c815efa939bfc8.cloudfront.net (CloudFront) 05:48:01 INFO - x-amz-cf-id: PMuK07zvexgMSqxaqI7pXZ4-3m9vzV8n5bK9kT6OdNUCqqavXNQF9A== 05:48:01 INFO - x-amz-version-id: lm5jR9.4ydagh4sP1ItXnwnGs7j2jDMA 05:48:01 INFO - x-cache: Hit from cloudfront 05:48:01 INFO - Expected file size: 20417494 05:48:01 INFO - Obtained file size: 20417494 05:48:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:48:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:48:06 INFO - Fetch https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:48:06 INFO - Http code: 200 05:48:06 INFO - Content-Encoding: None 05:48:06 INFO - Content-Type: application/zip 05:48:06 INFO - via: 1.1 75d3bdff1b8eb2920f04077d77f16ca0.cloudfront.net (CloudFront) 05:48:06 INFO - x-amz-cf-id: MeVoKMD58qLrOu8wPIB6Wnib-R9snLBTWfi2KIRd_1q_tiWl-wC0Zw== 05:48:06 INFO - x-amz-version-id: oucauJkm4xKIx6OAjFjZRNSouZL2TBBV 05:48:06 INFO - x-cache: Hit from cloudfront 05:48:07 INFO - Expected file size: 14414067 05:48:07 INFO - Obtained file size: 14414067 05:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:07 INFO - trying https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:48:07 INFO - Downloading https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/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 05:48:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/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 05:48:08 INFO - Downloaded 55745612 bytes. 05:48:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:48:08 INFO - mkdir: /builds/slave/test/properties 05:48:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:48:08 INFO - Writing to file /builds/slave/test/properties/build_url 05:48:08 INFO - Contents: 05:48:08 INFO - build_url:https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:48:10 INFO - Running post-action listener: _resource_record_post_action 05:48:10 INFO - Running post-action listener: set_extra_try_arguments 05:48:10 INFO - [mozharness: 2016-09-29 12:48:10.390241Z] Finished download-and-extract step (success) 05:48:10 INFO - [mozharness: 2016-09-29 12:48:10.390469Z] Running populate-webroot step. 05:48:10 INFO - Running pre-action listener: _resource_record_pre_action 05:48:10 INFO - Running main action method: populate_webroot 05:48:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:48:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:48:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:48:10 INFO - '--tppagecycles', 05:48:10 INFO - '7'], 05:48:10 INFO - 'tests': ['tsvgm']}}, 05:48:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:48:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:48:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:48:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:48:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:48:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:48:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:10 INFO - 'talos_options': ['--disable-e10s'], 05:48:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:10 INFO - 'talos_options': ['--disable-e10s'], 05:48:10 INFO - 'tests': ['damp', 'tps']}, 05:48:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:10 INFO - 'tests': ['damp', 'tps']}, 05:48:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:48:10 INFO - 'tests': ['dromaeo_dom']}, 05:48:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:48:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:48:10 INFO - 'tests': ['basic_compositor_video']}, 05:48:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:48:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:48:10 INFO - 'tests': ['a11yr', 05:48:10 INFO - 'ts_paint', 05:48:10 INFO - 'tpaint', 05:48:10 INFO - 'sessionrestore', 05:48:10 INFO - 'sessionrestore_no_auto_restore', 05:48:10 INFO - 'tabpaint']}, 05:48:10 INFO - 'other-e10s': {'tests': ['a11yr', 05:48:10 INFO - 'ts_paint', 05:48:10 INFO - 'tpaint', 05:48:10 INFO - 'sessionrestore', 05:48:10 INFO - 'sessionrestore_no_auto_restore', 05:48:10 INFO - 'tabpaint']}, 05:48:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:48:10 INFO - 'ts_paint', 05:48:10 INFO - 'tpaint', 05:48:10 INFO - 'sessionrestore', 05:48:10 INFO - 'sessionrestore_no_auto_restore', 05:48:10 INFO - 'tabpaint']}, 05:48:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:48:10 INFO - 'ts_paint', 05:48:10 INFO - 'tpaint', 05:48:10 INFO - 'sessionrestore', 05:48:10 INFO - 'sessionrestore_no_auto_restore', 05:48:10 INFO - 'tabpaint']}, 05:48:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:48:10 INFO - 'tests': ['a11yr', 05:48:10 INFO - 'ts_paint', 05:48:10 INFO - 'tpaint', 05:48:10 INFO - 'sessionrestore', 05:48:10 INFO - 'sessionrestore_no_auto_restore', 05:48:10 INFO - 'tabpaint']}, 05:48:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:48:10 INFO - 'tests': ['a11yr', 05:48:10 INFO - 'ts_paint', 05:48:10 INFO - 'tpaint', 05:48:10 INFO - 'sessionrestore', 05:48:10 INFO - 'sessionrestore_no_auto_restore', 05:48:10 INFO - 'tabpaint']}, 05:48:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:48:10 INFO - 'tests': ['tsvgx', 05:48:10 INFO - 'tsvgr_opacity', 05:48:10 INFO - 'tart', 05:48:10 INFO - 'tscrollx', 05:48:10 INFO - 'cart']}, 05:48:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:48:10 INFO - 'tsvgr_opacity', 05:48:10 INFO - 'tart', 05:48:10 INFO - 'tscrollx', 05:48:10 INFO - 'cart']}, 05:48:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:10 INFO - 'talos_options': ['--disable-e10s'], 05:48:10 INFO - 'tests': ['tp5o']}, 05:48:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:10 INFO - 'tests': ['tp5o']}, 05:48:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:10 INFO - 'talos_options': ['--disable-e10s', 05:48:10 INFO - '--xperf_path', 05:48:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:10 INFO - 'tests': ['tp5n']}, 05:48:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:10 INFO - 'talos_options': ['--xperf_path', 05:48:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:10 INFO - 'tests': ['tp5n']}}, 05:48:10 INFO - 'talos.zip': {'path': '', 05:48:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:48:10 INFO - Running post-action listener: _resource_record_post_action 05:48:10 INFO - [mozharness: 2016-09-29 12:48:10.411740Z] Finished populate-webroot step (success) 05:48:10 INFO - [mozharness: 2016-09-29 12:48:10.411828Z] Running create-virtualenv step. 05:48:10 INFO - Running pre-action listener: _resource_record_pre_action 05:48:10 INFO - Running main action method: create_virtualenv 05:48:10 INFO - Creating virtualenv /builds/slave/test/build/venv 05:48:10 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 05:48:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:48:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:48:10 INFO - Using real prefix '/usr' 05:48:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:48:11 INFO - Installing distribute.............................................................................................................................................................................................done. 05:48:12 INFO - Installing pip.................done. 05:48:12 INFO - Return code: 0 05:48:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:48:13 INFO - Reading from file tmpfile_stdout 05:48:13 INFO - Output received: 05:48:13 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) 05:48:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:48:13 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')]} 05:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:13 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')]} 05:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:13 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 0x7fc19833cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d3f60>, '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 0x16d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d51d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', '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 05:48:13 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 05:48:13 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 05:48:13 INFO - Using env: {'DISPLAY': ':0', 05:48:13 INFO - 'HOME': '/home/cltbld', 05:48:13 INFO - 'LANG': 'en_US.UTF-8', 05:48:13 INFO - 'LANGUAGE': 'en_US:en', 05:48:13 INFO - 'LOGNAME': 'cltbld', 05:48:13 INFO - 'MAIL': '/var/mail/cltbld', 05:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:13 INFO - 'MOZ_NO_REMOTE': '1', 05:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:13 INFO - 'NO_EM_RESTART': '1', 05:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:13 INFO - 'PWD': '/builds/slave/test', 05:48:13 INFO - 'SHELL': '/bin/bash', 05:48:13 INFO - 'SHLVL': '1', 05:48:13 INFO - 'TERM': 'linux', 05:48:13 INFO - 'TMOUT': '86400', 05:48:13 INFO - 'USER': 'cltbld', 05:48:13 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', 05:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:13 INFO - '_': '/tools/buildbot/bin/python'} 05:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:13 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 05:48:13 INFO - Cleaning up... 05:48:13 INFO - Return code: 0 05:48:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:48:13 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')]} 05:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:13 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')]} 05:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:13 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 0x7fc19833cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d3f60>, '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 0x16d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d51d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', '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 05:48:13 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 05:48:13 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 05:48:13 INFO - Using env: {'DISPLAY': ':0', 05:48:13 INFO - 'HOME': '/home/cltbld', 05:48:13 INFO - 'LANG': 'en_US.UTF-8', 05:48:13 INFO - 'LANGUAGE': 'en_US:en', 05:48:13 INFO - 'LOGNAME': 'cltbld', 05:48:13 INFO - 'MAIL': '/var/mail/cltbld', 05:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:13 INFO - 'MOZ_NO_REMOTE': '1', 05:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:13 INFO - 'NO_EM_RESTART': '1', 05:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:13 INFO - 'PWD': '/builds/slave/test', 05:48:13 INFO - 'SHELL': '/bin/bash', 05:48:13 INFO - 'SHLVL': '1', 05:48:13 INFO - 'TERM': 'linux', 05:48:13 INFO - 'TMOUT': '86400', 05:48:13 INFO - 'USER': 'cltbld', 05:48:13 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', 05:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:13 INFO - '_': '/tools/buildbot/bin/python'} 05:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:13 INFO - Downloading/unpacking psutil>=3.1.1 05:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:48:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:15 INFO - Installing collected packages: psutil 05:48:15 INFO - Running setup.py install for psutil 05:48:15 INFO - building 'psutil._psutil_linux' extension 05:48:15 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 05:48:15 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 05:48:15 INFO - building 'psutil._psutil_posix' extension 05:48:15 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 05:48:16 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 05:48:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:16 INFO - Successfully installed psutil 05:48:16 INFO - Cleaning up... 05:48:16 INFO - Return code: 0 05:48:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:48:16 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')]} 05:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:16 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')]} 05:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:16 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 0x7fc19833cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d3f60>, '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 0x16d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d51d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', '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 05:48:16 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 05:48:16 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 05:48:16 INFO - Using env: {'DISPLAY': ':0', 05:48:16 INFO - 'HOME': '/home/cltbld', 05:48:16 INFO - 'LANG': 'en_US.UTF-8', 05:48:16 INFO - 'LANGUAGE': 'en_US:en', 05:48:16 INFO - 'LOGNAME': 'cltbld', 05:48:16 INFO - 'MAIL': '/var/mail/cltbld', 05:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:16 INFO - 'MOZ_NO_REMOTE': '1', 05:48:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:16 INFO - 'NO_EM_RESTART': '1', 05:48:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:16 INFO - 'PWD': '/builds/slave/test', 05:48:16 INFO - 'SHELL': '/bin/bash', 05:48:16 INFO - 'SHLVL': '1', 05:48:16 INFO - 'TERM': 'linux', 05:48:16 INFO - 'TMOUT': '86400', 05:48:16 INFO - 'USER': 'cltbld', 05:48:16 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', 05:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:16 INFO - '_': '/tools/buildbot/bin/python'} 05:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:48:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:48:18 INFO - Installing collected packages: mozsystemmonitor 05:48:18 INFO - Running setup.py install for mozsystemmonitor 05:48:18 INFO - Successfully installed mozsystemmonitor 05:48:18 INFO - Cleaning up... 05:48:18 INFO - Return code: 0 05:48:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:18 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 0x7fc19833cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d3f60>, '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 0x16d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d51d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', '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 05:48:18 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 05:48:18 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 05:48:18 INFO - Using env: {'DISPLAY': ':0', 05:48:18 INFO - 'HOME': '/home/cltbld', 05:48:18 INFO - 'LANG': 'en_US.UTF-8', 05:48:18 INFO - 'LANGUAGE': 'en_US:en', 05:48:18 INFO - 'LOGNAME': 'cltbld', 05:48:18 INFO - 'MAIL': '/var/mail/cltbld', 05:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:18 INFO - 'MOZ_NO_REMOTE': '1', 05:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:18 INFO - 'NO_EM_RESTART': '1', 05:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:18 INFO - 'PWD': '/builds/slave/test', 05:48:18 INFO - 'SHELL': '/bin/bash', 05:48:18 INFO - 'SHLVL': '1', 05:48:18 INFO - 'TERM': 'linux', 05:48:18 INFO - 'TMOUT': '86400', 05:48:18 INFO - 'USER': 'cltbld', 05:48:18 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', 05:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:18 INFO - '_': '/tools/buildbot/bin/python'} 05:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:18 INFO - Downloading/unpacking jsonschema==2.5.1 05:48:18 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 05:48:18 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 05:48:18 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 05:48:18 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 05:48:18 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 05:48:18 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 05:48:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:48:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:20 INFO - Downloading functools32-3.2.3-2.tar.gz 05:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:48:20 INFO - warning: no files found matching '*.txt' 05:48:20 INFO - no previously-included directories found matching 'build' 05:48:20 INFO - no previously-included directories found matching 'dist' 05:48:20 INFO - no previously-included directories found matching '.git*' 05:48:20 INFO - Installing collected packages: jsonschema, functools32 05:48:20 INFO - Running setup.py install for functools32 05:48:21 INFO - warning: no files found matching '*.txt' 05:48:21 INFO - no previously-included directories found matching 'build' 05:48:21 INFO - no previously-included directories found matching 'dist' 05:48:21 INFO - no previously-included directories found matching '.git*' 05:48:21 INFO - Successfully installed jsonschema functools32 05:48:21 INFO - Cleaning up... 05:48:21 INFO - Return code: 0 05:48:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc19833cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d3f60>, '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 0x16d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d51d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', '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 05:48:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:48:21 INFO - Using env: {'DISPLAY': ':0', 05:48:21 INFO - 'HOME': '/home/cltbld', 05:48:21 INFO - 'LANG': 'en_US.UTF-8', 05:48:21 INFO - 'LANGUAGE': 'en_US:en', 05:48:21 INFO - 'LOGNAME': 'cltbld', 05:48:21 INFO - 'MAIL': '/var/mail/cltbld', 05:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:21 INFO - 'MOZ_NO_REMOTE': '1', 05:48:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:21 INFO - 'NO_EM_RESTART': '1', 05:48:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:21 INFO - 'PWD': '/builds/slave/test', 05:48:21 INFO - 'SHELL': '/bin/bash', 05:48:21 INFO - 'SHLVL': '1', 05:48:21 INFO - 'TERM': 'linux', 05:48:21 INFO - 'TMOUT': '86400', 05:48:21 INFO - 'USER': 'cltbld', 05:48:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', 05:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:21 INFO - '_': '/tools/buildbot/bin/python'} 05:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:48:21 INFO - Cleaning up... 05:48:21 INFO - Return code: 0 05:48:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc19833cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d3f60>, '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 0x16d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d51d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', '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 05:48:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:48:21 INFO - Using env: {'DISPLAY': ':0', 05:48:21 INFO - 'HOME': '/home/cltbld', 05:48:21 INFO - 'LANG': 'en_US.UTF-8', 05:48:21 INFO - 'LANGUAGE': 'en_US:en', 05:48:21 INFO - 'LOGNAME': 'cltbld', 05:48:21 INFO - 'MAIL': '/var/mail/cltbld', 05:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:21 INFO - 'MOZ_NO_REMOTE': '1', 05:48:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:21 INFO - 'NO_EM_RESTART': '1', 05:48:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:21 INFO - 'PWD': '/builds/slave/test', 05:48:21 INFO - 'SHELL': '/bin/bash', 05:48:21 INFO - 'SHLVL': '1', 05:48:21 INFO - 'TERM': 'linux', 05:48:21 INFO - 'TMOUT': '86400', 05:48:21 INFO - 'USER': 'cltbld', 05:48:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', 05:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:21 INFO - '_': '/tools/buildbot/bin/python'} 05:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:21 INFO - Downloading/unpacking blobuploader==1.2.4 05:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:23 INFO - Downloading blobuploader-1.2.4.tar.gz 05:48:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:48:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:48:23 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 05:48:23 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 05:48:23 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 05:48:23 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 05:48:23 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 05:48:23 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 05:48:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:48:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:48:23 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 05:48:23 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 05:48:23 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 05:48:23 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 05:48:23 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 05:48:23 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 05:48:24 INFO - Downloading docopt-0.6.1.tar.gz 05:48:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:48:24 INFO - Installing collected packages: blobuploader, requests, docopt 05:48:24 INFO - Running setup.py install for blobuploader 05:48:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:48:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:48:24 INFO - Running setup.py install for requests 05:48:24 INFO - Running setup.py install for docopt 05:48:24 INFO - Successfully installed blobuploader requests docopt 05:48:24 INFO - Cleaning up... 05:48:24 INFO - Return code: 0 05:48:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:24 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 0x7fc19833cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d3f60>, '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 0x16d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d51d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', '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 05:48:24 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 05:48:24 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 05:48:24 INFO - Using env: {'DISPLAY': ':0', 05:48:24 INFO - 'HOME': '/home/cltbld', 05:48:24 INFO - 'LANG': 'en_US.UTF-8', 05:48:24 INFO - 'LANGUAGE': 'en_US:en', 05:48:24 INFO - 'LOGNAME': 'cltbld', 05:48:24 INFO - 'MAIL': '/var/mail/cltbld', 05:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:24 INFO - 'MOZ_NO_REMOTE': '1', 05:48:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:24 INFO - 'NO_EM_RESTART': '1', 05:48:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:24 INFO - 'PWD': '/builds/slave/test', 05:48:24 INFO - 'SHELL': '/bin/bash', 05:48:24 INFO - 'SHLVL': '1', 05:48:24 INFO - 'TERM': 'linux', 05:48:24 INFO - 'TMOUT': '86400', 05:48:24 INFO - 'USER': 'cltbld', 05:48:24 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', 05:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:24 INFO - '_': '/tools/buildbot/bin/python'} 05:48:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:48:25 INFO - Running setup.py (path:/tmp/pip-7CppTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:48:25 INFO - Running setup.py (path:/tmp/pip-ViXlsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:48:25 INFO - Running setup.py (path:/tmp/pip-GwDecP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:48:25 INFO - Running setup.py (path:/tmp/pip-a4ODWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:48:25 INFO - Running setup.py (path:/tmp/pip-MaOPp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:48:25 INFO - Running setup.py (path:/tmp/pip-Q9VpVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:48:25 INFO - Running setup.py (path:/tmp/pip-BESU_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:48:25 INFO - Running setup.py (path:/tmp/pip-lMP4NC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:48:25 INFO - Running setup.py (path:/tmp/pip-lJTogK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:48:25 INFO - Running setup.py (path:/tmp/pip-QAtN7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:48:25 INFO - Running setup.py (path:/tmp/pip-jpNF1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:48:25 INFO - Running setup.py (path:/tmp/pip-7HNxwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:48:25 INFO - Running setup.py (path:/tmp/pip-i8Ra0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:48:26 INFO - Running setup.py (path:/tmp/pip-u9V84q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:26 INFO - Running setup.py (path:/tmp/pip-c1SBd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:48:26 INFO - Running setup.py (path:/tmp/pip-yEPROk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:48:26 INFO - Running setup.py (path:/tmp/pip-PDROKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:48:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:48:26 INFO - Running setup.py install for manifestparser 05:48:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:48:26 INFO - Running setup.py install for mozcrash 05:48:26 INFO - Running setup.py install for mozdebug 05:48:26 INFO - Running setup.py install for mozdevice 05:48:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:48:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:48:26 INFO - Running setup.py install for mozfile 05:48:26 INFO - Running setup.py install for mozhttpd 05:48:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:48:26 INFO - Running setup.py install for mozinfo 05:48:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:48:27 INFO - Running setup.py install for mozInstall 05:48:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:48:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:48:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:48:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:48:27 INFO - Running setup.py install for mozleak 05:48:27 INFO - Running setup.py install for mozlog 05:48:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:48:27 INFO - Running setup.py install for moznetwork 05:48:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:48:27 INFO - Running setup.py install for mozprocess 05:48:27 INFO - Running setup.py install for mozprofile 05:48:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:48:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:48:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:48:27 INFO - Running setup.py install for mozrunner 05:48:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:48:27 INFO - Running setup.py install for mozscreenshot 05:48:27 INFO - Running setup.py install for moztest 05:48:27 INFO - Running setup.py install for mozversion 05:48:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:48:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:48:28 INFO - Cleaning up... 05:48:28 INFO - Return code: 0 05:48:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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')]} 05:48:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:28 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 0x7fc19833cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d3f60>, '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 0x16d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d51d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', '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 05:48:28 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 05:48:28 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 05:48:28 INFO - Using env: {'DISPLAY': ':0', 05:48:28 INFO - 'HOME': '/home/cltbld', 05:48:28 INFO - 'LANG': 'en_US.UTF-8', 05:48:28 INFO - 'LANGUAGE': 'en_US:en', 05:48:28 INFO - 'LOGNAME': 'cltbld', 05:48:28 INFO - 'MAIL': '/var/mail/cltbld', 05:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:28 INFO - 'MOZ_NO_REMOTE': '1', 05:48:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:28 INFO - 'NO_EM_RESTART': '1', 05:48:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:28 INFO - 'PWD': '/builds/slave/test', 05:48:28 INFO - 'SHELL': '/bin/bash', 05:48:28 INFO - 'SHLVL': '1', 05:48:28 INFO - 'TERM': 'linux', 05:48:28 INFO - 'TMOUT': '86400', 05:48:28 INFO - 'USER': 'cltbld', 05:48:28 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', 05:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:28 INFO - '_': '/tools/buildbot/bin/python'} 05:48:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:48:28 INFO - Running setup.py (path:/tmp/pip-zT1Z1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:48:28 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)) 05:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:48:28 INFO - Running setup.py (path:/tmp/pip-V7UUzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:48:28 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)) 05:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:48:28 INFO - Running setup.py (path:/tmp/pip-4Jz7nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:48:28 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)) 05:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:48:28 INFO - Running setup.py (path:/tmp/pip-gHVOqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:48:28 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)) 05:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:48:28 INFO - Running setup.py (path:/tmp/pip-LRqjlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:48:28 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)) 05:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:48:28 INFO - Running setup.py (path:/tmp/pip-jlsMwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:48:28 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)) 05:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:48:28 INFO - Running setup.py (path:/tmp/pip-xm_0Cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:48:28 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)) 05:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:48:28 INFO - Running setup.py (path:/tmp/pip-oyvIjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:48:28 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)) 05:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:48:28 INFO - Running setup.py (path:/tmp/pip-CeDlC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:48:28 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)) 05:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:48:28 INFO - Running setup.py (path:/tmp/pip-lCVCKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:48:29 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)) 05:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:48:29 INFO - Running setup.py (path:/tmp/pip-iruAh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:48:29 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)) 05:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:48:29 INFO - Running setup.py (path:/tmp/pip-xC0Hcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:48:29 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)) 05:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:48:29 INFO - Running setup.py (path:/tmp/pip-NPnGKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:48:29 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)) 05:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:48:29 INFO - Running setup.py (path:/tmp/pip-Jt6YQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:48:29 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)) 05:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:29 INFO - Running setup.py (path:/tmp/pip-0QJ60D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:29 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)) 05:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:48:29 INFO - Running setup.py (path:/tmp/pip-NwdYwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:48:29 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)) 05:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:48:29 INFO - Running setup.py (path:/tmp/pip-HT9aE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:48:29 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)) 05:48:29 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)) 05:48:29 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)) 05:48:29 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)) 05:48:29 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)) 05:48:29 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)) 05:48:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:31 INFO - Downloading blessings-1.6.tar.gz 05:48:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:48:31 INFO - Installing collected packages: blessings 05:48:31 INFO - Running setup.py install for blessings 05:48:31 INFO - Successfully installed blessings 05:48:31 INFO - Cleaning up... 05:48:31 INFO - Return code: 0 05:48:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:48:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:48:31 INFO - Reading from file tmpfile_stdout 05:48:31 INFO - Current package versions: 05:48:31 INFO - argparse == 1.2.1 05:48:31 INFO - blessings == 1.6 05:48:31 INFO - blobuploader == 1.2.4 05:48:31 INFO - docopt == 0.6.1 05:48:31 INFO - functools32 == 3.2.3-2 05:48:31 INFO - jsonschema == 2.5.1 05:48:31 INFO - manifestparser == 1.1 05:48:31 INFO - mozInstall == 1.12 05:48:31 INFO - mozcrash == 0.17 05:48:31 INFO - mozdebug == 0.1 05:48:31 INFO - mozdevice == 0.48 05:48:31 INFO - mozfile == 1.2 05:48:31 INFO - mozhttpd == 0.7 05:48:31 INFO - mozinfo == 0.9 05:48:31 INFO - mozleak == 0.1 05:48:31 INFO - mozlog == 3.4 05:48:31 INFO - moznetwork == 0.27 05:48:31 INFO - mozprocess == 0.23 05:48:31 INFO - mozprofile == 0.28 05:48:31 INFO - mozrunner == 6.12 05:48:31 INFO - mozscreenshot == 0.1 05:48:31 INFO - mozsystemmonitor == 0.3 05:48:31 INFO - moztest == 0.7 05:48:31 INFO - mozversion == 1.4 05:48:31 INFO - psutil == 3.1.1 05:48:31 INFO - requests == 1.2.3 05:48:31 INFO - wsgiref == 0.1.2 05:48:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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')]} 05:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:31 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 0x7fc19833cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d3f60>, '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 0x16d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d51d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', '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 05:48:31 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 05:48:31 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 05:48:31 INFO - Using env: {'DISPLAY': ':0', 05:48:31 INFO - 'HOME': '/home/cltbld', 05:48:31 INFO - 'LANG': 'en_US.UTF-8', 05:48:31 INFO - 'LANGUAGE': 'en_US:en', 05:48:31 INFO - 'LOGNAME': 'cltbld', 05:48:31 INFO - 'MAIL': '/var/mail/cltbld', 05:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:31 INFO - 'MOZ_NO_REMOTE': '1', 05:48:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:31 INFO - 'NO_EM_RESTART': '1', 05:48:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:31 INFO - 'PWD': '/builds/slave/test', 05:48:31 INFO - 'SHELL': '/bin/bash', 05:48:31 INFO - 'SHLVL': '1', 05:48:31 INFO - 'TERM': 'linux', 05:48:31 INFO - 'TMOUT': '86400', 05:48:31 INFO - 'USER': 'cltbld', 05:48:31 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', 05:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:31 INFO - '_': '/tools/buildbot/bin/python'} 05:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:32 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)) 05:48:32 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)) 05:48:32 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)) 05:48:32 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)) 05:48:32 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)) 05:48:32 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)) 05:48:32 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)) 05:48:32 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)) 05:48:32 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)) 05:48:32 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)) 05:48:32 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)) 05:48:32 INFO - Cleaning up... 05:48:32 INFO - Return code: 0 05:48:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:32 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 0x7fc19833cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d3f60>, '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 0x16d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d51d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', '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 05:48:32 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 05:48:32 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 05:48:32 INFO - Using env: {'DISPLAY': ':0', 05:48:32 INFO - 'HOME': '/home/cltbld', 05:48:32 INFO - 'LANG': 'en_US.UTF-8', 05:48:32 INFO - 'LANGUAGE': 'en_US:en', 05:48:32 INFO - 'LOGNAME': 'cltbld', 05:48:32 INFO - 'MAIL': '/var/mail/cltbld', 05:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:32 INFO - 'MOZ_NO_REMOTE': '1', 05:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:32 INFO - 'NO_EM_RESTART': '1', 05:48:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:32 INFO - 'PWD': '/builds/slave/test', 05:48:32 INFO - 'SHELL': '/bin/bash', 05:48:32 INFO - 'SHLVL': '1', 05:48:32 INFO - 'TERM': 'linux', 05:48:32 INFO - 'TMOUT': '86400', 05:48:32 INFO - 'USER': 'cltbld', 05:48:32 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', 05:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:32 INFO - '_': '/tools/buildbot/bin/python'} 05:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:48:32 INFO - Cleaning up... 05:48:32 INFO - Return code: 0 05:48:32 INFO - Running post-action listener: _resource_record_post_action 05:48:32 INFO - Running post-action listener: _start_resource_monitoring 05:48:32 INFO - Starting resource monitoring. 05:48:32 INFO - [mozharness: 2016-09-29 12:48:32.425186Z] Finished create-virtualenv step (success) 05:48:32 INFO - [mozharness: 2016-09-29 12:48:32.425695Z] Running install step. 05:48:32 INFO - Running pre-action listener: _resource_record_pre_action 05:48:32 INFO - Running main action method: install 05:48:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:48:32 INFO - Reading from file tmpfile_stdout 05:48:32 INFO - Detecting whether we're running mozinstall >=1.0... 05:48:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:48:32 INFO - Reading from file tmpfile_stdout 05:48:32 INFO - Output received: 05:48:32 INFO - Usage: mozinstall [options] installer 05:48:32 INFO - Options: 05:48:32 INFO - -h, --help show this help message and exit 05:48:32 INFO - -d DEST, --destination=DEST 05:48:32 INFO - Directory to install application into. [default: 05:48:32 INFO - "/builds/slave/test"] 05:48:32 INFO - --app=APP Application being installed. [default: firefox] 05:48:32 INFO - mkdir: /builds/slave/test/build/application 05:48:32 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'] 05:48:32 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 05:48:48 INFO - Reading from file tmpfile_stdout 05:48:48 INFO - Output received: 05:48:48 INFO - /builds/slave/test/build/application/firefox/firefox 05:48:48 INFO - Running post-action listener: _resource_record_post_action 05:48:48 INFO - [mozharness: 2016-09-29 12:48:48.848087Z] Finished install step (success) 05:48:48 INFO - [mozharness: 2016-09-29 12:48:48.848331Z] Running run-tests step. 05:48:48 INFO - Running pre-action listener: _resource_record_pre_action 05:48:48 INFO - Running main action method: run_tests 05:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:48:48 INFO - Python 2.7.3 05:48:48 INFO - Return code: 0 05:48:48 INFO - grabbing minidump binary from tooltool 05:48:48 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')]} 05:48:48 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 0x16d3f60>, '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 0x16d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d51d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:48:48 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 05:48:48 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 05:48:48 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 05:48:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:48:48 INFO - Return code: 0 05:48:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:48:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:48:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:48:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:48:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 05:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 05:48:48 INFO - Using env: {'DISPLAY': ':0', 05:48:48 INFO - 'HOME': '/home/cltbld', 05:48:48 INFO - 'LANG': 'en_US.UTF-8', 05:48:48 INFO - 'LANGUAGE': 'en_US:en', 05:48:48 INFO - 'LOGNAME': 'cltbld', 05:48:48 INFO - 'MAIL': '/var/mail/cltbld', 05:48:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:48:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:48 INFO - 'MOZ_NO_REMOTE': '1', 05:48:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:48:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:48 INFO - 'NO_EM_RESTART': '1', 05:48:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:48 INFO - 'PWD': '/builds/slave/test', 05:48:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:48:48 INFO - 'SHELL': '/bin/bash', 05:48:48 INFO - 'SHLVL': '1', 05:48:48 INFO - 'TERM': 'linux', 05:48:48 INFO - 'TMOUT': '86400', 05:48:48 INFO - 'USER': 'cltbld', 05:48:48 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907', 05:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:48 INFO - '_': '/tools/buildbot/bin/python'} 05:48:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 05:48:49 INFO - mozversion application_buildid: 20160929050519 05:48:49 INFO - mozversion application_changeset: 0f2c7b2a783bbc5954e93216e7cb3b396a78003e 05:48:49 INFO - mozversion application_display_name: Nightly 05:48:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:48:49 INFO - mozversion application_name: Firefox 05:48:49 INFO - mozversion application_remotingname: firefox 05:48:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:48:49 INFO - mozversion application_vendor: Mozilla 05:48:49 INFO - mozversion application_version: 52.0a1 05:48:49 INFO - mozversion platform_buildid: 20160929050519 05:48:49 INFO - mozversion platform_changeset: 0f2c7b2a783bbc5954e93216e7cb3b396a78003e 05:48:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:48:49 INFO - mozversion platform_version: 52.0a1 05:48:49 INFO - using testdate: 1475153329 05:48:49 INFO - actual date: 1475153329 05:48:49 INFO - starting webserver on 'localhost:43612' 05:48:49 INFO - SUITE-START | Running 2 tests 05:48:49 INFO - TEST-START | dromaeo_css 05:48:49 INFO - operating with platform_type : linux_ 05:48:49 INFO - Initialising browser for dromaeo_css test... 05:48:49 INFO - TEST-INFO | started process 25635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvcS3Z4/profile http://localhost:43612/getInfo.html) 05:48:53 INFO - PROCESS | 25635 | __metrics Screen width/height:1600/1200 05:48:53 INFO - PROCESS | 25635 | colorDepth:24 05:48:53 INFO - PROCESS | 25635 | Browser inner width/height: 1024/697 05:48:53 INFO - PROCESS | 25635 | __metrics 05:48:54 INFO - PROCESS | 25635 | 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" 05:48:54 INFO - PROCESS | 25635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:48:55 INFO - PROCESS | 25635 | console.error: PushService: 05:48:55 INFO - PROCESS | 25635 | stateChangeProcessEnqueue: Error transitioning state 05:48:55 INFO - PROCESS | 25635 | UnknownError 05:48:55 INFO - TEST-INFO | 25635: exit 0 05:48:55 INFO - Browser initialized. 05:48:55 INFO - Running cycle 1/1 for dromaeo_css test... 05:48:55 INFO - TEST-INFO | started process 25718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvcS3Z4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:08 INFO - PROCESS | 25718 | RSS: Main: 175271936 05:49:08 INFO - PROCESS | 25718 | 05:49:59 INFO - PROCESS | 25718 | 1475153399058 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] 05:52:12 INFO - PROCESS | 25718 | Cycle 1(1): loaded http://localhost:43612/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43612/tests/dromaeo/cssquery-ext.html) 05:52:13 INFO - PROCESS | 25718 | RSS: Main: 273739776 05:52:13 INFO - PROCESS | 25718 | 05:55:16 INFO - PROCESS | 25718 | Cycle 1(1): loaded http://localhost:43612/tests/dromaeo/cssquery-ext.html (next: http://localhost:43612/tests/dromaeo/cssquery-jquery.html) 05:55:16 INFO - PROCESS | 25718 | RSS: Main: 265625600 05:55:16 INFO - PROCESS | 25718 | 05:58:19 INFO - PROCESS | 25718 | Cycle 1(1): loaded http://localhost:43612/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43612/tests/dromaeo/cssquery-mootools.html) 05:58:19 INFO - PROCESS | 25718 | RSS: Main: 216739840 05:58:19 INFO - PROCESS | 25718 | 06:01:21 INFO - PROCESS | 25718 | Cycle 1(1): loaded http://localhost:43612/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43612/tests/dromaeo/cssquery-prototype.html) 06:01:22 INFO - PROCESS | 25718 | RSS: Main: 238391296 06:01:22 INFO - PROCESS | 25718 | 06:04:25 INFO - PROCESS | 25718 | Cycle 1(1): loaded http://localhost:43612/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43612/tests/dromaeo/cssquery-yui.html) 06:04:26 INFO - PROCESS | 25718 | RSS: Main: 220094464 06:04:26 INFO - PROCESS | 25718 | 06:07:29 INFO - PROCESS | 25718 | Cycle 1(1): loaded http://localhost:43612/tests/dromaeo/cssquery-yui.html (next: http://localhost:43612/tests/dromaeo/cssquery-dojo.html) 06:07:29 INFO - PROCESS | 25718 | RSS: Main: 307888128 06:07:29 INFO - PROCESS | 25718 | 06:07:29 INFO - PROCESS | 25718 | __start_tp_report 06:07:29 INFO - PROCESS | 25718 | _x_x_mozilla_page_load 06:07:29 INFO - PROCESS | 25718 | _x_x_mozilla_page_load_details 06:07:29 INFO - PROCESS | 25718 | |i|pagename|runs| 06:07:29 INFO - PROCESS | 25718 | |0;dojo.html;2548.541262572737;2579.6775403074616;2599.07732754872;2603.0368763557485;2617.908373206938;4529.162105010575;4633.2818413146015;4674.205385084535;4696.8121275149;4710.693804902683;4623.237165867637;4629.120467111255;4630.421197350332;4635.235186194274;4662.860114196571;4183.037901282699;4245.363195520666;4247.702660813744;4300.247456695066;4317.201317756209;4348.21732088224;4349.630281426083;4379.4525684289465;4392.604665580097;4433.5566443355565;4303.634191093761;4312.676549258803;4357.346398040288;4417;4429.867103986886;4382.386465894777;4388.275934470808;4393.362962370438;4434.9334759978465;4452.844150454751;4169.666426685888;4206.0326124991425;4220.53574106848;4257.446531950857;4313.266744653416;4570.10882877839;4583.472900616405;4602.424696912886;4679.321498382716;4733.526647335273;4922.926156107661;4954.355933728628;4962.528559786814;4970.055689418999;5018.372703412074;4784.449788274358;4831.710097394132;4987.102321582114;4988.152014157566;5044.571211447032;4626.259798432235;4669.322948172564;4678.742669153161;4682.906341873144;4685.109829132454;5094.949050509522;5124.052050370618;5140.357455318085;5141.151709967813;5187.818426355059;4697.13103075932;4731.976340118277;4909.680870743462;4920.237363208708;4983.202687569971;4929.433115191799;4966.627502937295;4973.875653108701;4978.253262010728;5021.924671129936;4892.633052521075;4917.680350777259;4924.679895806761;4925;4986.551210391082;4797.040591881568;4901.142300097468;4910.631702622318;4912.4350699669285;4967.726775027336;4183.267928112568;4226.366045093199;4236.9364459533135;4268.957310426856;4269.530351661315;3710.8330125143893;3723.0320116769835;3729.1236559408517;3754.662080412776;3785.356489396809;4314.22343978087;4315.3742707307265;4321.891952701208;4365.716228445141;4369.300911854088;4747.928781068286;4778.116048530964;4789.401324834395;4964.578010869117;5027.4721154279005;4251.979524914061;4328.761918094472;4341.848035318749;4343.609075183249;4356.760378179167;4518.88702782433;4522.276435770261;4523.932141017887;4526.253168227271;4578.40480737502;4671.953280467152;4696.319033740088;4701.318308845267;4723.787429565609;4761.95238047622;4860.3195552621955;4894.583960363409;4918.532739389752;4950.727709975986;4951.331570237971;4710.69380490267;4712.175369310288;4714.057188562369;4760.952390476189;4764.951710623657;4950.059488697136;4951.9752401237765;4956.553910148104;4959.107360675113;5065.670731402447;4861.246506791453;4911.140550403594;4924.901501970012;4925.408950925912;5070.746462676925;4809.422869255712;4833.854984350475;4844.588210002189;4885.90228195427;4900.8284710036405;4841.951580484291;4843.249296358929;4849.539293767087;4851.733154676385;4860.562549370574;4664.346991421272;4716.316134160596;4748.31149483316;4795.040991801584;4803.327534145153;4923.286123512143;4963.851084467472;4964.379452568429;5024.397072351341;5025.723585202702;4840.6127509799835;4847.75761211931;4850.345203397496;4913.238448040559;4914.311996320446 06:07:29 INFO - PROCESS | 25718 | |1;ext.html;570.1760955419418;571.7370009795494;578.881329327488;583.1165783837486;593.1666009256995;28197.15408537742;38300.425493617586;39416;39428.605713942816;43584.3462348065;40059.59940400595;40432.19135617293;40479.19041619166;40479.797601012026;40503.39244911321;7591.544507329578;7735.1491335953;7739.57432341221;7742.187070357616;7744.148143704188;7500;7569.167391586949;7574.280443357872;7585.2414758524255;7586.431017673696;7605.8478830423355;7649.847003059936;7650.3497202737835;7655.655495502716;7658.2724641159;7570.886436703454;7609.6575654095695;7620.771376858731;7621;7622.5426474411715;7500.699972001114;7569.545827250383;7571.167171611119;7572.318491335806;7576.4317676174505;38106.80946595277;38239.80880095582;38457;38508.14918508127;38519.61480385188;3190.2821865080405;3391.101358140095;3454.2055327274616;3681.1901381696252;3682.0794801299676;28154.436911261866;28218.858905705547;28314.2921426966;28410.857945710344;29801.10596682103;3138.5606015157896;3229.5155726640955;3243.2054146733967;3246.2858171202533;3248.2853772170083;242271;243612;244463.33135020922;244872;245533.772331139;51439.742801286506;51864.22203666948;51887.2216916739;51893.7405312971;51986.22020669693;32275.51586726201;33087;33233.501497477555;34833.65166348355;34883.65116348804;14294.28528573588;14447.205403702897;14455.710885782435;14457.349419276157;14461;10672.946635266773;10731.892681073245;10733.570657173781;10740;10743.51654175564;17790.555236119202;17810.287588496572;17863.642727145645;17890.821091789177;17993.550161246072;6672.933270667231;6817.897731534031;6841.726330946806;6890.276520965226;6982.266861979419;740.7777666700076;800.9799755006171;815.8164413007026;852.2500199824239;1014.2393205096178;27319.590206146924;27532.862335688194;27726.445471090465;28041;28052.71947280501;911.8039621481413;927.188709878856;937.6249500199974;965.7633879699519;985.6205360936091;13844.30778461073;14433.566992990227;14730.55808325752;14992.850071499146;15051.247437628075;383100;387151;387289;387369;388536;49763.75118124386;50397.24404133941;50403.49596503988;50412.24381634279;50414;1042.551702767802;1056.2025670618634;1129.4578602270792;1160.3907948327196;1173.9178257522062;27276.72723272742;28898;29428.55857162187;29753.702462975092;29943.55084673688;41327.38008929808;41605.37591936184;41761.58238417577;41909.161816764106;41949.370759438025;298929;301254;302475;302921;303408;22226.333210003726;22257.332280031624;22602.95364297524;22842;24862.12982545602;36796.81601591975;40095;40414.79792601018;40520.594794051685;40780.59219407768;34618;34857;35249.1187720309;35276.82361588176;35370.29259414746;34430.13924651803;34474.31051378908;34523;34583.65416345804;34709;34568.65431345755;34724.65275347214;35330.58677652865;35489.46765798567;35673;29988.250293742833;31414.528782068744;31631;31739;32562.348753025282;23811;23813.285601431984;24556.386090347885;24568.754312456647;25543 06:07:29 INFO - PROCESS | 25718 | |2;jquery.html;344.8775684631954;356.6754253629198;356.8483394557313;368.6387340406403;374.6366024955792;15430.382784688612;16401.83598164018;17260.309587616513;17313.220905059272;17336.653266934652;16514.174291285417;16633.334666613322;16873;16890.915545422286;17026.404075857346;4806.158922188621;5045.949540504585;5047.570956468705;5051.191809310511;5051.898962020758;3698.33429982603;3881.3401721707237;5000.424951130612;5650.208970744099;5907.793227237047;6022.367651396606;6024.698765061751;6026.186464827258;6027.9095813562835;6031.276246850384;5685.260916080903;5788.5658575606785;5802.390748971339;5804.158397032406;5819.185314056035;4937.703737775709;5088.109580823341;5092.159793634046;5093.261477085839;5095.082885080684;20418.387448376572;20518.794812051987;20760.5847883043;20772.169113235454;20780.792192078035;1754.8596112310984;1846.8984205868671;1877.8028307027703;2147.720796296487;2320.3540703167637;12424.56514022014;12936.48254069836;13085.934570327183;13173;13486.932565337209;1659.4109091272667;1678.471281546309;1788.552861784554;1789.7046987247088;1799.9550011249692;43963.78018109921;66793;67644;67770.32229677739;68633.65683171603;8788.472691638523;8858.601362938683;9179.127982841619;9208.26333893287;9437.858432123523;12155.5137794489;12333.50665973369;12347.62957111288;12351.6912077197;12452.937735311447;6653.900191497131;6960.303969602999;7156.141263048467;7335.4131669466315;7424.294692004251;6904.067950826675;7002.159740831031;7014.824629384204;7142.035825163641;7183.245759195313;5619.634723742944;5741.942580574224;5758.856028599319;5819.912701309484;5878;1475.2107622421952;1541.5067178502773;1612.6613411183782;1626.0487614745507;1698.150924537731;792.4334101117729;807.8263173417625;838.2497664590157;876.4872549558452;915.4598786715869;16025.19874006295;16857.662846743;16900.323987040625;16931.746023809654;17772.733408998876;803.867361885294;809.6761295481855;852.109545524928;869.860822268434;910.9706032183723;9416.858747118798;10016.699499015042;10082.344647597884;10094.545745441474;10219.284650074424;377600;385750;386818;386988;391410;66049;66819.33180668228;67112.66443667847;67427;70272;923.690563661181;958.324381311174;962.5668449197889;973.4791886340773;984.3552473130111;15041.247937603295;15154.545363638668;15449;15589.766153507933;15993.600159996093;34151;34759.47860782141;34976.82511587426;35187.82406087953;35894.461583075754;44622.55377446184;44930.77534612306;45459.090818184115;45753;45961;5822.446867547576;5896.380880007709;7145.678444470115;7212.764043146642;7605.315521603082;11581.768364632491;11597.88402115968;11658.825117623073;11734.765304694029;11886.16796824214;9717.951410242904;9846.409215447096;10366;10456.738581535523;10740.785184296114;9974.301798874008;10245.180385569285;10367.118794902217;10498.215303398594;10672.733181670521;9707.417554946725;9903.702888913343;10064.748381290527;10156.949215253877;10513.474326283502;7624.428167887319;7721.343685786771;7832.490888092256;7847.450678452454;7871.252231038042;9586.66446674363;10110.443925584164;10111.848322275024;10254.794904102026;10404.687859363929 06:07:29 INFO - PROCESS | 25718 | |3;mootools.html;1338.9665258368543;1378.2901805570132;1445.8265008199019;1647.1210299744096;1654.239050036983;7202.783916482507;7774.961125194381;7784.571848548328;7784.987951566295;7802.531848089105;6352.110704501373;6533.803985880431;7041.366277035066;7236.131664200303;7275.672594733236;2039.255671679841;2049.1905697249576;2063.9690404643943;2066.08059413561;2068.2967790951075;2048.3138148720195;2084.551236890362;2091.7699053104225;2104.5054412213117;2124.097258665061;1820.817918208182;1879.5583037986062;2058.4956685612046;2114.693369461427;2135.145941623355;2103.7159983402353;2109.7257356543705;2129.4995676016124;2131.7868213178713;2135.572885422906;2121.6287149748887;2125.691774692661;2128.095559387254;2130.392838041166;2136.529963408048;7501.549907005598;7740.109887362969;7748.535087894688;7766.18455062216;7767.805804854867;4431.844885429026;4497.055618320157;4563.452385713703;4566.06395688883;4572.657050721209;2753.518134326505;2813.479506291322;2848.5584734366207;2871.138658402471;2880.769538436941;872.8079822439116;894.1237587164616;926.1618235496886;926.305271046715;932.8227636748996;10212.897871021269;10222.9488852556;10231.130353919925;10243.948780256125;10262.332948358408;3693.7045036397026;3856.73002889795;3905.882823515299;3983.521977362735;3986.5216174059296;8855.822883542292;8856;8856.38005339633;8857.734267971971;8880.289576833839;4528.0943811237885;4533.569310915458;4534.36518887356;4539.046800172001;4543.114092751882;4096.366319652202;4112.362583799516;4127.752334859918;4142.502899652061;4147.585241475888;3595.5685317762036;3628.8911332660064;3696.149885526344;3722.236941427001;3813.828377723009;1195.6831439668322;1195.838561794164;1199.3883119609063;1208.0637505932796;1231.876812318761;624.6907780648608;641.900505421651;710.7690000749777;744.914334851499;756.4553521464537;4645.790939407735;4722.598579120813;4793.257045158006;4853.9029219415415;4883.436195997059;826.98346033079;843.3590471241778;855.362754747717;856.5203486047833;876.588003638289;3152.338009018086;3230.2570408806105;3251.219707270285;3257.446234140202;3347.9497807532907;8979.820403592023;9405.388649737883;9520.285978551497;9520.571574279174;9522.90477095234;9444.52777361143;9461.574229159703;9467.195288400562;9472.336936414385;9474.431534107976;6954.4436445084275;7146.821329466701;7220.602866842374;7221.31397517235;7236.819079523054;4582.427196600425;4611.146937816515;4739.952600473951;4775.808967641395;4883.95116048835;8334.49993000422;8386.748397548083;8578.099299573454;8607.612657430305;8614.310855131449;8611.397202196036;8748.737537873874;8753.781155471164;8868.866966995629;8953.238974687225;6327.145835312174;6410.1025856381075;6410.551261411843;6411.807645770635;6414.486841052798;7080.044194033945;7104.573725576482;7142.535735177197;7152.070230870162;7176.4258859290085;5945.940540594539;5959;5965.135055417027;6071.726772295169;6235.875282494416;6301.275353334425;6345.0482427636225;6377.521685873671;6407.967960160356;6515.869682606416;5542.3903370630005;5719.170720245625;5719.428057194247;5769.567282453749;5876.412358764261;4249.745015299092;4313.892152696208;4364.781760912006;4450.221211287947;4571.51999040096;4280.445738938532;4285.5928686774705;4318.9352159717;4338.674599404994;4470.798814053311 06:07:29 INFO - PROCESS | 25718 | |4;prototype.html;267.2383706436655;268.7661734291167;271.45979500793425;278.7992645295387;281.04724982309983;4642.535746425364;4735.976320118394;4813.494583068776;4819.891424972254;4875.634327425444;4607.470140933794;4721.881952951178;4747.382840230765;4752.954350042994;4771.618270538357;3702.741068036867;3724.478572999769;3727.1427571658533;3730.519204728852;3736.6823819975266;3521.38375784238;3724.4971928789537;3726.7887936420634;3727.869524566627;3739.7195210359196;3414.4024795660785;3654.835532401035;3672.7429079964413;3679.6872265857432;3694.1503454205413;3664.6701796838147;3666.7999200479767;3681.5582130144285;3682.3739964206147;3695.8891233263043;3225.9676903390923;3229.1765599772143;3229.8223597702117;3231.5475833383343;3243.9026829195163;4595.333676616905;4604.424446944132;4608.423947006624;4721.102990431841;4736.478987311393;4169.145325208356;4182.895427614334;4186.1836941796055;4187.623113919732;4190.8533201337805;4984.22744474607;4989.226669866177;4989.276554899519;4993;4998.8250411235795;3511.1924257420937;3535.6641119093647;3536.1866770642637;3538.2569660371355;3567.7324200684793;5071.442141364447;5125.410577783528;5179.326687530597;5228.2680424740565;5255.343082114736;3458.9450217683343;3480.946241717348;3481;3484.9719332796885;3504.9474257886154;3532.7566994957874;3534.717222622184;3535.9469607955903;3541.451075083366;3543.875964341236;3927.8821635350987;4111.8560850370095;4117.114820313647;4135.110951145518;4135.379693046068;5005.249212618136;5028.396592408862;5030.924536131961;5043.5965122790085;5047.798088076509;1162.9011534019535;1179.823026546025;1226.3929354969348;1237.616338934933;1240.9317487538272;796.4026979765176;814.5601375257413;817.7587611654576;824.4599787139433;830.543201239316;4349.673774466928;4368.148211098805;4372.213001659668;4379.474463064453;4394.989152494944;5119.769610367543;5124.846254612367;5128.205128205134;5137.332146820964;5148.176291793295;4194.895127621834;4324.372965919987;4345.847895323648;4354.194474022316;4360.65114790816;2695.908157196339;2705.6482657254433;2712.443948990452;2724.223596275052;2727.3999720061556;4796.537056197823;4810.302506136591;4814.927776083362;4819.783109759999;4820.6261215553395;4992.600591952635;5154.8969020620125;5190.8183213587345;5191.454897235812;5222.764975576109;4756.167670657552;4758.1443237136855;4776.617870570346;4783.675345634751;4783.823360371092;5101.158308878993;5116.9232461512365;5123.513266239701;5129.153689641316;5131.846044618667;4836.347093142522;4935.531124543163;4974.825881094144;5017;5033;4768.233095854236;4778.546038126373;4778.904421911473;4789.994101238779;4797.160496913096;3469.548958635462;3497.4229252173104;3508.245727168671;3530.258645684435;3531.947020794639;4975;5144.125498665311;5164.147915593885;5216.869578260574;5220.216967454912;5018.723970181675;5070.467600901852;5084;5090.49095090488;5093.911496286505;5064.4935506449065;5070.645054846125;5083.796648134181;5088.363954505687;5092.516210959953;4765;4782.402199725035;4939.333190019302;4994.80020799164;5029.899402012013;4926.48271931442;5006.945763084443;5087.643864929568;5109.514596113363;5113.948860511347;4965.354503914613;4972.900541989212;4977.352944117241;4977.651564390458;5003.649744517848 06:07:29 INFO - PROCESS | 25718 | |5;yui.html;629.9559030867838;634.6223996721951;648.7080813633863;653.6372313366081;720.5352547606797;12391.44238509267;13658.863411365883;13679;13712.451501939922;13787.241701706402;13147.802782958262;13318.267495287755;13334;13341.1995280283;13347.599572012856;617.45663815842;635.3582881289884;742.1873049011351;754.4417131322823;765.8276887700279;767.8272388712523;768.5158350239342;769.0041396391658;769.6421164158666;770.1451388958252;819.72948926854;820.2044017303207;820.3683163963744;821.4537332673794;821.5399376349234;647.1425361396145;662.4766434516725;767.6161919040479;784.0395515493532;787.263908245792;586.6890548009562;588.417466707956;589.0163427076792;589.3046205477535;589.5342679283361;12075.637730868088;12076.698082547919;12104.757904841941;12129.818052729217;12131.575394861226;12101.939490302491;12238.632841014783;12326.75346493065;12640.115191936567;12889.742205155844;10292.125169360539;10356;10590.78818423635;10660.147188224923;10796.730081748019;4049.574794646549;4107.568705285962;4181.205570941512;4262.637675797561;4293.806778694966;57916.71041644765;61043;61296.08055879121;61423;61452;9605.423674579408;9788.314817962675;9807.31348805591;9817.312788104764;9849;16998.830011699723;17003.829961700223;17030.74453883168;17032.914835425992;17044.744328835077;6594.910471243336;6685.76599819004;6795.762148324785;6834.111565496453;6891.5865048096275;3485.128717820545;3614.5120408744483;3644.1982763791925;3652.244930480828;3761.962380376216;2764.4609301186074;2898.434805212963;2899.362140329124;3136.2159460134967;3300.1254667513126;538.6606437944071;539.7235537952791;540.9594280428984;551.2282804074327;551.8841043380854;548.3611592494699;595.2678205806795;612.6569121292091;622.3092367472102;635.3011687144196;7649.770506884803;8004.399670024772;8015;8175.509469431853;8367.205115514016;523.7224271136304;607.9817605471843;619.2970977939981;622.2470810319473;629.4995478594528;4033.253848038122;4134.896627584274;4152.626263636287;4295.183915056129;4329.9134017319475;97690;98352.50823745978;99176.50411747895;101573.49213253887;102041.48979255056;82713.17286827175;83752.58123709343;86004;86574;88145;55564.72217638967;73796.63101684458;78999;79476;79973;7707.653155607899;8208.630611622611;8277.668893244443;8372.330213582776;8411.957940210259;41552;45209.77395113003;45225.32162017506;45652.771736141105;45778;38939.6106038936;43058.138837222454;51977.344644348574;65439.34560654333;66802.33197668155;11268.887311126784;11435.828462573234;11596.304221746723;11671.12466564994;11823.113266504875;11662.358570278717;12184.695382615506;13413.731725365244;13457.125286856322;14064.718705625626;11213.66359009231;11951.641450756491;12253.326067066397;12429.875701242872;13239.13945593572;12102.818457722966;12199.268043917038;12267;12343.938280308541;13074.542391016268;10775;11080.445977701243;11284;11459.828102578635;12182.14724969279;10240.692779216635;10275.126614237575;10419.739506512398;10783.946080269548;11142.944285278521;10816.729581760519;10924.7268818277;10953.507092180711;10989;11079.113670906469 06:07:29 INFO - PROCESS | 25718 | __end_tp_report 06:07:29 INFO - PROCESS | 25718 | __start_cc_report 06:07:29 INFO - PROCESS | 25718 | _x_x_mozilla_cycle_collect,859 06:07:29 INFO - PROCESS | 25718 | __end_cc_report 06:07:29 INFO - PROCESS | 25718 | __startTimestamp1475154449346__endTimestamp 06:07:29 INFO - PROCESS | 25718 | 06:07:29 INFO - PROCESS | 25718 | ------- Summary: start ------- 06:07:29 INFO - PROCESS | 25718 | Number of tests: 6 06:07:29 INFO - PROCESS | 25718 | 06:07:29 INFO - PROCESS | 25718 | [#0] dojo.html Cycles:165 Average:4609.60 Median:4716.32 stddev:471.43 (10.0%) stddev-sans-first:444.29 06:07:29 INFO - PROCESS | 25718 | Values: 2548.5 2579.7 2599.1 2603.0 2617.9 4529.2 4633.3 4674.2 4696.8 4710.7 4623.2 4629.1 4630.4 4635.2 4662.9 4183.0 4245.4 4247.7 4300.2 4317.2 4348.2 4349.6 4379.5 4392.6 4433.6 4303.6 4312.7 4357.3 4417.0 4429.9 4382.4 4388.3 4393.4 4434.9 4452.8 4169.7 4206.0 4220.5 4257.4 4313.3 4570.1 4583.5 4602.4 4679.3 4733.5 4922.9 4954.4 4962.5 4970.1 5018.4 4784.4 4831.7 4987.1 4988.2 5044.6 4626.3 4669.3 4678.7 4682.9 4685.1 5094.9 5124.1 5140.4 5141.2 5187.8 4697.1 4732.0 4909.7 4920.2 4983.2 4929.4 4966.6 4973.9 4978.3 5021.9 4892.6 4917.7 4924.7 4925.0 4986.6 4797.0 4901.1 4910.6 4912.4 4967.7 4183.3 4226.4 4236.9 4269.0 4269.5 3710.8 3723.0 3729.1 3754.7 3785.4 4314.2 4315.4 4321.9 4365.7 4369.3 4747.9 4778.1 4789.4 4964.6 5027.5 4252.0 4328.8 4341.8 4343.6 4356.8 4518.9 4522.3 4523.9 4526.3 4578.4 4672.0 4696.3 4701.3 4723.8 4762.0 4860.3 4894.6 4918.5 4950.7 4951.3 4710.7 4712.2 4714.1 4761.0 4765.0 4950.1 4952.0 4956.6 4959.1 5065.7 4861.2 4911.1 4924.9 4925.4 5070.7 4809.4 4833.9 4844.6 4885.9 4900.8 4842.0 4843.2 4849.5 4851.7 4860.6 4664.3 4716.3 4748.3 4795.0 4803.3 4923.3 4963.9 4964.4 5024.4 5025.7 4840.6 4847.8 4850.3 4913.2 4914.3 06:07:29 INFO - PROCESS | 25718 | 06:07:29 INFO - PROCESS | 25718 | [#1] ext.html Cycles:180 Average:45781.58 Median:35303.71 stddev:83302.06 (236.0%) stddev-sans-first:83466.58 06:07:29 INFO - PROCESS | 25718 | Values: 570.2 571.7 578.9 583.1 593.2 28197.2 38300.4 39416.0 39428.6 43584.3 40059.6 40432.2 40479.2 40479.8 40503.4 7591.5 7735.1 7739.6 7742.2 7744.1 7500.0 7569.2 7574.3 7585.2 7586.4 7605.8 7649.8 7650.3 7655.7 7658.3 7570.9 7609.7 7620.8 7621.0 7622.5 7500.7 7569.5 7571.2 7572.3 7576.4 38106.8 38239.8 38457.0 38508.1 38519.6 3190.3 3391.1 3454.2 3681.2 3682.1 28154.4 28218.9 28314.3 28410.9 29801.1 3138.6 3229.5 3243.2 3246.3 3248.3 242271.0 243612.0 244463.3 244872.0 245533.8 51439.7 51864.2 51887.2 51893.7 51986.2 32275.5 33087.0 33233.5 34833.7 34883.7 14294.3 14447.2 14455.7 14457.3 14461.0 10672.9 10731.9 10733.6 10740.0 10743.5 17790.6 17810.3 17863.6 17890.8 17993.6 6672.9 6817.9 6841.7 6890.3 6982.3 740.8 801.0 815.8 852.3 1014.2 27319.6 27532.9 27726.4 28041.0 28052.7 911.8 927.2 937.6 965.8 985.6 13844.3 14433.6 14730.6 14992.9 15051.2 383100.0 387151.0 387289.0 387369.0 388536.0 49763.8 50397.2 50403.5 50412.2 50414.0 1042.6 1056.2 1129.5 1160.4 1173.9 27276.7 28898.0 29428.6 29753.7 29943.6 41327.4 41605.4 41761.6 41909.2 41949.4 298929.0 301254.0 302475.0 302921.0 303408.0 22226.3 22257.3 22603.0 22842.0 24862.1 36796.8 40095.0 40414.8 40520.6 40780.6 34618.0 34857.0 35249.1 35276.8 35370.3 34430.1 34474.3 34523.0 34583.7 34709.0 34568.7 34724.7 35330.6 35489.5 35673.0 29988.3 31414.5 31631.0 31739.0 32562.3 23811.0 23813.3 24556.4 24568.8 25543.0 06:07:29 INFO - PROCESS | 25718 | 06:07:29 INFO - PROCESS | 25718 | [#2] jquery.html Cycles:180 Average:23594.20 Median:44293.17 stddev:63338.16 (143.0%) stddev-sans-first:63491.78 06:07:29 INFO - PROCESS | 25718 | Values: 344.9 356.7 356.8 368.6 374.6 15430.4 16401.8 17260.3 17313.2 17336.7 16514.2 16633.3 16873.0 16890.9 17026.4 4806.2 5045.9 5047.6 5051.2 5051.9 3698.3 3881.3 5000.4 5650.2 5907.8 6022.4 6024.7 6026.2 6027.9 6031.3 5685.3 5788.6 5802.4 5804.2 5819.2 4937.7 5088.1 5092.2 5093.3 5095.1 20418.4 20518.8 20760.6 20772.2 20780.8 1754.9 1846.9 1877.8 2147.7 2320.4 12424.6 12936.5 13085.9 13173.0 13486.9 1659.4 1678.5 1788.6 1789.7 1800.0 43963.8 66793.0 67644.0 67770.3 68633.7 8788.5 8858.6 9179.1 9208.3 9437.9 12155.5 12333.5 12347.6 12351.7 12452.9 6653.9 6960.3 7156.1 7335.4 7424.3 6904.1 7002.2 7014.8 7142.0 7183.2 5619.6 5741.9 5758.9 5819.9 5878.0 1475.2 1541.5 1612.7 1626.0 1698.2 792.4 807.8 838.2 876.5 915.5 16025.2 16857.7 16900.3 16931.7 17772.7 803.9 809.7 852.1 869.9 911.0 9416.9 10016.7 10082.3 10094.5 10219.3 377600.0 385750.0 386818.0 386988.0 391410.0 66049.0 66819.3 67112.7 67427.0 70272.0 923.7 958.3 962.6 973.5 984.4 15041.2 15154.5 15449.0 15589.8 15993.6 34151.0 34759.5 34976.8 35187.8 35894.5 44622.6 44930.8 45459.1 45753.0 45961.0 5822.4 5896.4 7145.7 7212.8 7605.3 11581.8 11597.9 11658.8 11734.8 11886.2 9718.0 9846.4 10366.0 10456.7 10740.8 9974.3 10245.2 10367.1 10498.2 10672.7 9707.4 9903.7 10064.7 10156.9 10513.5 7624.4 7721.3 7832.5 7847.5 7871.3 9586.7 10110.4 10111.8 10254.8 10404.7 06:07:29 INFO - PROCESS | 25718 | 06:07:29 INFO - PROCESS | 25718 | [#3] mootools.html Cycles:180 Average:4915.72 Median:4784.53 stddev:2774.72 (58.0%) stddev-sans-first:2769.49 06:07:29 INFO - PROCESS | 25718 | Values: 1339.0 1378.3 1445.8 1647.1 1654.2 7202.8 7775.0 7784.6 7785.0 7802.5 6352.1 6533.8 7041.4 7236.1 7275.7 2039.3 2049.2 2064.0 2066.1 2068.3 2048.3 2084.6 2091.8 2104.5 2124.1 1820.8 1879.6 2058.5 2114.7 2135.1 2103.7 2109.7 2129.5 2131.8 2135.6 2121.6 2125.7 2128.1 2130.4 2136.5 7501.5 7740.1 7748.5 7766.2 7767.8 4431.8 4497.1 4563.5 4566.1 4572.7 2753.5 2813.5 2848.6 2871.1 2880.8 872.8 894.1 926.2 926.3 932.8 10212.9 10222.9 10231.1 10243.9 10262.3 3693.7 3856.7 3905.9 3983.5 3986.5 8855.8 8856.0 8856.4 8857.7 8880.3 4528.1 4533.6 4534.4 4539.0 4543.1 4096.4 4112.4 4127.8 4142.5 4147.6 3595.6 3628.9 3696.1 3722.2 3813.8 1195.7 1195.8 1199.4 1208.1 1231.9 624.7 641.9 710.8 744.9 756.5 4645.8 4722.6 4793.3 4853.9 4883.4 827.0 843.4 855.4 856.5 876.6 3152.3 3230.3 3251.2 3257.4 3347.9 8979.8 9405.4 9520.3 9520.6 9522.9 9444.5 9461.6 9467.2 9472.3 9474.4 6954.4 7146.8 7220.6 7221.3 7236.8 4582.4 4611.1 4740.0 4775.8 4884.0 8334.5 8386.7 8578.1 8607.6 8614.3 8611.4 8748.7 8753.8 8868.9 8953.2 6327.1 6410.1 6410.6 6411.8 6414.5 7080.0 7104.6 7142.5 7152.1 7176.4 5945.9 5959.0 5965.1 6071.7 6235.9 6301.3 6345.0 6377.5 6408.0 6515.9 5542.4 5719.2 5719.4 5769.6 5876.4 4249.7 4313.9 4364.8 4450.2 4571.5 4280.4 4285.6 4318.9 4338.7 4470.8 06:07:29 INFO - PROCESS | 25718 | 06:07:29 INFO - PROCESS | 25718 | [#4] prototype.html Cycles:180 Average:4118.93 Median:4754.56 stddev:1221.11 (25.7%) stddev-sans-first:1189.82 06:07:29 INFO - PROCESS | 25718 | Values: 267.2 268.8 271.5 278.8 281.0 4642.5 4736.0 4813.5 4819.9 4875.6 4607.5 4721.9 4747.4 4753.0 4771.6 3702.7 3724.5 3727.1 3730.5 3736.7 3521.4 3724.5 3726.8 3727.9 3739.7 3414.4 3654.8 3672.7 3679.7 3694.2 3664.7 3666.8 3681.6 3682.4 3695.9 3226.0 3229.2 3229.8 3231.5 3243.9 4595.3 4604.4 4608.4 4721.1 4736.5 4169.1 4182.9 4186.2 4187.6 4190.9 4984.2 4989.2 4989.3 4993.0 4998.8 3511.2 3535.7 3536.2 3538.3 3567.7 5071.4 5125.4 5179.3 5228.3 5255.3 3458.9 3480.9 3481.0 3485.0 3504.9 3532.8 3534.7 3535.9 3541.5 3543.9 3927.9 4111.9 4117.1 4135.1 4135.4 5005.2 5028.4 5030.9 5043.6 5047.8 1162.9 1179.8 1226.4 1237.6 1240.9 796.4 814.6 817.8 824.5 830.5 4349.7 4368.1 4372.2 4379.5 4395.0 5119.8 5124.8 5128.2 5137.3 5148.2 4194.9 4324.4 4345.8 4354.2 4360.7 2695.9 2705.6 2712.4 2724.2 2727.4 4796.5 4810.3 4814.9 4819.8 4820.6 4992.6 5154.9 5190.8 5191.5 5222.8 4756.2 4758.1 4776.6 4783.7 4783.8 5101.2 5116.9 5123.5 5129.2 5131.8 4836.3 4935.5 4974.8 5017.0 5033.0 4768.2 4778.5 4778.9 4790.0 4797.2 3469.5 3497.4 3508.2 3530.3 3531.9 4975.0 5144.1 5164.1 5216.9 5220.2 5018.7 5070.5 5084.0 5090.5 5093.9 5064.5 5070.6 5083.8 5088.4 5092.5 4765.0 4782.4 4939.3 4994.8 5029.9 4926.5 5006.9 5087.6 5109.5 5113.9 4965.4 4972.9 4977.4 4977.7 5003.6 06:07:29 INFO - PROCESS | 25718 | 06:07:29 INFO - PROCESS | 25718 | [#5] yui.html Cycles:180 Average:17554.65 Median:45217.55 stddev:25161.28 (55.6%) stddev-sans-first:25199.77 06:07:29 INFO - PROCESS | 25718 | Values: 630.0 634.6 648.7 653.6 720.5 12391.4 13658.9 13679.0 13712.5 13787.2 13147.8 13318.3 13334.0 13341.2 13347.6 617.5 635.4 742.2 754.4 765.8 767.8 768.5 769.0 769.6 770.1 819.7 820.2 820.4 821.5 821.5 647.1 662.5 767.6 784.0 787.3 586.7 588.4 589.0 589.3 589.5 12075.6 12076.7 12104.8 12129.8 12131.6 12101.9 12238.6 12326.8 12640.1 12889.7 10292.1 10356.0 10590.8 10660.1 10796.7 4049.6 4107.6 4181.2 4262.6 4293.8 57916.7 61043.0 61296.1 61423.0 61452.0 9605.4 9788.3 9807.3 9817.3 9849.0 16998.8 17003.8 17030.7 17032.9 17044.7 6594.9 6685.8 6795.8 6834.1 6891.6 3485.1 3614.5 3644.2 3652.2 3762.0 2764.5 2898.4 2899.4 3136.2 3300.1 538.7 539.7 541.0 551.2 551.9 548.4 595.3 612.7 622.3 635.3 7649.8 8004.4 8015.0 8175.5 8367.2 523.7 608.0 619.3 622.2 629.5 4033.3 4134.9 4152.6 4295.2 4329.9 97690.0 98352.5 99176.5 101573.5 102041.5 82713.2 83752.6 86004.0 86574.0 88145.0 55564.7 73796.6 78999.0 79476.0 79973.0 7707.7 8208.6 8277.7 8372.3 8412.0 41552.0 45209.8 45225.3 45652.8 45778.0 38939.6 43058.1 51977.3 65439.3 66802.3 11268.9 11435.8 11596.3 11671.1 11823.1 11662.4 12184.7 13413.7 13457.1 14064.7 11213.7 11951.6 12253.3 12429.9 13239.1 12102.8 12199.3 12267.0 12343.9 13074.5 10775.0 11080.4 11284.0 11459.8 12182.1 10240.7 10275.1 10419.7 10783.9 11142.9 10816.7 10924.7 10953.5 10989.0 11079.1 06:07:29 INFO - PROCESS | 25718 | -------- Summary: end -------- 06:07:29 INFO - PROCESS | 25718 | 06:07:30 INFO - TEST-INFO | 25718: exit 0 06:07:30 INFO - TEST-OK | dromaeo_css | took 1121133ms 06:07:30 INFO - TEST-START | kraken 06:07:30 INFO - operating with platform_type : linux_ 06:07:30 INFO - Initialising browser for kraken test... 06:07:30 INFO - TEST-INFO | started process 26022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXKNRcv/profile http://localhost:43612/getInfo.html) 06:07:34 INFO - PROCESS | 26022 | __metrics Screen width/height:1600/1200 06:07:34 INFO - PROCESS | 26022 | colorDepth:24 06:07:34 INFO - PROCESS | 26022 | Browser inner width/height: 1024/697 06:07:34 INFO - PROCESS | 26022 | __metrics 06:07:35 INFO - PROCESS | 26022 | 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" 06:07:35 INFO - PROCESS | 26022 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:07:35 INFO - PROCESS | 26022 | console.error: PushService: 06:07:35 INFO - PROCESS | 26022 | stateChangeProcessEnqueue: Error transitioning state 06:07:35 INFO - PROCESS | 26022 | UnknownError 06:07:36 INFO - TEST-INFO | 26022: exit 0 06:07:36 INFO - Browser initialized. 06:07:36 INFO - Running cycle 1/1 for kraken test... 06:07:36 INFO - TEST-INFO | started process 26106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXKNRcv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:07:48 INFO - PROCESS | 26106 | RSS: Main: 175820800 06:07:48 INFO - PROCESS | 26106 | 06:07:51 INFO - PROCESS | 26106 | Cycle 1(1): loaded http://localhost:43612/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43612/tests/kraken/driver.html?testName=audio-beat-detection) 06:07:52 INFO - PROCESS | 26106 | RSS: Main: 234594304 06:07:52 INFO - PROCESS | 26106 | 06:07:55 INFO - PROCESS | 26106 | Cycle 1(1): loaded http://localhost:43612/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43612/tests/kraken/driver.html?testName=audio-dft) 06:07:56 INFO - PROCESS | 26106 | RSS: Main: 219054080 06:07:56 INFO - PROCESS | 26106 | 06:07:59 INFO - PROCESS | 26106 | Cycle 1(1): loaded http://localhost:43612/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43612/tests/kraken/driver.html?testName=audio-fft) 06:07:59 INFO - PROCESS | 26106 | RSS: Main: 300867584 06:07:59 INFO - PROCESS | 26106 | 06:08:02 INFO - PROCESS | 26106 | Cycle 1(1): loaded http://localhost:43612/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43612/tests/kraken/driver.html?testName=audio-oscillator) 06:08:02 INFO - PROCESS | 26106 | RSS: Main: 210808832 06:08:02 INFO - PROCESS | 26106 | 06:08:04 INFO - PROCESS | 26106 | Cycle 1(1): loaded http://localhost:43612/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43612/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:08:05 INFO - PROCESS | 26106 | RSS: Main: 214085632 06:08:05 INFO - PROCESS | 26106 | 06:08:08 INFO - PROCESS | 26106 | Cycle 1(1): loaded http://localhost:43612/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43612/tests/kraken/driver.html?testName=imaging-darkroom) 06:08:09 INFO - PROCESS | 26106 | RSS: Main: 251183104 06:08:09 INFO - PROCESS | 26106 | 06:08:12 INFO - PROCESS | 26106 | Cycle 1(1): loaded http://localhost:43612/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43612/tests/kraken/driver.html?testName=imaging-desaturate) 06:08:13 INFO - PROCESS | 26106 | RSS: Main: 245297152 06:08:13 INFO - PROCESS | 26106 | 06:08:16 INFO - PROCESS | 26106 | Cycle 1(1): loaded http://localhost:43612/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43612/tests/kraken/driver.html?testName=json-parse-financial) 06:08:17 INFO - PROCESS | 26106 | RSS: Main: 247771136 06:08:17 INFO - PROCESS | 26106 | 06:08:18 INFO - PROCESS | 26106 | Cycle 1(1): loaded http://localhost:43612/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43612/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:08:19 INFO - PROCESS | 26106 | RSS: Main: 211238912 06:08:19 INFO - PROCESS | 26106 | 06:08:21 INFO - PROCESS | 26106 | Cycle 1(1): loaded http://localhost:43612/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43612/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:08:21 INFO - PROCESS | 26106 | RSS: Main: 219054080 06:08:21 INFO - PROCESS | 26106 | 06:08:24 INFO - PROCESS | 26106 | Cycle 1(1): loaded http://localhost:43612/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43612/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:08:24 INFO - PROCESS | 26106 | RSS: Main: 222175232 06:08:24 INFO - PROCESS | 26106 | 06:08:27 INFO - PROCESS | 26106 | Cycle 1(1): loaded http://localhost:43612/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43612/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:08:28 INFO - PROCESS | 26106 | RSS: Main: 218271744 06:08:28 INFO - PROCESS | 26106 | 06:08:31 INFO - PROCESS | 26106 | Cycle 1(1): loaded http://localhost:43612/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43612/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:08:31 INFO - PROCESS | 26106 | RSS: Main: 221851648 06:08:31 INFO - PROCESS | 26106 | 06:08:33 INFO - PROCESS | 26106 | Cycle 1(1): loaded http://localhost:43612/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43612/tests/kraken/driver.html?testName=ai-astar) 06:08:33 INFO - PROCESS | 26106 | RSS: Main: 272560128 06:08:33 INFO - PROCESS | 26106 | 06:08:33 INFO - PROCESS | 26106 | __start_tp_report 06:08:33 INFO - PROCESS | 26106 | _x_x_mozilla_page_load 06:08:33 INFO - PROCESS | 26106 | _x_x_mozilla_page_load_details 06:08:33 INFO - PROCESS | 26106 | |i|pagename|runs| 06:08:33 INFO - PROCESS | 26106 | |0;ai-astar;112;118;117;117;117;117;115;116;117;117 06:08:33 INFO - PROCESS | 26106 | |1;audio-beat-detection;155;123;122;166;126;129;130;129;162;124 06:08:33 INFO - PROCESS | 26106 | |2;audio-dft;161;161;161;163;161;161;163;161;162;161 06:08:33 INFO - PROCESS | 26106 | |3;audio-fft;76;78;77;103;77;77;76;76;114;76 06:08:33 INFO - PROCESS | 26106 | |4;audio-oscillator;85;84;117;84;83;84;107;83;83;116 06:08:33 INFO - PROCESS | 26106 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;118;117 06:08:33 INFO - PROCESS | 26106 | |6;imaging-darkroom;147;147;146;146;148;147;148;148;148;148 06:08:33 INFO - PROCESS | 26106 | |7;imaging-desaturate;96;95;95;95;95;95;95;94;95;95 06:08:33 INFO - PROCESS | 26106 | |8;json-parse-financial;64;63;63;63;64;64;64;65;65;65 06:08:33 INFO - PROCESS | 26106 | |9;json-stringify-tinderbox;66;66;65;66;68;65;67;65;66;66 06:08:33 INFO - PROCESS | 26106 | |10;stanford-crypto-aes;89;85;85;82;83;82;83;83;83;82 06:08:33 INFO - PROCESS | 26106 | |11;stanford-crypto-ccm;143;134;137;132;141;134;136;134;187;146 06:08:33 INFO - PROCESS | 26106 | |12;stanford-crypto-pbkdf2;171;169;172;171;176;175;178;176;176;174 06:08:33 INFO - PROCESS | 26106 | |13;stanford-crypto-sha256-iterative;69;72;69;68;67;67;67;68;67;68 06:08:33 INFO - PROCESS | 26106 | __end_tp_report 06:08:33 INFO - PROCESS | 26106 | __start_cc_report 06:08:33 INFO - PROCESS | 26106 | _x_x_mozilla_cycle_collect,1980 06:08:33 INFO - PROCESS | 26106 | __end_cc_report 06:08:33 INFO - PROCESS | 26106 | __startTimestamp1475154513808__endTimestamp 06:08:33 INFO - PROCESS | 26106 | 06:08:33 INFO - PROCESS | 26106 | ------- Summary: start ------- 06:08:33 INFO - PROCESS | 26106 | Number of tests: 14 06:08:33 INFO - PROCESS | 26106 | 06:08:33 INFO - PROCESS | 26106 | [#0] ai-astar Cycles:10 Average:116.30 Median:117.00 stddev:1.70 (1.5%) stddev-sans-first:0.83 06:08:33 INFO - PROCESS | 26106 | Values: 112.0 118.0 117.0 117.0 117.0 117.0 115.0 116.0 117.0 117.0 06:08:33 INFO - PROCESS | 26106 | 06:08:33 INFO - PROCESS | 26106 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:129.50 stddev:17.24 (13.3%) stddev-sans-first:16.96 06:08:33 INFO - PROCESS | 26106 | Values: 155.0 123.0 122.0 166.0 126.0 129.0 130.0 129.0 162.0 124.0 06:08:33 INFO - PROCESS | 26106 | 06:08:33 INFO - PROCESS | 26106 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 06:08:33 INFO - PROCESS | 26106 | Values: 161.0 161.0 161.0 163.0 161.0 161.0 163.0 161.0 162.0 161.0 06:08:33 INFO - PROCESS | 26106 | 06:08:33 INFO - PROCESS | 26106 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.50 stddev:13.70 (17.9%) stddev-sans-first:14.30 06:08:33 INFO - PROCESS | 26106 | Values: 76.0 78.0 77.0 103.0 77.0 77.0 76.0 76.0 114.0 76.0 06:08:33 INFO - PROCESS | 26106 | 06:08:33 INFO - PROCESS | 26106 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:83.50 stddev:14.55 (17.4%) stddev-sans-first:15.17 06:08:33 INFO - PROCESS | 26106 | Values: 85.0 84.0 117.0 84.0 83.0 84.0 107.0 83.0 83.0 116.0 06:08:33 INFO - PROCESS | 26106 | 06:08:33 INFO - PROCESS | 26106 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:08:33 INFO - PROCESS | 26106 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 06:08:33 INFO - PROCESS | 26106 | 06:08:33 INFO - PROCESS | 26106 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 06:08:33 INFO - PROCESS | 26106 | Values: 147.0 147.0 146.0 146.0 148.0 147.0 148.0 148.0 148.0 148.0 06:08:33 INFO - PROCESS | 26106 | 06:08:33 INFO - PROCESS | 26106 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 06:08:33 INFO - PROCESS | 26106 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 06:08:33 INFO - PROCESS | 26106 | 06:08:33 INFO - PROCESS | 26106 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 06:08:33 INFO - PROCESS | 26106 | Values: 64.0 63.0 63.0 63.0 64.0 64.0 64.0 65.0 65.0 65.0 06:08:33 INFO - PROCESS | 26106 | 06:08:33 INFO - PROCESS | 26106 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.94 (1.4%) stddev-sans-first:1.00 06:08:33 INFO - PROCESS | 26106 | Values: 66.0 66.0 65.0 66.0 68.0 65.0 67.0 65.0 66.0 66.0 06:08:33 INFO - PROCESS | 26106 | 06:08:33 INFO - PROCESS | 26106 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:2.16 (2.6%) stddev-sans-first:1.17 06:08:33 INFO - PROCESS | 26106 | Values: 89.0 85.0 85.0 82.0 83.0 82.0 83.0 83.0 83.0 82.0 06:08:33 INFO - PROCESS | 26106 | 06:08:33 INFO - PROCESS | 26106 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:139.00 stddev:16.31 (11.7%) stddev-sans-first:17.30 06:08:33 INFO - PROCESS | 26106 | Values: 143.0 134.0 137.0 132.0 141.0 134.0 136.0 134.0 187.0 146.0 06:08:33 INFO - PROCESS | 26106 | 06:08:33 INFO - PROCESS | 26106 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:175.50 stddev:2.90 (1.7%) stddev-sans-first:2.89 06:08:33 INFO - PROCESS | 26106 | Values: 171.0 169.0 172.0 171.0 176.0 175.0 178.0 176.0 176.0 174.0 06:08:33 INFO - PROCESS | 26106 | 06:08:33 INFO - PROCESS | 26106 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.55 (2.3%) stddev-sans-first:1.62 06:08:33 INFO - PROCESS | 26106 | Values: 69.0 72.0 69.0 68.0 67.0 67.0 67.0 68.0 67.0 68.0 06:08:33 INFO - PROCESS | 26106 | -------- Summary: end -------- 06:08:33 INFO - PROCESS | 26106 | 06:08:35 INFO - TEST-INFO | 26106: exit 0 06:08:35 INFO - TEST-OK | kraken | took 64989ms 06:08:35 INFO - SUITE-END | took 1186s 06:08:35 INFO - Completed test suite (00:19:46) 06:08:35 INFO - javascript benchmark 06:08:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2548.541262572737, 2579.6775403074616, 2599.07732754872, 2603.0368763557485, 2617.908373206938, 4529.162105010575, 4633.2818413146015, 4674.205385084535, 4696.8121275149, 4710.693804902683, 4623.237165867637, 4629.120467111255, 4630.421197350332, 4635.235186194274, 4662.860114196571, 4183.037901282699, 4245.363195520666, 4247.702660813744, 4300.247456695066, 4317.201317756209, 4348.21732088224, 4349.630281426083, 4379.4525684289465, 4392.604665580097, 4433.5566443355565, 4303.634191093761, 4312.676549258803, 4357.346398040288, 4417.0, 4429.867103986886, 4382.386465894777, 4388.275934470808, 4393.362962370438, 4434.9334759978465, 4452.844150454751, 4169.666426685888, 4206.0326124991425, 4220.53574106848, 4257.446531950857, 4313.266744653416, 4570.10882877839, 4583.472900616405, 4602.424696912886, 4679.321498382716, 4733.526647335273, 4922.926156107661, 4954.355933728628, 4962.528559786814, 4970.055689418999, 5018.372703412074, 4784.449788274358, 4831.710097394132, 4987.102321582114, 4988.152014157566, 5044.571211447032, 4626.259798432235, 4669.322948172564, 4678.742669153161, 4682.906341873144, 4685.109829132454, 5094.949050509522, 5124.052050370618, 5140.357455318085, 5141.151709967813, 5187.818426355059, 4697.13103075932, 4731.976340118277, 4909.680870743462, 4920.237363208708, 4983.202687569971, 4929.433115191799, 4966.627502937295, 4973.875653108701, 4978.253262010728, 5021.924671129936, 4892.633052521075, 4917.680350777259, 4924.679895806761, 4925.0, 4986.551210391082, 4797.040591881568, 4901.142300097468, 4910.631702622318, 4912.4350699669285, 4967.726775027336, 4183.267928112568, 4226.366045093199, 4236.9364459533135, 4268.957310426856, 4269.530351661315, 3710.8330125143893, 3723.0320116769835, 3729.1236559408517, 3754.662080412776, 3785.356489396809, 4314.22343978087, 4315.3742707307265, 4321.891952701208, 4365.716228445141, 4369.300911854088, 4747.928781068286, 4778.116048530964, 4789.401324834395, 4964.578010869117, 5027.4721154279005, 4251.979524914061, 4328.761918094472, 4341.848035318749, 4343.609075183249, 4356.760378179167, 4518.88702782433, 4522.276435770261, 4523.932141017887, 4526.253168227271, 4578.40480737502, 4671.953280467152, 4696.319033740088, 4701.318308845267, 4723.787429565609, 4761.95238047622, 4860.3195552621955, 4894.583960363409, 4918.532739389752, 4950.727709975986, 4951.331570237971, 4710.69380490267, 4712.175369310288, 4714.057188562369, 4760.952390476189, 4764.951710623657, 4950.059488697136, 4951.9752401237765, 4956.553910148104, 4959.107360675113, 5065.670731402447, 4861.246506791453, 4911.140550403594, 4924.901501970012, 4925.408950925912, 5070.746462676925, 4809.422869255712, 4833.854984350475, 4844.588210002189, 4885.90228195427, 4900.8284710036405, 4841.951580484291, 4843.249296358929, 4849.539293767087, 4851.733154676385, 4860.562549370574, 4664.346991421272, 4716.316134160596, 4748.31149483316, 4795.040991801584, 4803.327534145153, 4923.286123512143, 4963.851084467472, 4964.379452568429, 5024.397072351341, 5025.723585202702, 4840.6127509799835, 4847.75761211931, 4850.345203397496, 4913.238448040559, 4914.311996320446], "value": 4579.8639988582045, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.1760955419418, 571.7370009795494, 578.881329327488, 583.1165783837486, 593.1666009256995, 28197.15408537742, 38300.425493617586, 39416.0, 39428.605713942816, 43584.3462348065, 40059.59940400595, 40432.19135617293, 40479.19041619166, 40479.797601012026, 40503.39244911321, 7591.544507329578, 7735.1491335953, 7739.57432341221, 7742.187070357616, 7744.148143704188, 7500.0, 7569.167391586949, 7574.280443357872, 7585.2414758524255, 7586.431017673696, 7605.8478830423355, 7649.847003059936, 7650.3497202737835, 7655.655495502716, 7658.2724641159, 7570.886436703454, 7609.6575654095695, 7620.771376858731, 7621.0, 7622.5426474411715, 7500.699972001114, 7569.545827250383, 7571.167171611119, 7572.318491335806, 7576.4317676174505, 38106.80946595277, 38239.80880095582, 38457.0, 38508.14918508127, 38519.61480385188, 3190.2821865080405, 3391.101358140095, 3454.2055327274616, 3681.1901381696252, 3682.0794801299676, 28154.436911261866, 28218.858905705547, 28314.2921426966, 28410.857945710344, 29801.10596682103, 3138.5606015157896, 3229.5155726640955, 3243.2054146733967, 3246.2858171202533, 3248.2853772170083, 242271.0, 243612.0, 244463.33135020922, 244872.0, 245533.772331139, 51439.742801286506, 51864.22203666948, 51887.2216916739, 51893.7405312971, 51986.22020669693, 32275.51586726201, 33087.0, 33233.501497477555, 34833.65166348355, 34883.65116348804, 14294.28528573588, 14447.205403702897, 14455.710885782435, 14457.349419276157, 14461.0, 10672.946635266773, 10731.892681073245, 10733.570657173781, 10740.0, 10743.51654175564, 17790.555236119202, 17810.287588496572, 17863.642727145645, 17890.821091789177, 17993.550161246072, 6672.933270667231, 6817.897731534031, 6841.726330946806, 6890.276520965226, 6982.266861979419, 740.7777666700076, 800.9799755006171, 815.8164413007026, 852.2500199824239, 1014.2393205096178, 27319.590206146924, 27532.862335688194, 27726.445471090465, 28041.0, 28052.71947280501, 911.8039621481413, 927.188709878856, 937.6249500199974, 965.7633879699519, 985.6205360936091, 13844.30778461073, 14433.566992990227, 14730.55808325752, 14992.850071499146, 15051.247437628075, 383100.0, 387151.0, 387289.0, 387369.0, 388536.0, 49763.75118124386, 50397.24404133941, 50403.49596503988, 50412.24381634279, 50414.0, 1042.551702767802, 1056.2025670618634, 1129.4578602270792, 1160.3907948327196, 1173.9178257522062, 27276.72723272742, 28898.0, 29428.55857162187, 29753.702462975092, 29943.55084673688, 41327.38008929808, 41605.37591936184, 41761.58238417577, 41909.161816764106, 41949.370759438025, 298929.0, 301254.0, 302475.0, 302921.0, 303408.0, 22226.333210003726, 22257.332280031624, 22602.95364297524, 22842.0, 24862.12982545602, 36796.81601591975, 40095.0, 40414.79792601018, 40520.594794051685, 40780.59219407768, 34618.0, 34857.0, 35249.1187720309, 35276.82361588176, 35370.29259414746, 34430.13924651803, 34474.31051378908, 34523.0, 34583.65416345804, 34709.0, 34568.65431345755, 34724.65275347214, 35330.58677652865, 35489.46765798567, 35673.0, 29988.250293742833, 31414.528782068744, 31631.0, 31739.0, 32562.348753025282, 23811.0, 23813.285601431984, 24556.386090347885, 24568.754312456647, 25543.0], "value": 16935.962853835703, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.8775684631954, 356.6754253629198, 356.8483394557313, 368.6387340406403, 374.6366024955792, 15430.382784688612, 16401.83598164018, 17260.309587616513, 17313.220905059272, 17336.653266934652, 16514.174291285417, 16633.334666613322, 16873.0, 16890.915545422286, 17026.404075857346, 4806.158922188621, 5045.949540504585, 5047.570956468705, 5051.191809310511, 5051.898962020758, 3698.33429982603, 3881.3401721707237, 5000.424951130612, 5650.208970744099, 5907.793227237047, 6022.367651396606, 6024.698765061751, 6026.186464827258, 6027.9095813562835, 6031.276246850384, 5685.260916080903, 5788.5658575606785, 5802.390748971339, 5804.158397032406, 5819.185314056035, 4937.703737775709, 5088.109580823341, 5092.159793634046, 5093.261477085839, 5095.082885080684, 20418.387448376572, 20518.794812051987, 20760.5847883043, 20772.169113235454, 20780.792192078035, 1754.8596112310984, 1846.8984205868671, 1877.8028307027703, 2147.720796296487, 2320.3540703167637, 12424.56514022014, 12936.48254069836, 13085.934570327183, 13173.0, 13486.932565337209, 1659.4109091272667, 1678.471281546309, 1788.552861784554, 1789.7046987247088, 1799.9550011249692, 43963.78018109921, 66793.0, 67644.0, 67770.32229677739, 68633.65683171603, 8788.472691638523, 8858.601362938683, 9179.127982841619, 9208.26333893287, 9437.858432123523, 12155.5137794489, 12333.50665973369, 12347.62957111288, 12351.6912077197, 12452.937735311447, 6653.900191497131, 6960.303969602999, 7156.141263048467, 7335.4131669466315, 7424.294692004251, 6904.067950826675, 7002.159740831031, 7014.824629384204, 7142.035825163641, 7183.245759195313, 5619.634723742944, 5741.942580574224, 5758.856028599319, 5819.912701309484, 5878.0, 1475.2107622421952, 1541.5067178502773, 1612.6613411183782, 1626.0487614745507, 1698.150924537731, 792.4334101117729, 807.8263173417625, 838.2497664590157, 876.4872549558452, 915.4598786715869, 16025.19874006295, 16857.662846743, 16900.323987040625, 16931.746023809654, 17772.733408998876, 803.867361885294, 809.6761295481855, 852.109545524928, 869.860822268434, 910.9706032183723, 9416.858747118798, 10016.699499015042, 10082.344647597884, 10094.545745441474, 10219.284650074424, 377600.0, 385750.0, 386818.0, 386988.0, 391410.0, 66049.0, 66819.33180668228, 67112.66443667847, 67427.0, 70272.0, 923.690563661181, 958.324381311174, 962.5668449197889, 973.4791886340773, 984.3552473130111, 15041.247937603295, 15154.545363638668, 15449.0, 15589.766153507933, 15993.600159996093, 34151.0, 34759.47860782141, 34976.82511587426, 35187.82406087953, 35894.461583075754, 44622.55377446184, 44930.77534612306, 45459.090818184115, 45753.0, 45961.0, 5822.446867547576, 5896.380880007709, 7145.678444470115, 7212.764043146642, 7605.315521603082, 11581.768364632491, 11597.88402115968, 11658.825117623073, 11734.765304694029, 11886.16796824214, 9717.951410242904, 9846.409215447096, 10366.0, 10456.738581535523, 10740.785184296114, 9974.301798874008, 10245.180385569285, 10367.118794902217, 10498.215303398594, 10672.733181670521, 9707.417554946725, 9903.702888913343, 10064.748381290527, 10156.949215253877, 10513.474326283502, 7624.428167887319, 7721.343685786771, 7832.490888092256, 7847.450678452454, 7871.252231038042, 9586.66446674363, 10110.443925584164, 10111.848322275024, 10254.794904102026, 10404.687859363929], "value": 8152.966346294933, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.9665258368543, 1378.2901805570132, 1445.8265008199019, 1647.1210299744096, 1654.239050036983, 7202.783916482507, 7774.961125194381, 7784.571848548328, 7784.987951566295, 7802.531848089105, 6352.110704501373, 6533.803985880431, 7041.366277035066, 7236.131664200303, 7275.672594733236, 2039.255671679841, 2049.1905697249576, 2063.9690404643943, 2066.08059413561, 2068.2967790951075, 2048.3138148720195, 2084.551236890362, 2091.7699053104225, 2104.5054412213117, 2124.097258665061, 1820.817918208182, 1879.5583037986062, 2058.4956685612046, 2114.693369461427, 2135.145941623355, 2103.7159983402353, 2109.7257356543705, 2129.4995676016124, 2131.7868213178713, 2135.572885422906, 2121.6287149748887, 2125.691774692661, 2128.095559387254, 2130.392838041166, 2136.529963408048, 7501.549907005598, 7740.109887362969, 7748.535087894688, 7766.18455062216, 7767.805804854867, 4431.844885429026, 4497.055618320157, 4563.452385713703, 4566.06395688883, 4572.657050721209, 2753.518134326505, 2813.479506291322, 2848.5584734366207, 2871.138658402471, 2880.769538436941, 872.8079822439116, 894.1237587164616, 926.1618235496886, 926.305271046715, 932.8227636748996, 10212.897871021269, 10222.9488852556, 10231.130353919925, 10243.948780256125, 10262.332948358408, 3693.7045036397026, 3856.73002889795, 3905.882823515299, 3983.521977362735, 3986.5216174059296, 8855.822883542292, 8856.0, 8856.38005339633, 8857.734267971971, 8880.289576833839, 4528.0943811237885, 4533.569310915458, 4534.36518887356, 4539.046800172001, 4543.114092751882, 4096.366319652202, 4112.362583799516, 4127.752334859918, 4142.502899652061, 4147.585241475888, 3595.5685317762036, 3628.8911332660064, 3696.149885526344, 3722.236941427001, 3813.828377723009, 1195.6831439668322, 1195.838561794164, 1199.3883119609063, 1208.0637505932796, 1231.876812318761, 624.6907780648608, 641.900505421651, 710.7690000749777, 744.914334851499, 756.4553521464537, 4645.790939407735, 4722.598579120813, 4793.257045158006, 4853.9029219415415, 4883.436195997059, 826.98346033079, 843.3590471241778, 855.362754747717, 856.5203486047833, 876.588003638289, 3152.338009018086, 3230.2570408806105, 3251.219707270285, 3257.446234140202, 3347.9497807532907, 8979.820403592023, 9405.388649737883, 9520.285978551497, 9520.571574279174, 9522.90477095234, 9444.52777361143, 9461.574229159703, 9467.195288400562, 9472.336936414385, 9474.431534107976, 6954.4436445084275, 7146.821329466701, 7220.602866842374, 7221.31397517235, 7236.819079523054, 4582.427196600425, 4611.146937816515, 4739.952600473951, 4775.808967641395, 4883.95116048835, 8334.49993000422, 8386.748397548083, 8578.099299573454, 8607.612657430305, 8614.310855131449, 8611.397202196036, 8748.737537873874, 8753.781155471164, 8868.866966995629, 8953.238974687225, 6327.145835312174, 6410.1025856381075, 6410.551261411843, 6411.807645770635, 6414.486841052798, 7080.044194033945, 7104.573725576482, 7142.535735177197, 7152.070230870162, 7176.4258859290085, 5945.940540594539, 5959.0, 5965.135055417027, 6071.726772295169, 6235.875282494416, 6301.275353334425, 6345.0482427636225, 6377.521685873671, 6407.967960160356, 6515.869682606416, 5542.3903370630005, 5719.170720245625, 5719.428057194247, 5769.567282453749, 5876.412358764261, 4249.745015299092, 4313.892152696208, 4364.781760912006, 4450.221211287947, 4571.51999040096, 4280.445738938532, 4285.5928686774705, 4318.9352159717, 4338.674599404994, 4470.798814053311], "value": 3957.5110264810573, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [267.2383706436655, 268.7661734291167, 271.45979500793425, 278.7992645295387, 281.04724982309983, 4642.535746425364, 4735.976320118394, 4813.494583068776, 4819.891424972254, 4875.634327425444, 4607.470140933794, 4721.881952951178, 4747.382840230765, 4752.954350042994, 4771.618270538357, 3702.741068036867, 3724.478572999769, 3727.1427571658533, 3730.519204728852, 3736.6823819975266, 3521.38375784238, 3724.4971928789537, 3726.7887936420634, 3727.869524566627, 3739.7195210359196, 3414.4024795660785, 3654.835532401035, 3672.7429079964413, 3679.6872265857432, 3694.1503454205413, 3664.6701796838147, 3666.7999200479767, 3681.5582130144285, 3682.3739964206147, 3695.8891233263043, 3225.9676903390923, 3229.1765599772143, 3229.8223597702117, 3231.5475833383343, 3243.9026829195163, 4595.333676616905, 4604.424446944132, 4608.423947006624, 4721.102990431841, 4736.478987311393, 4169.145325208356, 4182.895427614334, 4186.1836941796055, 4187.623113919732, 4190.8533201337805, 4984.22744474607, 4989.226669866177, 4989.276554899519, 4993.0, 4998.8250411235795, 3511.1924257420937, 3535.6641119093647, 3536.1866770642637, 3538.2569660371355, 3567.7324200684793, 5071.442141364447, 5125.410577783528, 5179.326687530597, 5228.2680424740565, 5255.343082114736, 3458.9450217683343, 3480.946241717348, 3481.0, 3484.9719332796885, 3504.9474257886154, 3532.7566994957874, 3534.717222622184, 3535.9469607955903, 3541.451075083366, 3543.875964341236, 3927.8821635350987, 4111.8560850370095, 4117.114820313647, 4135.110951145518, 4135.379693046068, 5005.249212618136, 5028.396592408862, 5030.924536131961, 5043.5965122790085, 5047.798088076509, 1162.9011534019535, 1179.823026546025, 1226.3929354969348, 1237.616338934933, 1240.9317487538272, 796.4026979765176, 814.5601375257413, 817.7587611654576, 824.4599787139433, 830.543201239316, 4349.673774466928, 4368.148211098805, 4372.213001659668, 4379.474463064453, 4394.989152494944, 5119.769610367543, 5124.846254612367, 5128.205128205134, 5137.332146820964, 5148.176291793295, 4194.895127621834, 4324.372965919987, 4345.847895323648, 4354.194474022316, 4360.65114790816, 2695.908157196339, 2705.6482657254433, 2712.443948990452, 2724.223596275052, 2727.3999720061556, 4796.537056197823, 4810.302506136591, 4814.927776083362, 4819.783109759999, 4820.6261215553395, 4992.600591952635, 5154.8969020620125, 5190.8183213587345, 5191.454897235812, 5222.764975576109, 4756.167670657552, 4758.1443237136855, 4776.617870570346, 4783.675345634751, 4783.823360371092, 5101.158308878993, 5116.9232461512365, 5123.513266239701, 5129.153689641316, 5131.846044618667, 4836.347093142522, 4935.531124543163, 4974.825881094144, 5017.0, 5033.0, 4768.233095854236, 4778.546038126373, 4778.904421911473, 4789.994101238779, 4797.160496913096, 3469.548958635462, 3497.4229252173104, 3508.245727168671, 3530.258645684435, 3531.947020794639, 4975.0, 5144.125498665311, 5164.147915593885, 5216.869578260574, 5220.216967454912, 5018.723970181675, 5070.467600901852, 5084.0, 5090.49095090488, 5093.911496286505, 5064.4935506449065, 5070.645054846125, 5083.796648134181, 5088.363954505687, 5092.516210959953, 4765.0, 4782.402199725035, 4939.333190019302, 4994.80020799164, 5029.899402012013, 4926.48271931442, 5006.945763084443, 5087.643864929568, 5109.514596113363, 5113.948860511347, 4965.354503914613, 4972.900541989212, 4977.352944117241, 4977.651564390458, 5003.649744517848], "value": 3721.7026316150823, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.9559030867838, 634.6223996721951, 648.7080813633863, 653.6372313366081, 720.5352547606797, 12391.44238509267, 13658.863411365883, 13679.0, 13712.451501939922, 13787.241701706402, 13147.802782958262, 13318.267495287755, 13334.0, 13341.1995280283, 13347.599572012856, 617.45663815842, 635.3582881289884, 742.1873049011351, 754.4417131322823, 765.8276887700279, 767.8272388712523, 768.5158350239342, 769.0041396391658, 769.6421164158666, 770.1451388958252, 819.72948926854, 820.2044017303207, 820.3683163963744, 821.4537332673794, 821.5399376349234, 647.1425361396145, 662.4766434516725, 767.6161919040479, 784.0395515493532, 787.263908245792, 586.6890548009562, 588.417466707956, 589.0163427076792, 589.3046205477535, 589.5342679283361, 12075.637730868088, 12076.698082547919, 12104.757904841941, 12129.818052729217, 12131.575394861226, 12101.939490302491, 12238.632841014783, 12326.75346493065, 12640.115191936567, 12889.742205155844, 10292.125169360539, 10356.0, 10590.78818423635, 10660.147188224923, 10796.730081748019, 4049.574794646549, 4107.568705285962, 4181.205570941512, 4262.637675797561, 4293.806778694966, 57916.71041644765, 61043.0, 61296.08055879121, 61423.0, 61452.0, 9605.423674579408, 9788.314817962675, 9807.31348805591, 9817.312788104764, 9849.0, 16998.830011699723, 17003.829961700223, 17030.74453883168, 17032.914835425992, 17044.744328835077, 6594.910471243336, 6685.76599819004, 6795.762148324785, 6834.111565496453, 6891.5865048096275, 3485.128717820545, 3614.5120408744483, 3644.1982763791925, 3652.244930480828, 3761.962380376216, 2764.4609301186074, 2898.434805212963, 2899.362140329124, 3136.2159460134967, 3300.1254667513126, 538.6606437944071, 539.7235537952791, 540.9594280428984, 551.2282804074327, 551.8841043380854, 548.3611592494699, 595.2678205806795, 612.6569121292091, 622.3092367472102, 635.3011687144196, 7649.770506884803, 8004.399670024772, 8015.0, 8175.509469431853, 8367.205115514016, 523.7224271136304, 607.9817605471843, 619.2970977939981, 622.2470810319473, 629.4995478594528, 4033.253848038122, 4134.896627584274, 4152.626263636287, 4295.183915056129, 4329.9134017319475, 97690.0, 98352.50823745978, 99176.50411747895, 101573.49213253887, 102041.48979255056, 82713.17286827175, 83752.58123709343, 86004.0, 86574.0, 88145.0, 55564.72217638967, 73796.63101684458, 78999.0, 79476.0, 79973.0, 7707.653155607899, 8208.630611622611, 8277.668893244443, 8372.330213582776, 8411.957940210259, 41552.0, 45209.77395113003, 45225.32162017506, 45652.771736141105, 45778.0, 38939.6106038936, 43058.138837222454, 51977.344644348574, 65439.34560654333, 66802.33197668155, 11268.887311126784, 11435.828462573234, 11596.304221746723, 11671.12466564994, 11823.113266504875, 11662.358570278717, 12184.695382615506, 13413.731725365244, 13457.125286856322, 14064.718705625626, 11213.66359009231, 11951.641450756491, 12253.326067066397, 12429.875701242872, 13239.13945593572, 12102.818457722966, 12199.268043917038, 12267.0, 12343.938280308541, 13074.542391016268, 10775.0, 11080.445977701243, 11284.0, 11459.828102578635, 12182.14724969279, 10240.692779216635, 10275.126614237575, 10419.739506512398, 10783.946080269548, 11142.944285278521, 10816.729581760519, 10924.7268818277, 10953.507092180711, 10989.0, 11079.113670906469], "value": 6569.722958586403, "unit": "score"}], "name": "dromaeo_css", "value": 6277.547751157735, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 118.0, 117.0, 117.0, 117.0, 117.0, 115.0, 116.0, 117.0, 117.0], "value": 116.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 123.0, 122.0, 166.0, 126.0, 129.0, 130.0, 129.0, 162.0, 124.0], "value": 136.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 163.0, 161.0, 161.0, 163.0, 161.0, 162.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 103.0, 77.0, 77.0, 76.0, 76.0, 114.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 117.0, 84.0, 83.0, 84.0, 107.0, 83.0, 83.0, 116.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 148.0, 147.0, 148.0, 148.0, 148.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 68.0, 65.0, 67.0, 65.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 85.0, 82.0, 83.0, 82.0, 83.0, 83.0, 83.0, 82.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 134.0, 137.0, 132.0, 141.0, 134.0, 136.0, 134.0, 187.0, 146.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 169.0, 172.0, 171.0, 176.0, 175.0, 178.0, 176.0, 176.0, 174.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 69.0, 68.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1547.5000000000002, "alertThreshold": 2.0}]} 06:08:35 INFO - Return code: 0 06:08:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:08:35 INFO - # TBPL SUCCESS # 06:08:35 INFO - Running post-action listener: _resource_record_post_action 06:08:35 INFO - [mozharness: 2016-09-29 13:08:35.597975Z] Finished run-tests step (success) 06:08:35 INFO - Running post-run listener: _resource_record_post_run 06:08:35 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 397983744; Read time: 4; Write time: 276800 06:08:35 INFO - TinderboxPrint: CPU usage
13.0% 06:08:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 06:08:35 INFO - TinderboxPrint: I/O write bytes / time
397,983,744 / 276,800 06:08:35 INFO - TinderboxPrint: CPU idle
8,350.9 (87.0%) 06:08:35 INFO - TinderboxPrint: CPU user
1,198.7 (12.5%) 06:08:35 INFO - TinderboxPrint: Swap in / out
0 / 0 06:08:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106262528; Read time: 0; Write time: 70848 06:08:35 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 290725888; Read time: 0; Write time: 205916 06:08:36 INFO - Running post-run listener: _upload_blobber_files 06:08:36 INFO - Blob upload gear active. 06:08:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:08:36 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 06:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:08:36 INFO - (blobuploader) - INFO - Open directory for files ... 06:08:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:08:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:08:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:37 INFO - (blobuploader) - INFO - Done attempting. 06:08:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:08:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:08:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:38 INFO - (blobuploader) - INFO - Done attempting. 06:08:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:08:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:08:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:41 INFO - (blobuploader) - INFO - Done attempting. 06:08:41 INFO - (blobuploader) - INFO - Iteration through files over. 06:08:41 INFO - Return code: 0 06:08:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:08:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:08:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a8a72a2e1844f631f2da432f501c54d462f73204c845905f7cde1cf98c2491a606fbdf767fd936b7f391e073a69e0f65a371b487c5d245103fd5244526825da4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f7fd887c8f5aafc9a9d020d3b3b0a6a91e0db2ac6b8ebad4e04f505ec99e82b46b73212540502976164114baad812275f1ef8f859b4207a7354f88d65adebb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1051a4c9c3eb694d2677161ecfd960c48fbccf962ab8a220fe4b974926bf712826f6dbc091a3d1974fdfb0cbf585ebece51fb68771039400af59e3c800e975e"} 06:08:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:08:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:08:41 INFO - Contents: 06:08:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a8a72a2e1844f631f2da432f501c54d462f73204c845905f7cde1cf98c2491a606fbdf767fd936b7f391e073a69e0f65a371b487c5d245103fd5244526825da4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f7fd887c8f5aafc9a9d020d3b3b0a6a91e0db2ac6b8ebad4e04f505ec99e82b46b73212540502976164114baad812275f1ef8f859b4207a7354f88d65adebb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1051a4c9c3eb694d2677161ecfd960c48fbccf962ab8a220fe4b974926bf712826f6dbc091a3d1974fdfb0cbf585ebece51fb68771039400af59e3c800e975e"} 06:08:41 INFO - Running post-run listener: copy_logs_to_upload_dir 06:08:41 INFO - Copying logs to upload dir... 06:08:41 INFO - mkdir: /builds/slave/test/build/upload/logs 06:08:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.969510 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-29 06:08:40.895642) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 06:08:40.899148) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a8a72a2e1844f631f2da432f501c54d462f73204c845905f7cde1cf98c2491a606fbdf767fd936b7f391e073a69e0f65a371b487c5d245103fd5244526825da4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f7fd887c8f5aafc9a9d020d3b3b0a6a91e0db2ac6b8ebad4e04f505ec99e82b46b73212540502976164114baad812275f1ef8f859b4207a7354f88d65adebb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1051a4c9c3eb694d2677161ecfd960c48fbccf962ab8a220fe4b974926bf712826f6dbc091a3d1974fdfb0cbf585ebece51fb68771039400af59e3c800e975e"} build_url:https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011435 build_url: 'https://queue.taskcluster.net/v1/task/fyvRJO6yTNKNT61wY5y7ZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a8a72a2e1844f631f2da432f501c54d462f73204c845905f7cde1cf98c2491a606fbdf767fd936b7f391e073a69e0f65a371b487c5d245103fd5244526825da4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f7fd887c8f5aafc9a9d020d3b3b0a6a91e0db2ac6b8ebad4e04f505ec99e82b46b73212540502976164114baad812275f1ef8f859b4207a7354f88d65adebb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1051a4c9c3eb694d2677161ecfd960c48fbccf962ab8a220fe4b974926bf712826f6dbc091a3d1974fdfb0cbf585ebece51fb68771039400af59e3c800e975e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 06:08:40.925067) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 06:08:40.925394) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1475153272.570226-1525249907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 06:08:41.010280) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 06:08:41.010623) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 06:08:41.010947) ========= ========= Total master_lag: 0.17 =========