builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1475976464.33 results: success (0) buildid: 20161008171719 builduid: af0787e223ab47cb84442e656c23ce9a revision: ea311deedce9154009a9575e9cad1345669ff781 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-08 18:27:44.332153) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-08 18:27:44.332594) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-08 18:27:44.333042) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-08 18:27:44.393851) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 18:27:44.394161) ========= 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=745a4373a2a16df560f216e000000264-1475973570.624102-1554800475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-08 18:27:44-- 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% 226M=0s 2016-10-08 18:27:44 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.203363 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 18:27:44.626136) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 18:27:44.626442) ========= 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=745a4373a2a16df560f216e000000264-1475973570.624102-1554800475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.187658 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 18:27:44.827525) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 18:27:44.828105) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ea311deedce9154009a9575e9cad1345669ff781 --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 ea311deedce9154009a9575e9cad1345669ff781 --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=745a4373a2a16df560f216e000000264-1475973570.624102-1554800475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-08 18:27:44,868 truncating revision to first 12 chars 2016-10-08 18:27:44,868 Setting DEBUG logging. 2016-10-08 18:27:44,868 attempt 1/10 2016-10-08 18:27:44,868 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ea311deedce9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-08 18:27:45,336 unpacking tar archive at: fx-team-ea311deedce9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.827107 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 18:27:45.678232) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-08 18:27:45.678588) ========= script_repo_revision: ea311deedce9154009a9575e9cad1345669ff781 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-08 18:27:45.679124) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-08 18:27:45.679479) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-08 18:27:45.691082) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-10-08 18:27:45.691407) ========= /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=745a4373a2a16df560f216e000000264-1475973570.624102-1554800475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:27:45 INFO - MultiFileLogger online at 20161008 18:27:45 in /builds/slave/test 18:27:45 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 18:27:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:27:45 INFO - {'append_to_log': False, 18:27:45 INFO - 'base_work_dir': '/builds/slave/test', 18:27:45 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:27:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:27:45 INFO - 'branch': 'Fx-Team-Non-PGO', 18:27:45 INFO - 'buildbot_json_path': 'buildprops.json', 18:27:45 INFO - 'config_files': ('talos/linux_config.py',), 18:27:45 INFO - 'default_actions': ('clobber', 18:27:45 INFO - 'read-buildbot-config', 18:27:45 INFO - 'download-and-extract', 18:27:45 INFO - 'populate-webroot', 18:27:45 INFO - 'create-virtualenv', 18:27:45 INFO - 'install', 18:27:45 INFO - 'run-tests'), 18:27:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:27:45 INFO - 'download_minidump_stackwalk': True, 18:27:45 INFO - 'download_symbols': 'ondemand', 18:27:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:27:45 INFO - 'tooltool.py': '/tools/tooltool.py', 18:27:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:27:45 INFO - '/tools/misc-python/virtualenv.py')}, 18:27:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:27:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:27:45 INFO - 'installer_path': 'installer.exe', 18:27:45 INFO - 'log_level': 'info', 18:27:45 INFO - 'log_name': 'talos', 18:27:45 INFO - 'log_to_console': True, 18:27:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:27:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:27:45 INFO - 'opt_config_files': (), 18:27:45 INFO - 'pip_index': False, 18:27:45 INFO - 'sps_profile': False, 18:27:45 INFO - 'sps_profile_interval': 0, 18:27:45 INFO - 'suite': 'dromaeojs', 18:27:45 INFO - 'system_bits': '32', 18:27:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:27:45 INFO - 'title': 'talos-linux64-ix-032', 18:27:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:27:45 INFO - 'use_talos_json': True, 18:27:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:27:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:27:45 INFO - 'work_dir': 'build'} 18:27:45 INFO - [mozharness: 2016-10-09 01:27:45.982440Z] Running clobber step. 18:27:45 INFO - Running pre-action listener: _resource_record_pre_action 18:27:45 INFO - Running main action method: clobber 18:27:45 INFO - rmtree: /builds/slave/test/build 18:27:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:27:47 INFO - Running post-action listener: _resource_record_post_action 18:27:47 INFO - [mozharness: 2016-10-09 01:27:47.642564Z] Finished clobber step (success) 18:27:47 INFO - [mozharness: 2016-10-09 01:27:47.642663Z] Running read-buildbot-config step. 18:27:47 INFO - Running pre-action listener: _resource_record_pre_action 18:27:47 INFO - Running main action method: read_buildbot_config 18:27:47 INFO - Using buildbot properties: 18:27:47 INFO - { 18:27:47 INFO - "project": "", 18:27:47 INFO - "product": "firefox", 18:27:47 INFO - "script_repo_revision": "production", 18:27:47 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:27:47 INFO - "repository": "", 18:27:47 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:27:47 INFO - "buildid": "20161008171719", 18:27:47 INFO - "pgo_build": "False", 18:27:47 INFO - "basedir": "/builds/slave/test", 18:27:47 INFO - "buildnumber": 3374, 18:27:47 INFO - "slavename": "talos-linux64-ix-032", 18:27:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:27:47 INFO - "platform": "ubuntu64_hw", 18:27:47 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:27:47 INFO - "branch": "fx-team", 18:27:47 INFO - "repo_path": "integration/fx-team", 18:27:47 INFO - "revision": "ea311deedce9154009a9575e9cad1345669ff781", 18:27:47 INFO - "stage_platform": "linux64", 18:27:47 INFO - "builduid": "af0787e223ab47cb84442e656c23ce9a", 18:27:47 INFO - "slavebuilddir": "test" 18:27:47 INFO - } 18:27:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:27:47 INFO - Running post-action listener: _resource_record_post_action 18:27:47 INFO - [mozharness: 2016-10-09 01:27:47.645103Z] Finished read-buildbot-config step (success) 18:27:47 INFO - [mozharness: 2016-10-09 01:27:47.645190Z] Running download-and-extract step. 18:27:47 INFO - Running pre-action listener: _resource_record_pre_action 18:27:47 INFO - Running main action method: download_and_extract 18:27:47 INFO - mkdir: /builds/slave/test/build/tests 18:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:47 INFO - trying https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:27:47 INFO - Downloading https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/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 18:27:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/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 18:27:48 INFO - Downloaded 1361 bytes. 18:27:48 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:27:48 INFO - Using the following test package requirements: 18:27:48 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:27:48 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:27:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:27:48 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:27:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:27:48 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:27:48 INFO - u'jsshell-linux-x86_64.zip'], 18:27:48 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:27:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:27:48 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:27:48 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:27:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:27:48 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:27:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:27:48 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:27:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:27:48 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:27:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:27:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:27:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:27:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:27:48 INFO - Fetch https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:27:48 INFO - Http code: 200 18:27:48 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 18:27:48 INFO - x-amz-cf-id: Ru4Qcs1Oo4cQKyZHV7kWiCUg18RC2xdG-pg3jL048GHbC9GqcwW3_A== 18:27:48 INFO - x-amz-version-id: _xSGXWAYlSdH7DOiY0QVh27l8QgFH22l 18:27:49 INFO - Expected file size: 20524999 18:27:49 INFO - Obtained file size: 20524999 18:27:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:27:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:27:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:27:53 INFO - Fetch https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:27:53 INFO - Http code: 200 18:27:53 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 18:27:53 INFO - x-amz-cf-id: A4gZYBsbEMYKHxy3moi2keBjIL7n44qSIebNIQnzup8cE00UzI9VAw== 18:27:53 INFO - x-amz-version-id: _xSGXWAYlSdH7DOiY0QVh27l8QgFH22l 18:27:53 INFO - Expected file size: 20524999 18:27:53 INFO - Obtained file size: 20524999 18:27:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:27:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:27:59 INFO - Fetch https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:27:59 INFO - Http code: 200 18:27:59 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 18:27:59 INFO - x-amz-cf-id: z6EHPR0xPHnJXhvUC49D6u9pg2vnkpS9jkph45QGM9Pqf3vVlQeAUw== 18:27:59 INFO - x-amz-version-id: vx6_Z6R_sYVQ5EJYfdo.sd4aT68tKRFx 18:27:59 INFO - Expected file size: 14409006 18:27:59 INFO - Obtained file size: 14409006 18:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:28:00 INFO - trying https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:28:00 INFO - Downloading https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/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 18:28:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/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 18:28:02 INFO - Downloaded 55833457 bytes. 18:28:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:28:02 INFO - mkdir: /builds/slave/test/properties 18:28:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:28:02 INFO - Writing to file /builds/slave/test/properties/build_url 18:28:02 INFO - Contents: 18:28:02 INFO - build_url:https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:28:02 INFO - Running post-action listener: _resource_record_post_action 18:28:02 INFO - Running post-action listener: set_extra_try_arguments 18:28:02 INFO - [mozharness: 2016-10-09 01:28:02.962899Z] Finished download-and-extract step (success) 18:28:02 INFO - [mozharness: 2016-10-09 01:28:02.963129Z] Running populate-webroot step. 18:28:02 INFO - Running pre-action listener: _resource_record_pre_action 18:28:02 INFO - Running main action method: populate_webroot 18:28:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:28:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:28:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:28:02 INFO - '--tppagecycles', 18:28:02 INFO - '7'], 18:28:02 INFO - 'tests': ['tsvgm']}}, 18:28:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:28:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:28:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:28:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:28:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:28:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:28:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:28:02 INFO - 'talos_options': ['--disable-e10s'], 18:28:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:28:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:28:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:28:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:28:02 INFO - 'talos_options': ['--disable-e10s'], 18:28:02 INFO - 'tests': ['damp', 'tps']}, 18:28:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:28:02 INFO - 'tests': ['damp', 'tps']}, 18:28:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:28:02 INFO - 'tests': ['dromaeo_dom']}, 18:28:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:28:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:28:02 INFO - 'tests': ['basic_compositor_video']}, 18:28:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:28:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:28:02 INFO - 'tests': ['a11yr', 18:28:02 INFO - 'ts_paint', 18:28:02 INFO - 'tpaint', 18:28:02 INFO - 'sessionrestore', 18:28:02 INFO - 'sessionrestore_no_auto_restore', 18:28:02 INFO - 'tabpaint']}, 18:28:02 INFO - 'other-e10s': {'tests': ['a11yr', 18:28:02 INFO - 'ts_paint', 18:28:02 INFO - 'tpaint', 18:28:02 INFO - 'sessionrestore', 18:28:02 INFO - 'sessionrestore_no_auto_restore', 18:28:02 INFO - 'tabpaint']}, 18:28:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:28:02 INFO - 'ts_paint', 18:28:02 INFO - 'tpaint', 18:28:02 INFO - 'sessionrestore', 18:28:02 INFO - 'sessionrestore_no_auto_restore', 18:28:02 INFO - 'tabpaint']}, 18:28:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:28:02 INFO - 'ts_paint', 18:28:02 INFO - 'tpaint', 18:28:02 INFO - 'sessionrestore', 18:28:02 INFO - 'sessionrestore_no_auto_restore', 18:28:02 INFO - 'tabpaint']}, 18:28:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:28:02 INFO - 'tests': ['a11yr', 18:28:02 INFO - 'ts_paint', 18:28:02 INFO - 'tpaint', 18:28:02 INFO - 'sessionrestore', 18:28:02 INFO - 'sessionrestore_no_auto_restore', 18:28:02 INFO - 'tabpaint']}, 18:28:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:28:02 INFO - 'tests': ['a11yr', 18:28:02 INFO - 'ts_paint', 18:28:02 INFO - 'tpaint', 18:28:02 INFO - 'sessionrestore', 18:28:02 INFO - 'sessionrestore_no_auto_restore', 18:28:02 INFO - 'tabpaint']}, 18:28:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:28:02 INFO - 'tests': ['tsvgx', 18:28:02 INFO - 'tsvgr_opacity', 18:28:02 INFO - 'tart', 18:28:02 INFO - 'tscrollx', 18:28:02 INFO - 'cart']}, 18:28:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:28:02 INFO - 'tsvgr_opacity', 18:28:02 INFO - 'tart', 18:28:02 INFO - 'tscrollx', 18:28:02 INFO - 'cart']}, 18:28:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:28:02 INFO - 'talos_options': ['--disable-e10s'], 18:28:02 INFO - 'tests': ['tp5o']}, 18:28:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:28:02 INFO - 'tests': ['tp5o']}, 18:28:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:28:02 INFO - 'talos_options': ['--disable-e10s', 18:28:02 INFO - '--xperf_path', 18:28:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:28:02 INFO - 'tests': ['tp5n']}, 18:28:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:28:02 INFO - 'talos_options': ['--xperf_path', 18:28:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:28:02 INFO - 'tests': ['tp5n']}}, 18:28:02 INFO - 'talos.zip': {'path': '', 18:28:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:28:02 INFO - Running post-action listener: _resource_record_post_action 18:28:02 INFO - [mozharness: 2016-10-09 01:28:02.985281Z] Finished populate-webroot step (success) 18:28:02 INFO - [mozharness: 2016-10-09 01:28:02.985370Z] Running create-virtualenv step. 18:28:02 INFO - Running pre-action listener: _resource_record_pre_action 18:28:02 INFO - Running main action method: create_virtualenv 18:28:02 INFO - Creating virtualenv /builds/slave/test/build/venv 18:28:02 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 18:28:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:28:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:28:03 INFO - Using real prefix '/usr' 18:28:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:28:03 INFO - Installing distribute.............................................................................................................................................................................................done. 18:28:05 INFO - Installing pip.................done. 18:28:05 INFO - Return code: 0 18:28:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:28:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:28:07 INFO - Reading from file tmpfile_stdout 18:28:07 INFO - Output received: 18:28:07 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) 18:28:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:28: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')]} 18:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28: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')]} 18:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:07 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 0x7fb074f53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24caf60>, '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 0x24cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc1d0>, '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': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', '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 18:28:07 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 18:28:07 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 18:28:07 INFO - Using env: {'DISPLAY': ':0', 18:28:07 INFO - 'HOME': '/home/cltbld', 18:28:07 INFO - 'LANG': 'en_US.UTF-8', 18:28:07 INFO - 'LANGUAGE': 'en_US:en', 18:28:07 INFO - 'LOGNAME': 'cltbld', 18:28:07 INFO - 'MAIL': '/var/mail/cltbld', 18:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:28:07 INFO - 'MOZ_NO_REMOTE': '1', 18:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:28:07 INFO - 'NO_EM_RESTART': '1', 18:28:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:28:07 INFO - 'PWD': '/builds/slave/test', 18:28:07 INFO - 'SHELL': '/bin/bash', 18:28:07 INFO - 'SHLVL': '1', 18:28:07 INFO - 'TERM': 'linux', 18:28:07 INFO - 'TMOUT': '86400', 18:28:07 INFO - 'USER': 'cltbld', 18:28:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', 18:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:28:07 INFO - '_': '/tools/buildbot/bin/python'} 18:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:28:07 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 18:28:07 INFO - Cleaning up... 18:28:07 INFO - Return code: 0 18:28:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:28: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')]} 18:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28: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')]} 18:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:07 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 0x7fb074f53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24caf60>, '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 0x24cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc1d0>, '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': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', '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 18:28:07 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 18:28:07 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 18:28:07 INFO - Using env: {'DISPLAY': ':0', 18:28:07 INFO - 'HOME': '/home/cltbld', 18:28:07 INFO - 'LANG': 'en_US.UTF-8', 18:28:07 INFO - 'LANGUAGE': 'en_US:en', 18:28:07 INFO - 'LOGNAME': 'cltbld', 18:28:07 INFO - 'MAIL': '/var/mail/cltbld', 18:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:28:07 INFO - 'MOZ_NO_REMOTE': '1', 18:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:28:07 INFO - 'NO_EM_RESTART': '1', 18:28:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:28:07 INFO - 'PWD': '/builds/slave/test', 18:28:07 INFO - 'SHELL': '/bin/bash', 18:28:07 INFO - 'SHLVL': '1', 18:28:07 INFO - 'TERM': 'linux', 18:28:07 INFO - 'TMOUT': '86400', 18:28:07 INFO - 'USER': 'cltbld', 18:28:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', 18:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:28:07 INFO - '_': '/tools/buildbot/bin/python'} 18:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:28:07 INFO - Downloading/unpacking psutil>=3.1.1 18:28:07 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 18:28:07 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 18:28:07 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 18:28:07 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 18:28:07 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 18:28:07 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 18:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:28:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:28:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:28:09 INFO - Installing collected packages: psutil 18:28:09 INFO - Running setup.py install for psutil 18:28:09 INFO - building 'psutil._psutil_linux' extension 18:28:09 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 18:28:11 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 18:28:11 INFO - building 'psutil._psutil_posix' extension 18:28:11 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 18:28:11 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 18:28:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:28:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:28:11 INFO - Successfully installed psutil 18:28:11 INFO - Cleaning up... 18:28:11 INFO - Return code: 0 18:28:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb074f53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24caf60>, '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 0x24cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc1d0>, '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': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', '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 18:28:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:28:11 INFO - Using env: {'DISPLAY': ':0', 18:28:11 INFO - 'HOME': '/home/cltbld', 18:28:11 INFO - 'LANG': 'en_US.UTF-8', 18:28:11 INFO - 'LANGUAGE': 'en_US:en', 18:28:11 INFO - 'LOGNAME': 'cltbld', 18:28:11 INFO - 'MAIL': '/var/mail/cltbld', 18:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:28:11 INFO - 'MOZ_NO_REMOTE': '1', 18:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:28:11 INFO - 'NO_EM_RESTART': '1', 18:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:28:11 INFO - 'PWD': '/builds/slave/test', 18:28:11 INFO - 'SHELL': '/bin/bash', 18:28:11 INFO - 'SHLVL': '1', 18:28:11 INFO - 'TERM': 'linux', 18:28:11 INFO - 'TMOUT': '86400', 18:28:11 INFO - 'USER': 'cltbld', 18:28:11 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', 18:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:28:11 INFO - '_': '/tools/buildbot/bin/python'} 18:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:28:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:28:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:28:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:28:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:28:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:28:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:28:13 INFO - Installing collected packages: mozsystemmonitor 18:28:13 INFO - Running setup.py install for mozsystemmonitor 18:28:13 INFO - Successfully installed mozsystemmonitor 18:28:13 INFO - Cleaning up... 18:28:14 INFO - Return code: 0 18:28:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:28:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:28:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb074f53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24caf60>, '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 0x24cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc1d0>, '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': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', '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 18:28:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:28:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:28:14 INFO - Using env: {'DISPLAY': ':0', 18:28:14 INFO - 'HOME': '/home/cltbld', 18:28:14 INFO - 'LANG': 'en_US.UTF-8', 18:28:14 INFO - 'LANGUAGE': 'en_US:en', 18:28:14 INFO - 'LOGNAME': 'cltbld', 18:28:14 INFO - 'MAIL': '/var/mail/cltbld', 18:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:28:14 INFO - 'MOZ_NO_REMOTE': '1', 18:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:28:14 INFO - 'NO_EM_RESTART': '1', 18:28:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:28:14 INFO - 'PWD': '/builds/slave/test', 18:28:14 INFO - 'SHELL': '/bin/bash', 18:28:14 INFO - 'SHLVL': '1', 18:28:14 INFO - 'TERM': 'linux', 18:28:14 INFO - 'TMOUT': '86400', 18:28:14 INFO - 'USER': 'cltbld', 18:28:14 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', 18:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:28:14 INFO - '_': '/tools/buildbot/bin/python'} 18:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:28:14 INFO - Downloading/unpacking jsonschema==2.5.1 18:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:28:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:28:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:28:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:28:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:28:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:28:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:28: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 18:28: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 18:28: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 18:28: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 18:28: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 18:28: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 18:28:16 INFO - Downloading functools32-3.2.3-2.tar.gz 18:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:28:16 INFO - warning: no files found matching '*.txt' 18:28:16 INFO - no previously-included directories found matching 'build' 18:28:16 INFO - no previously-included directories found matching 'dist' 18:28:16 INFO - no previously-included directories found matching '.git*' 18:28:16 INFO - Installing collected packages: jsonschema, functools32 18:28:16 INFO - Running setup.py install for functools32 18:28:16 INFO - warning: no files found matching '*.txt' 18:28:16 INFO - no previously-included directories found matching 'build' 18:28:16 INFO - no previously-included directories found matching 'dist' 18:28:16 INFO - no previously-included directories found matching '.git*' 18:28:16 INFO - Successfully installed jsonschema functools32 18:28:16 INFO - Cleaning up... 18:28:16 INFO - Return code: 0 18:28:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:28: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')]} 18:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:28:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28: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')]} 18:28:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:28:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28: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', '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 0x7fb074f53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24caf60>, '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 0x24cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc1d0>, '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': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', '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 18:28: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:28: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 functools32==3.2.3-2 18:28:16 INFO - Using env: {'DISPLAY': ':0', 18:28:16 INFO - 'HOME': '/home/cltbld', 18:28:16 INFO - 'LANG': 'en_US.UTF-8', 18:28:16 INFO - 'LANGUAGE': 'en_US:en', 18:28:16 INFO - 'LOGNAME': 'cltbld', 18:28:16 INFO - 'MAIL': '/var/mail/cltbld', 18:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:28:16 INFO - 'MOZ_NO_REMOTE': '1', 18:28:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:28:16 INFO - 'NO_EM_RESTART': '1', 18:28:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:28:16 INFO - 'PWD': '/builds/slave/test', 18:28:16 INFO - 'SHELL': '/bin/bash', 18:28:16 INFO - 'SHLVL': '1', 18:28:16 INFO - 'TERM': 'linux', 18:28:16 INFO - 'TMOUT': '86400', 18:28:16 INFO - 'USER': 'cltbld', 18:28:16 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', 18:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:28:16 INFO - '_': '/tools/buildbot/bin/python'} 18:28:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:28:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:28:16 INFO - Cleaning up... 18:28:16 INFO - Return code: 0 18:28:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:28: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')]} 18:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:28:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28: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')]} 18:28:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:28:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28: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', '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 0x7fb074f53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24caf60>, '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 0x24cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc1d0>, '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': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', '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 18:28: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:28: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 blobuploader==1.2.4 18:28:16 INFO - Using env: {'DISPLAY': ':0', 18:28:16 INFO - 'HOME': '/home/cltbld', 18:28:16 INFO - 'LANG': 'en_US.UTF-8', 18:28:16 INFO - 'LANGUAGE': 'en_US:en', 18:28:16 INFO - 'LOGNAME': 'cltbld', 18:28:16 INFO - 'MAIL': '/var/mail/cltbld', 18:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:28:16 INFO - 'MOZ_NO_REMOTE': '1', 18:28:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:28:16 INFO - 'NO_EM_RESTART': '1', 18:28:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:28:16 INFO - 'PWD': '/builds/slave/test', 18:28:16 INFO - 'SHELL': '/bin/bash', 18:28:16 INFO - 'SHLVL': '1', 18:28:16 INFO - 'TERM': 'linux', 18:28:16 INFO - 'TMOUT': '86400', 18:28:16 INFO - 'USER': 'cltbld', 18:28:16 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', 18:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:28:16 INFO - '_': '/tools/buildbot/bin/python'} 18:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:28:17 INFO - Downloading/unpacking blobuploader==1.2.4 18:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:28:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:28:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:28:19 INFO - Downloading blobuploader-1.2.4.tar.gz 18:28:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:28:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:28:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:28:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:28:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:28:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:28:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:28:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:28:19 INFO - Downloading docopt-0.6.1.tar.gz 18:28:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:28:19 INFO - Installing collected packages: blobuploader, requests, docopt 18:28:19 INFO - Running setup.py install for blobuploader 18:28:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:28:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:28:19 INFO - Running setup.py install for requests 18:28:20 INFO - Running setup.py install for docopt 18:28:20 INFO - Successfully installed blobuploader requests docopt 18:28:20 INFO - Cleaning up... 18:28:20 INFO - Return code: 0 18:28:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:28:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:28:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:28:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:20 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 0x7fb074f53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24caf60>, '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 0x24cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc1d0>, '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': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', '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 18:28:20 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 18:28:20 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 18:28:20 INFO - Using env: {'DISPLAY': ':0', 18:28:20 INFO - 'HOME': '/home/cltbld', 18:28:20 INFO - 'LANG': 'en_US.UTF-8', 18:28:20 INFO - 'LANGUAGE': 'en_US:en', 18:28:20 INFO - 'LOGNAME': 'cltbld', 18:28:20 INFO - 'MAIL': '/var/mail/cltbld', 18:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:28:20 INFO - 'MOZ_NO_REMOTE': '1', 18:28:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:28:20 INFO - 'NO_EM_RESTART': '1', 18:28:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:28:20 INFO - 'PWD': '/builds/slave/test', 18:28:20 INFO - 'SHELL': '/bin/bash', 18:28:20 INFO - 'SHLVL': '1', 18:28:20 INFO - 'TERM': 'linux', 18:28:20 INFO - 'TMOUT': '86400', 18:28:20 INFO - 'USER': 'cltbld', 18:28:20 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', 18:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:28:20 INFO - '_': '/tools/buildbot/bin/python'} 18:28:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:28:20 INFO - Running setup.py (path:/tmp/pip-rfMcya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:28:20 INFO - Running setup.py (path:/tmp/pip-z7H0hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:28:20 INFO - Running setup.py (path:/tmp/pip-Uizt2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:28:20 INFO - Running setup.py (path:/tmp/pip-7XHOgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:28:20 INFO - Running setup.py (path:/tmp/pip-1aLhhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:28:21 INFO - Running setup.py (path:/tmp/pip-tqLavJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:28:21 INFO - Running setup.py (path:/tmp/pip-vZAmFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:28:21 INFO - Running setup.py (path:/tmp/pip-NPE5Wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:28:21 INFO - Running setup.py (path:/tmp/pip-PLEg3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:28:21 INFO - Running setup.py (path:/tmp/pip-cWRLON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:28:21 INFO - Running setup.py (path:/tmp/pip-dQxpVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:28:21 INFO - Running setup.py (path:/tmp/pip-GBQ_mM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:28:21 INFO - Running setup.py (path:/tmp/pip-l7Cf9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:28:21 INFO - Running setup.py (path:/tmp/pip-QzIX2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:28:21 INFO - Running setup.py (path:/tmp/pip-Xj4PQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:28:21 INFO - Running setup.py (path:/tmp/pip-rtP2FW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:28:21 INFO - Running setup.py (path:/tmp/pip-yOdVL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:28:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:28:21 INFO - Running setup.py install for manifestparser 18:28:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:28:22 INFO - Running setup.py install for mozcrash 18:28:22 INFO - Running setup.py install for mozdebug 18:28:22 INFO - Running setup.py install for mozdevice 18:28:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:28:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:28:22 INFO - Running setup.py install for mozfile 18:28:22 INFO - Running setup.py install for mozhttpd 18:28:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:28:22 INFO - Running setup.py install for mozinfo 18:28:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:28:22 INFO - Running setup.py install for mozInstall 18:28:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:28:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:28:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:28:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:28:22 INFO - Running setup.py install for mozleak 18:28:22 INFO - Running setup.py install for mozlog 18:28:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:28:22 INFO - Running setup.py install for moznetwork 18:28:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:28:23 INFO - Running setup.py install for mozprocess 18:28:23 INFO - Running setup.py install for mozprofile 18:28:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:28:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:28:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:28:23 INFO - Running setup.py install for mozrunner 18:28:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:28:23 INFO - Running setup.py install for mozscreenshot 18:28:23 INFO - Running setup.py install for moztest 18:28:23 INFO - Running setup.py install for mozversion 18:28:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:28:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:28:23 INFO - Cleaning up... 18:28:23 INFO - Return code: 0 18:28:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:28:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:28:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:23 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 0x7fb074f53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24caf60>, '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 0x24cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc1d0>, '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': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', '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 18:28:23 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 18:28:23 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 18:28:23 INFO - Using env: {'DISPLAY': ':0', 18:28:23 INFO - 'HOME': '/home/cltbld', 18:28:23 INFO - 'LANG': 'en_US.UTF-8', 18:28:23 INFO - 'LANGUAGE': 'en_US:en', 18:28:23 INFO - 'LOGNAME': 'cltbld', 18:28:23 INFO - 'MAIL': '/var/mail/cltbld', 18:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:28:23 INFO - 'MOZ_NO_REMOTE': '1', 18:28:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:28:23 INFO - 'NO_EM_RESTART': '1', 18:28:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:28:23 INFO - 'PWD': '/builds/slave/test', 18:28:23 INFO - 'SHELL': '/bin/bash', 18:28:23 INFO - 'SHLVL': '1', 18:28:23 INFO - 'TERM': 'linux', 18:28:23 INFO - 'TMOUT': '86400', 18:28:23 INFO - 'USER': 'cltbld', 18:28:23 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', 18:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:28:23 INFO - '_': '/tools/buildbot/bin/python'} 18:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:28:23 INFO - Running setup.py (path:/tmp/pip-Z47fwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:28:24 INFO - Running setup.py (path:/tmp/pip-3Acs8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:28:24 INFO - Running setup.py (path:/tmp/pip-lp459z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:28:24 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)) 18:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:28:24 INFO - Running setup.py (path:/tmp/pip-rZRjUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:28:24 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)) 18:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:28:24 INFO - Running setup.py (path:/tmp/pip-nK9ssb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:28:24 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)) 18:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:28:24 INFO - Running setup.py (path:/tmp/pip-T3rhyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:28:24 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)) 18:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:28:24 INFO - Running setup.py (path:/tmp/pip-vCf4lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:28:24 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)) 18:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:28:24 INFO - Running setup.py (path:/tmp/pip-QVXE5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:28:24 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)) 18:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:28:24 INFO - Running setup.py (path:/tmp/pip-ueb62q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:28:24 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)) 18:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:28:24 INFO - Running setup.py (path:/tmp/pip-dEJWkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:28:24 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)) 18:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:28:24 INFO - Running setup.py (path:/tmp/pip-sru7kT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:28:24 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)) 18:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:28:24 INFO - Running setup.py (path:/tmp/pip-oo0aM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:28:24 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)) 18:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:28:24 INFO - Running setup.py (path:/tmp/pip-59mQSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:28:24 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)) 18:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:28:24 INFO - Running setup.py (path:/tmp/pip-NRksLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:28:24 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)) 18:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:28:24 INFO - Running setup.py (path:/tmp/pip-QKIBNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:28:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:28:25 INFO - Running setup.py (path:/tmp/pip-LMKuE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:28:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:28:25 INFO - Running setup.py (path:/tmp/pip-GWR4_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:28:25 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)) 18:28:25 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)) 18:28:25 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)) 18:28:25 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)) 18:28:25 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)) 18:28:25 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)) 18:28:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:28:25 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 18:28:25 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 18:28:25 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 18:28:25 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 18:28:25 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 18:28:25 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 18:28:27 INFO - Downloading blessings-1.6.tar.gz 18:28:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:28:27 INFO - Installing collected packages: blessings 18:28:27 INFO - Running setup.py install for blessings 18:28:27 INFO - Successfully installed blessings 18:28:27 INFO - Cleaning up... 18:28:27 INFO - Return code: 0 18:28:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:28:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:28:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:28:27 INFO - Reading from file tmpfile_stdout 18:28:27 INFO - Current package versions: 18:28:27 INFO - argparse == 1.2.1 18:28:27 INFO - blessings == 1.6 18:28:27 INFO - blobuploader == 1.2.4 18:28:27 INFO - docopt == 0.6.1 18:28:27 INFO - functools32 == 3.2.3-2 18:28:27 INFO - jsonschema == 2.5.1 18:28:27 INFO - manifestparser == 1.1 18:28:27 INFO - mozInstall == 1.12 18:28:27 INFO - mozcrash == 0.17 18:28:27 INFO - mozdebug == 0.1 18:28:27 INFO - mozdevice == 0.48 18:28:27 INFO - mozfile == 1.2 18:28:27 INFO - mozhttpd == 0.7 18:28:27 INFO - mozinfo == 0.9 18:28:27 INFO - mozleak == 0.1 18:28:27 INFO - mozlog == 3.4 18:28:27 INFO - moznetwork == 0.27 18:28:27 INFO - mozprocess == 0.23 18:28:27 INFO - mozprofile == 0.28 18:28:27 INFO - mozrunner == 6.12 18:28:27 INFO - mozscreenshot == 0.1 18:28:27 INFO - mozsystemmonitor == 0.3 18:28:27 INFO - moztest == 0.7 18:28:27 INFO - mozversion == 1.4 18:28:27 INFO - psutil == 3.1.1 18:28:27 INFO - requests == 1.2.3 18:28:27 INFO - wsgiref == 0.1.2 18:28:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:28:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:28:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:28:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:27 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 0x7fb074f53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24caf60>, '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 0x24cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc1d0>, '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': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', '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 18:28:27 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 18:28:27 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 18:28:27 INFO - Using env: {'DISPLAY': ':0', 18:28:27 INFO - 'HOME': '/home/cltbld', 18:28:27 INFO - 'LANG': 'en_US.UTF-8', 18:28:27 INFO - 'LANGUAGE': 'en_US:en', 18:28:27 INFO - 'LOGNAME': 'cltbld', 18:28:27 INFO - 'MAIL': '/var/mail/cltbld', 18:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:28:27 INFO - 'MOZ_NO_REMOTE': '1', 18:28:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:28:27 INFO - 'NO_EM_RESTART': '1', 18:28:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:28:27 INFO - 'PWD': '/builds/slave/test', 18:28:27 INFO - 'SHELL': '/bin/bash', 18:28:27 INFO - 'SHLVL': '1', 18:28:27 INFO - 'TERM': 'linux', 18:28:27 INFO - 'TMOUT': '86400', 18:28:27 INFO - 'USER': 'cltbld', 18:28:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', 18:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:28:27 INFO - '_': '/tools/buildbot/bin/python'} 18:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:28:27 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)) 18:28:27 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)) 18:28:27 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)) 18:28:27 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)) 18:28:27 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)) 18:28:27 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)) 18:28:27 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)) 18:28:27 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)) 18:28:27 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)) 18:28:27 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)) 18:28:27 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)) 18:28:27 INFO - Cleaning up... 18:28:27 INFO - Return code: 0 18:28:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:28:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:28:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:28:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:27 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 0x7fb074f53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24caf60>, '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 0x24cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc1d0>, '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': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', '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 18:28:27 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 18:28:27 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 18:28:27 INFO - Using env: {'DISPLAY': ':0', 18:28:27 INFO - 'HOME': '/home/cltbld', 18:28:27 INFO - 'LANG': 'en_US.UTF-8', 18:28:27 INFO - 'LANGUAGE': 'en_US:en', 18:28:27 INFO - 'LOGNAME': 'cltbld', 18:28:27 INFO - 'MAIL': '/var/mail/cltbld', 18:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:28:27 INFO - 'MOZ_NO_REMOTE': '1', 18:28:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:28:27 INFO - 'NO_EM_RESTART': '1', 18:28:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:28:27 INFO - 'PWD': '/builds/slave/test', 18:28:27 INFO - 'SHELL': '/bin/bash', 18:28:27 INFO - 'SHLVL': '1', 18:28:27 INFO - 'TERM': 'linux', 18:28:27 INFO - 'TMOUT': '86400', 18:28:27 INFO - 'USER': 'cltbld', 18:28:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', 18:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:28:27 INFO - '_': '/tools/buildbot/bin/python'} 18:28:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:28:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:28:28 INFO - Cleaning up... 18:28:28 INFO - Return code: 0 18:28:28 INFO - Running post-action listener: _resource_record_post_action 18:28:28 INFO - Running post-action listener: _start_resource_monitoring 18:28:28 INFO - Starting resource monitoring. 18:28:28 INFO - [mozharness: 2016-10-09 01:28:28.165869Z] Finished create-virtualenv step (success) 18:28:28 INFO - [mozharness: 2016-10-09 01:28:28.166852Z] Running install step. 18:28:28 INFO - Running pre-action listener: _resource_record_pre_action 18:28:28 INFO - Running main action method: install 18:28:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:28:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:28:28 INFO - Reading from file tmpfile_stdout 18:28:28 INFO - Detecting whether we're running mozinstall >=1.0... 18:28:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:28:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:28:28 INFO - Reading from file tmpfile_stdout 18:28:28 INFO - Output received: 18:28:28 INFO - Usage: mozinstall [options] installer 18:28:28 INFO - Options: 18:28:28 INFO - -h, --help show this help message and exit 18:28:28 INFO - -d DEST, --destination=DEST 18:28:28 INFO - Directory to install application into. [default: 18:28:28 INFO - "/builds/slave/test"] 18:28:28 INFO - --app=APP Application being installed. [default: firefox] 18:28:28 INFO - mkdir: /builds/slave/test/build/application 18:28:28 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'] 18:28:28 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 18:28:44 INFO - Reading from file tmpfile_stdout 18:28:44 INFO - Output received: 18:28:44 INFO - /builds/slave/test/build/application/firefox/firefox 18:28:44 INFO - Running post-action listener: _resource_record_post_action 18:28:44 INFO - [mozharness: 2016-10-09 01:28:44.722724Z] Finished install step (success) 18:28:44 INFO - [mozharness: 2016-10-09 01:28:44.722971Z] Running run-tests step. 18:28:44 INFO - Running pre-action listener: _resource_record_pre_action 18:28:44 INFO - Running main action method: run_tests 18:28:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:28:44 INFO - Python 2.7.3 18:28:44 INFO - Return code: 0 18:28:44 INFO - grabbing minidump binary from tooltool 18:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:28:44 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 0x24caf60>, '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 0x24cbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:28:44 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 18:28:44 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 18:28:44 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 18:28:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:28:44 INFO - Return code: 0 18:28:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:28:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:28:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:28:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:28:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:28:44 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/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 18:28:44 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/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 18:28:44 INFO - Using env: {'DISPLAY': ':0', 18:28:44 INFO - 'HOME': '/home/cltbld', 18:28:44 INFO - 'LANG': 'en_US.UTF-8', 18:28:44 INFO - 'LANGUAGE': 'en_US:en', 18:28:44 INFO - 'LOGNAME': 'cltbld', 18:28:44 INFO - 'MAIL': '/var/mail/cltbld', 18:28:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:28:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:28:44 INFO - 'MOZ_NO_REMOTE': '1', 18:28:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:28:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:28:44 INFO - 'NO_EM_RESTART': '1', 18:28:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:28:44 INFO - 'PWD': '/builds/slave/test', 18:28:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:28:44 INFO - 'SHELL': '/bin/bash', 18:28:44 INFO - 'SHLVL': '1', 18:28:44 INFO - 'TERM': 'linux', 18:28:44 INFO - 'TMOUT': '86400', 18:28:44 INFO - 'USER': 'cltbld', 18:28:44 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475973570.624102-1554800475', 18:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:28:44 INFO - '_': '/tools/buildbot/bin/python'} 18:28:44 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/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 18:28:45 INFO - mozversion application_buildid: 20161008171719 18:28:45 INFO - mozversion application_changeset: ea311deedce9154009a9575e9cad1345669ff781 18:28:45 INFO - mozversion application_display_name: Nightly 18:28:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:28:45 INFO - mozversion application_name: Firefox 18:28:45 INFO - mozversion application_remotingname: firefox 18:28:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:28:45 INFO - mozversion application_vendor: Mozilla 18:28:45 INFO - mozversion application_version: 52.0a1 18:28:45 INFO - mozversion platform_buildid: 20161008171719 18:28:45 INFO - mozversion platform_changeset: ea311deedce9154009a9575e9cad1345669ff781 18:28:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:28:45 INFO - mozversion platform_version: 52.0a1 18:28:45 INFO - using testdate: 1475976525 18:28:45 INFO - actual date: 1475976525 18:28:45 INFO - starting webserver on 'localhost:46417' 18:28:45 INFO - SUITE-START | Running 2 tests 18:28:45 INFO - TEST-START | dromaeo_css 18:28:45 INFO - operating with platform_type : linux_ 18:28:45 INFO - Initialising browser for dromaeo_css test... 18:28:45 INFO - TEST-INFO | started process 3326 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjVLBZm/profile http://localhost:46417/getInfo.html) 18:28:53 INFO - PROCESS | 3326 | __metrics Screen width/height:1600/1200 18:28:53 INFO - PROCESS | 3326 | colorDepth:24 18:28:53 INFO - PROCESS | 3326 | Browser inner width/height: 1024/697 18:28:53 INFO - PROCESS | 3326 | __metrics 18:28:54 INFO - PROCESS | 3326 | 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" 18:28:54 INFO - PROCESS | 3326 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:28:55 INFO - PROCESS | 3326 | console.error: PushService: 18:28:55 INFO - PROCESS | 3326 | stateChangeProcessEnqueue: Error transitioning state 18:28:55 INFO - PROCESS | 3326 | UnknownError 18:28:55 INFO - TEST-INFO | 3326: exit 0 18:28:55 INFO - Browser initialized. 18:28:55 INFO - Running cycle 1/1 for dromaeo_css test... 18:28:56 INFO - TEST-INFO | started process 3411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjVLBZm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:29:08 INFO - PROCESS | 3411 | RSS: Main: 174288896 18:29:08 INFO - PROCESS | 3411 | 18:29:59 INFO - PROCESS | 3411 | 1475976599924 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] 18:32:13 INFO - PROCESS | 3411 | Cycle 1(1): loaded http://localhost:46417/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46417/tests/dromaeo/cssquery-ext.html) 18:32:14 INFO - PROCESS | 3411 | RSS: Main: 339263488 18:32:14 INFO - PROCESS | 3411 | 18:35:17 INFO - PROCESS | 3411 | Cycle 1(1): loaded http://localhost:46417/tests/dromaeo/cssquery-ext.html (next: http://localhost:46417/tests/dromaeo/cssquery-jquery.html) 18:35:18 INFO - PROCESS | 3411 | RSS: Main: 281837568 18:35:18 INFO - PROCESS | 3411 | 18:38:20 INFO - PROCESS | 3411 | Cycle 1(1): loaded http://localhost:46417/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46417/tests/dromaeo/cssquery-mootools.html) 18:38:21 INFO - PROCESS | 3411 | RSS: Main: 250171392 18:38:21 INFO - PROCESS | 3411 | 18:41:23 INFO - PROCESS | 3411 | Cycle 1(1): loaded http://localhost:46417/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46417/tests/dromaeo/cssquery-prototype.html) 18:41:23 INFO - PROCESS | 3411 | RSS: Main: 218689536 18:41:23 INFO - PROCESS | 3411 | 18:44:27 INFO - PROCESS | 3411 | Cycle 1(1): loaded http://localhost:46417/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46417/tests/dromaeo/cssquery-yui.html) 18:44:27 INFO - PROCESS | 3411 | RSS: Main: 218775552 18:44:27 INFO - PROCESS | 3411 | 18:47:31 INFO - PROCESS | 3411 | Cycle 1(1): loaded http://localhost:46417/tests/dromaeo/cssquery-yui.html (next: http://localhost:46417/tests/dromaeo/cssquery-dojo.html) 18:47:31 INFO - PROCESS | 3411 | RSS: Main: 313151488 18:47:31 INFO - PROCESS | 3411 | 18:47:31 INFO - PROCESS | 3411 | __start_tp_report 18:47:31 INFO - PROCESS | 3411 | _x_x_mozilla_page_load 18:47:31 INFO - PROCESS | 3411 | _x_x_mozilla_page_load_details 18:47:31 INFO - PROCESS | 3411 | |i|pagename|runs| 18:47:31 INFO - PROCESS | 3411 | |0;dojo.html;2582.1349847800984;2602.869856507174;2636.2223144172467;2646.7750241229505;2654.0710751237057;4608.493065762764;4681.789319480623;4717.150912835693;4742.691725037875;4744.240921452564;4708.128996135717;4709.27006314021;4737.644676649256;4775.403074615673;4822.758862056892;4257.574242575749;4263.168682106991;4318.5033721122;4332.545082766312;4369;4120.17596480705;4403.779811009436;4405.80173892174;4434.977825110886;4490.348899409583;4217.283061879488;4395.538468460798;4417.4919884213405;4438.045820148667;4522.68341216115;4260.957390426087;4317.568243175658;4326.783660816978;4366.323219900921;4390.8902277443;4359.367891655724;4362.2366085935155;4373.562643735633;4415.139047885664;4428.889277768049;4721.598664113554;4728.929066064012;4752.263399173134;4761.095391875532;4764.452088009889;4823.734694591796;4880.316755654211;4982.60139188864;5051.621128415383;5052.545270925598;5048.924266136011;5083.542481176712;5091.618128640367;5135.178371460548;5141.6143789215585;4726.550977657117;4727.669063165546;4730.739809310521;4730.763461826895;4786.95213047872;5035.84892453227;5081.898362032739;5106.336176297132;5164.92252616211;5237.711925844039;4883.218685010382;4893.877653058702;4895.167821470359;4900.632452566072;4948.826791062295;5020.648554601143;5149.742512874342;5152.587792976553;5152.639315247971;5162.070827251131;4951.034548263054;5023.799048038038;5032;5051.217061355495;5104.821331253388;5008.173651347487;5008.398992120969;5018.899622007612;5020.146575082244;5089.541941225233;4117.505899292104;4150.418941348214;4151.294279972351;4201.68487363449;4235.97882010588;3713.628637136319;3722.181120153562;3749.4000959846294;3771.453139294787;3787;4378.627816635558;4383;4387.648988080946;4389.429374181336;4437.134758722018;4919.0407870464915;4946.802127914843;4979.128652485801;5067.113255180402;5102.158143906214;4330.696851220384;4371.846985355497;4387.802548885308;4409.162259170747;4467;4549.931751023737;4556.407667003268;4559.863204103882;4560.95439045612;4609.1703493371515;4647.349371088118;4772.761361931959;4780.4741478436645;4796.640251981115;4825.638077144228;4977.228529577921;5021.6735912165595;5079.136546787129;5084.084864724385;5165.509276618715;4787.593054590259;4788.5211478853225;4791.448983366958;4802.327674125695;4861.781219845045;4981.701097934136;5003.674761140514;5014.724190169576;5016.197408414636;5062.721550314768;4871.683340582851;4919.065377578248;4922.040202160544;4973.552380285647;4974.204127339608;4784.234522476387;4839.540243676845;4840;4842.104210721028;4844.249141383091;4776.283557466408;4778.7849546769785;4852.660313778002;4880.1215781159735;4959.156943319716;4829.323894654681;4836.879078023077;4839.41926968766;4841.201201801663;4884.633652476007;4902.7058376497525;4921.311016457627;4924.03981223658;4924.679895806761;4985.277134815504;4731.266653668687;4783.689060211075;4824.396950381202;4824.638152138534;4862.562369386772 18:47:31 INFO - PROCESS | 3411 | |1;ext.html;549.1515608385045;565.6153815405523;566.5920537213206;577.3072313224133;577.898867698153;27448;37960.62039379605;39224;39369;43139.56860431395;41613;42071.579284207146;42115.57884421155;42123.57876421235;42134;7636.885446718304;7778.222177782205;7789.065312162548;7790.805229869242;7791.337736292422;7641.9617901910415;7729.652165652531;7731.922680773205;7733.22667733225;7733.304002639761;7717.459777815555;7779.2998630123275;7780.727674531393;7782.805429864242;7787.299143077122;7696.807579810494;7733.342665873408;7737.264959828807;7739.7678069658;7744.9931508903765;7635.236476352376;7683.039620047494;7688.384929205706;7690.846183076363;7695.192004839467;37861.621383786085;38195.23609527822;38236.80881595602;38274.425883611766;38319.233615327816;3077.1691643256418;3297.917552061194;3359.277755282626;3427.7600567960253;3625.6918161956264;27800.721992780014;28584.571231431546;28816.423671526663;29419.70580294191;29705.40589188204;3303.636599974001;3429.176997520602;3458.4466485362473;3542.4509201073874;3544.3088597723454;246441;246649;247789;247798.76100619562;249201;32928.506072408934;34423.311533769185;54310.72844635751;54841.177382339294;54944;34353.48469772955;34560.308793823984;34706.65293347085;34759.52404759504;34760.47859282113;12721.109522333349;12836.55072072473;12839.550615728405;12842;12842.550510732079;11256.943715281372;11334.149938754626;11342.262752921033;11344.829827552594;11348.716282093013;7852.803679908048;7888.881666775003;7959.164287749819;7991.200879911962;8074.192580741997;3066.6013418255484;3112.937741245162;3150.6534281229046;3174.2540502981783;3178.6026746656667;805.2068712318362;861.9439736417113;862.7584276402617;886.1050339157497;920.3695468604028;26218.73781262201;28097.297567560974;28154.43691126166;28264.43471130607;28592.14223573296;724.8187953011748;792.5680504125265;903.2503022491317;944.5607792376578;955.8040601676639;12028.752236895989;14921.552353429197;15170.696586068218;15314.846851531565;15351.539453816404;343768;639194;649428;650438;653288;50694.49305506972;50976.74511627418;51121;51426.228606570934;51533;1040.6305761454726;1075.5751478166237;1136.812425949709;1173.5892437646755;1188.6909403554964;27575;29056.56415153732;29592;29769.25576860596;29997.700022999492;41776;42461.363079553215;42463;42491;42529.78735106428;239576;240905;241040;242558;243355;38653.420198697604;39023.414648779726;39153.608463915;40191.397129043675;42241;40555;42671;42799;42932.570674294104;43015.35476967911;36048.63951360558;36403.63596364002;36566.45150322694;36634.8168259157;37598.248035038596;34962.65037349594;37096.44355334618;37313;37471.81264093662;37706.62293377141;36353;36950;36995.26009479849;37381.439278410304;37675.81162094282;31894.36211275715;33864.83067584646;34191.829040855635;34707;34812.477812833335;25453.490930180924;26034;26081.73918260869;26158.476830462903;26266.606000909618 18:47:31 INFO - PROCESS | 3411 | |2;jquery.html;333.6263385008788;346.6897127071271;353.59160170003656;356.8447725239521;380.6840322532299;12091.576794812183;15399.307031183596;16141.192940352994;16230.756538651929;17096.914515427437;16239.431619893307;16251.674966500663;16389.5902602435;16611.91694041531;17168;4038.4749982502235;4984.352034235553;5006;5218.425973142951;5225.973870130644;5059.544640982311;5200.531952124308;5204.661696989702;5204.765785539641;5211.557017653504;4954.702717836942;5166.586673066165;5167.7932882684645;5169.121249387595;5171.663841850286;5074.137396642561;5111.744412779346;5113.974430127825;5132.923006154911;5163.870903227431;4361.781910904442;4618.838340658061;4621.168189725848;4624.5144259852905;4626.699264547794;20253.797462025486;20315.695264571044;20395.796042039685;20614.5877082459;20625.278115265894;1719.7076496995417;1791.2118667786262;1909.5130741660787;1946.4939115829845;2045.3045964372036;8954.910450895473;10429.21780866438;12829;13222.471101155943;13621.182729036289;1688.7456737080743;1760.8943463392109;1763.312308199803;1795.4344381519911;1828.2138680367436;67297;67839.3216067838;67972.9999999995;68212.6589367055;68986.65506672434;9696;10027.197824174049;10027.598896044077;10247.897521024843;10327.483625818679;13939;13942.512012079529;13958.441662333596;13966.650833729238;13982;7014.403775679124;7360.190379058299;7387.556746595222;7516.135644400964;7579.621018949141;6998.265182155902;7050.330218629222;7267.854642907112;7309.488335816548;7348.669309881068;4233.830646774156;4235.97882010588;4280.807363668642;4385.407969924083;4494.505604383515;1781.5278951077976;1806.5844855683004;1809.7556829827804;1852.9629407411776;1876.0432179588236;817.5830326533511;818.3453237410048;822.5558198572704;835.9456635318685;859.5702148925537;16062.437814676665;16358.83641163597;16580.419685310957;17317.220725067404;17531.123443827757;833.2460171339364;845.3955421873267;850.3409857360595;859.0507489224317;873.4715497124275;9180.20003898804;9775.315727898978;9852.852207216898;9855.753606159904;9868.506574671237;340265;344814;346791;348665;358020;41706.582934170874;47170.52829471661;74431.62784186153;74503.62748186225;75250;772.7372693284198;809.7813590330578;869.5391442535466;926.6478738079487;931.3945935142211;14078.507252246121;15283.155554445393;16296.348146074024;16490.422835200712;16533.751993720343;36702;36732;36986.44520332251;37631.43552846655;37871.81064094662;46221.84445388892;48114.75942620265;48157;48195;50046.499535004186;4314.6339406626375;7514;7591.164971853203;7604.125525564631;8036.9953755780525;8872.778180545538;10728.73178170552;10840.5121769519;10938.398388088413;11640.126990475579;9680.322377433513;9735.659251926432;9894.554745036347;10045.146162575971;10411;4428.623566996841;9625.374350667184;9716.805663886824;10027.899721002697;10207.805321855836;9630.229581633592;9737.367071140636;9954.800903982024;10061.949690251502;10181;7477.626118694152;7516.774496765106;7659.502132361602;7812.140664526783;7821.843563128592;9121.908780912107;9892.208623310262;9968.950155249177;9985.800283994135;10070.69787906364 18:47:31 INFO - PROCESS | 3411 | |3;mootools.html;1345.7644912140372;1379.6826729852135;1426.7146570685866;1633.9379403387804;1687.7974643042837;6889.689963951621;7180.353768160864;7360.190379058306;7967.362610991121;7976.601169941494;7266.636668166584;7583.696652133922;7608.429367797409;7940.76177714668;7941.722039728611;2093.968590471144;2134.7331583552054;2139.5934772393275;2147.5168087180336;2153.827693784501;1774.751534785131;1844.5849683821168;2135.1459416233474;2166.458385403649;2196.3959911024435;2011.2960463837685;2069.4102180878454;2076.8546201765885;2086.3636590839787;2087.092114930003;2097.5595125023765;2115.270231770037;2115.9153633854626;2123.299311227291;2125.5748850230016;2124.373309873591;2141.29337318686;2141.4046535331277;2145.967810482844;2146.8175205107586;7904.486208396436;7967.521948683097;7978.122406535276;7995.600219988977;8000.519968801832;4082.163156552929;4128.195001974616;4146.834126634961;4165.520965089023;4249.6387807036435;2669.919902402931;2745.258780129374;2791.2742686901347;2793.329600895791;2802.383475635357;898.734873212404;904.0462312260562;922.7508572685338;935.7707361696359;945.8392073347547;9895;9897.208223342115;9921.107100361001;9948.403095814274;9968.252381071376;3646.3072016316814;3746.157114649182;3857.8071096445065;3920.0591857953887;3927.8036098194975;8618.310535157172;8621.655133794704;8630.5253211074;8633.309335253165;8635.438696484709;4231.7672528010635;4236.830526778956;4238.3006803877015;4253.298205796071;4254.127903779718;3859.55615104261;3865.8067096645054;3866.4007078902814;3868.709846761504;3872.6514613684903;3475.5829300483597;3617.963820361763;3674.412094064937;3681.7790932544135;3855.633714797146;1051;1077.159815344033;1115.4478533126155;1182.6629410617932;1191.106669997502;579.0937183308109;767.9692812287446;798.1898373151256;806.2340776262574;811.4157806379397;5047.192449208109;5105.234214867725;5175.4824517548695;5240.9213861792105;5276;810.9594520273963;853.3940901959554;860.6342304520554;860.7245681381897;895.3016647015338;3447.5690538682666;3468.2196505785996;3484.91287717804;3496.7027802636553;3518.648135186461;9018.86471702925;9609.615615375447;9628.9037109628;9635.373700709431;9651.179649729711;8880.73357799267;9183.311251656152;9343.859842102374;9537.523123843781;9655.613775449045;7192.748253811092;7401.48189626721;7405;7417.406607471389;7423.220561840929;5246.475352464723;5348.251244825806;5471.972640136773;5498.3127109111365;5664.518515926027;9002.63989440415;9074.274058075207;9265.258779297776;9358.953205233931;9376.859347109936;8468.534230617375;8840.115988401109;8842.513661748666;9392.812143757223;9395.577199025924;6790.898136527857;6955.547889387173;6957.060796792571;6963.477739169683;6966.059581956573;7540;7571.242875712384;7599.620018998918;7600.543967361976;7612.1246056701975;6769.323067693192;6968.0941477607585;6984.825379365557;7156.212816590067;7202.279772022755;6734.629595372302;6879.071325371211;6882.965585172042;6970.930290697231;7070.893936590853;6222.377762223741;6302.65335406557;6304.148939893055;6322;6329.715162817776;4315.266404711269;4383.912321753483;4450;4483.349914262349;4552.066826300535;4270.167317373082;4365.236083685406;4446.044100518404;4473.977630111829;4485.080558485437 18:47:31 INFO - PROCESS | 3411 | |4;prototype.html;271.033650862989;276.49125608879655;280.62676640068696;280.85957021489247;283.54774135254263;4997.2753950677225;4998.825041123561;5008.373953255843;5032.622553308503;5052.974735126324;4870.366852309195;4883.046781287487;4943.456219815817;4949.416186820219;4966.354373931384;3526.7531272810916;3651.214988777412;3690.520232369788;3845.692344612424;3849.287881741887;3822.7384962962155;3833.195029043904;3841.885853102611;3843.327417701905;3854.8265328060306;3799.9430008549894;3816.694664426839;3834.5206849143856;3835.9808200958955;3844.2695887781374;3554.8578056877695;3697.8705745299053;3719.828254099977;3786.8106594670157;3802.5627052888995;3305.3554556861422;3330.3672302262494;3336.816475093869;3344.745720354867;3353.279045005336;4744.383230180055;4750.524947505256;4750.881227969294;4759.666823322369;4811.085893680224;4279.486461624625;4286.699931004831;4347.869563913087;4376.496702879146;4391.692581519295;5118.769655365518;5124.436312005676;5130.153524668425;5147.7683504242395;5170.741462926839;3680.8159592020293;3684.5578530576504;3686.502322186497;3689.2990331836863;3699.2046709957217;5187.351581052369;5375.784968601212;5456.236126942231;5459.262999495097;5476.780928762844;3726.795026273581;3733.383991641403;3742.962570374316;3745.250949810049;3748.325301445766;3795.8102094895144;3798.145417281145;3817.2174704185577;3822.522184726909;3823.541175058955;4358.8038538265855;4365.293518018849;4368.453943257093;4376.365427013129;4387.166438376698;4884.12085824555;5133.358330208724;5152.124138896396;5174.922376164361;5212.166053431432;1264.431006047264;1277.4890043982482;1278.7762141625178;1282.1409655530817;1282.5639282643758;764.1746913333586;767.8425922685836;799.8360336131195;815.575900531732;818.1695578987333;4476.776161191992;4512.187806194851;4602.3786788783755;4606.447226332794;4623.722576645412;5270.789168433296;5296.549793267538;5308.442613525602;5324.946750532445;5371.785128594813;4411.669124815651;4590.472095708969;4595.035042641016;4597.977010114928;4611.700239484423;2766.2392841968217;2806.8877244909977;2810.7329803668617;2822.252103192656;2826.590144429046;4969.503049695001;4976.328195693607;4985.401751789808;5002.59979201663;5057.519535644108;5258.158694608845;5496.725163741797;5497.26836046644;5502.889942201134;5518.91721624176;4944.936838579651;4965.90068198634;5019.071471777733;5019.774110165052;5080.49195080489;5311.575073994149;5350.625456218183;5359.490848369399;5362.70505122222;5378.623496355218;5076.974615126901;5171.870703232449;5226.634135610623;5228.424873263862;5265.815696450606;4968;4978.556218696537;4983;4989.575886049726;4997.875053123701;3663.3405986921543;3690.55713314404;3712.8119001919126;3721.4603882437436;3730.459083432833;5036.345275114211;5354.437784032776;5358.651687640291;5360.303160589098;5370.62405631602;5193;5195.999540176984;5216.191490319006;5227.35338368428;5250.212468129811;5208.765605547836;5224.817131400383;5260.658057226268;5267.9736601316745;5273.707941554344;4859.538343857328;5116.590672746246;5145.408278047923;5191.091558977088;5209.723617713685;4964.851054468371;5073.34046573943;5148.382194136728;5238.319018527567;5239.738013099406;5105.591552675852;5123.538881500683;5133.230015497706;5133.358330208724;5155 18:47:31 INFO - PROCESS | 3411 | |5;yui.html;649.9837504062399;663.9402453779159;680.775344136435;697.9965100174499;741.1217707017183;13022.674433139176;14239.145651260931;14244.430222791101;14262.857371426282;14290;13504.662383440418;13592.116512426684;13615.319234038308;13620.931895340535;13689.794653080187;577.8815342854705;592.1709606550842;734.0530715377157;735.2904447208443;754.226917409654;757.7991832164481;764.3999460423569;765.74730338988;766.4060353226266;767.746643607611;809.8623234050197;810.9229623185818;811.2739098506833;811.3387589114882;811.3630799822141;603.405645439242;619.1301221783401;621.1459243540132;621.2203684376125;804.2158895077312;557.9079451890433;574.6896675795066;578.2049681687679;578.7598146769086;578.7945279425785;13032.934835325763;13174.67063323415;13678.110922789987;13678.794818077737;13693.931530342385;12541.686457838536;12942.158759680591;13140.802887956592;13278.800817987738;13364.732705345936;11619.593314233962;11632.941835290854;11781.175317727762;11916.582919597859;12188.207766495238;4230.788460576959;4287.882180262196;4315.568443155659;4467.642588592905;4483.865484035484;62447.687761561356;64095.35904640941;64266.03600946036;64307;65179.3482065178;10558.944404087768;10761.46192690378;10817.891821081688;10918.50866710984;11014.614488492864;19818.60362792736;19825.206991720457;19833.30583429573;19843;19859.404217873485;6578.967105164444;6641.44304442793;6805.693743781541;7032.718691252293;7077.504574679723;3703.222323312081;3732.682721968609;3751.4935483709896;3795.373763329075;3877.2439374321734;2731.617573539706;2851.7148285171734;2856.757175640094;2857.2571131505542;2857.6856545779947;476.87124476391875;482.0647942990587;484.4211167654689;486.18321220349446;491.6681240162947;440.77520464563304;528.873070463086;544.9291592093002;569.1320735877737;578.0462237308391;7725.690972361042;8049.718259860877;8092.150324215991;8110.5539195343645;8305.294050005696;519.3248776590493;546.8605505596048;549.7114015142002;554.27666894702;557.2171099605061;3921.235359105004;4160.355144952538;4183.058811767389;4268.786560671954;4289.571042895748;93137.534312328;99551.50224248832;100358.49820750995;103285;103298;59120.704396478606;87370;91106;93679;94935;72604;75705.62147189229;77563;81038.59480702558;81721;8157.265846073645;8781.780455488664;9029.187373136187;9294.442333460014;9345.252379809735;29033.7096629031;29536.704632953395;37671;38980.999999998865;39297;37532.81233593814;44548.109037818416;48754;58123.4187658118;59256.1111583318;11363.204575679623;11444.427778611203;11477.885221148015;11711.76576468483;11813.76372472563;11629.59296424621;12087.39563021863;12989.740205196033;13063.673408164492;13080.934595327342;11267.380294083903;11582.826257605973;11590.130740194687;11731.178817482694;11932.105092117952;12049.759004820029;12119.878801212228;12567.18313309632;12673.746525069262;12684;11536.769264614493;12257.938710306391;12415.130940834055;12486.25135009262;12659.493620255087;10235.795284094425;10666.98413643262;10701.090407315465;10788.460576971276;10949.288296260718;10590;10719.464026798785;11038.944805275922;11158.888411115784;11197.384143872165 18:47:31 INFO - PROCESS | 3411 | __end_tp_report 18:47:31 INFO - PROCESS | 3411 | __start_cc_report 18:47:31 INFO - PROCESS | 3411 | _x_x_mozilla_cycle_collect,1554 18:47:31 INFO - PROCESS | 3411 | __end_cc_report 18:47:31 INFO - PROCESS | 3411 | __startTimestamp1475977651267__endTimestamp 18:47:31 INFO - PROCESS | 3411 | 18:47:31 INFO - PROCESS | 3411 | ------- Summary: start ------- 18:47:31 INFO - PROCESS | 3411 | Number of tests: 6 18:47:31 INFO - PROCESS | 3411 | 18:47:31 INFO - PROCESS | 3411 | [#0] dojo.html Cycles:165 Average:4659.42 Median:4787.59 stddev:484.31 (10.1%) stddev-sans-first:457.56 18:47:31 INFO - PROCESS | 3411 | Values: 2582.1 2602.9 2636.2 2646.8 2654.1 4608.5 4681.8 4717.2 4742.7 4744.2 4708.1 4709.3 4737.6 4775.4 4822.8 4257.6 4263.2 4318.5 4332.5 4369.0 4120.2 4403.8 4405.8 4435.0 4490.3 4217.3 4395.5 4417.5 4438.0 4522.7 4261.0 4317.6 4326.8 4366.3 4390.9 4359.4 4362.2 4373.6 4415.1 4428.9 4721.6 4728.9 4752.3 4761.1 4764.5 4823.7 4880.3 4982.6 5051.6 5052.5 5048.9 5083.5 5091.6 5135.2 5141.6 4726.6 4727.7 4730.7 4730.8 4787.0 5035.8 5081.9 5106.3 5164.9 5237.7 4883.2 4893.9 4895.2 4900.6 4948.8 5020.6 5149.7 5152.6 5152.6 5162.1 4951.0 5023.8 5032.0 5051.2 5104.8 5008.2 5008.4 5018.9 5020.1 5089.5 4117.5 4150.4 4151.3 4201.7 4236.0 3713.6 3722.2 3749.4 3771.5 3787.0 4378.6 4383.0 4387.6 4389.4 4437.1 4919.0 4946.8 4979.1 5067.1 5102.2 4330.7 4371.8 4387.8 4409.2 4467.0 4549.9 4556.4 4559.9 4561.0 4609.2 4647.3 4772.8 4780.5 4796.6 4825.6 4977.2 5021.7 5079.1 5084.1 5165.5 4787.6 4788.5 4791.4 4802.3 4861.8 4981.7 5003.7 5014.7 5016.2 5062.7 4871.7 4919.1 4922.0 4973.6 4974.2 4784.2 4839.5 4840.0 4842.1 4844.2 4776.3 4778.8 4852.7 4880.1 4959.2 4829.3 4836.9 4839.4 4841.2 4884.6 4902.7 4921.3 4924.0 4924.7 4985.3 4731.3 4783.7 4824.4 4824.6 4862.6 18:47:31 INFO - PROCESS | 3411 | 18:47:31 INFO - PROCESS | 3411 | [#1] ext.html Cycles:180 Average:50158.04 Median:37535.03 stddev:107522.47 (286.5%) stddev-sans-first:107759.59 18:47:31 INFO - PROCESS | 3411 | Values: 549.2 565.6 566.6 577.3 577.9 27448.0 37960.6 39224.0 39369.0 43139.6 41613.0 42071.6 42115.6 42123.6 42134.0 7636.9 7778.2 7789.1 7790.8 7791.3 7642.0 7729.7 7731.9 7733.2 7733.3 7717.5 7779.3 7780.7 7782.8 7787.3 7696.8 7733.3 7737.3 7739.8 7745.0 7635.2 7683.0 7688.4 7690.8 7695.2 37861.6 38195.2 38236.8 38274.4 38319.2 3077.2 3297.9 3359.3 3427.8 3625.7 27800.7 28584.6 28816.4 29419.7 29705.4 3303.6 3429.2 3458.4 3542.5 3544.3 246441.0 246649.0 247789.0 247798.8 249201.0 32928.5 34423.3 54310.7 54841.2 54944.0 34353.5 34560.3 34706.7 34759.5 34760.5 12721.1 12836.6 12839.6 12842.0 12842.6 11256.9 11334.1 11342.3 11344.8 11348.7 7852.8 7888.9 7959.2 7991.2 8074.2 3066.6 3112.9 3150.7 3174.3 3178.6 805.2 861.9 862.8 886.1 920.4 26218.7 28097.3 28154.4 28264.4 28592.1 724.8 792.6 903.3 944.6 955.8 12028.8 14921.6 15170.7 15314.8 15351.5 343768.0 639194.0 649428.0 650438.0 653288.0 50694.5 50976.7 51121.0 51426.2 51533.0 1040.6 1075.6 1136.8 1173.6 1188.7 27575.0 29056.6 29592.0 29769.3 29997.7 41776.0 42461.4 42463.0 42491.0 42529.8 239576.0 240905.0 241040.0 242558.0 243355.0 38653.4 39023.4 39153.6 40191.4 42241.0 40555.0 42671.0 42799.0 42932.6 43015.4 36048.6 36403.6 36566.5 36634.8 37598.2 34962.7 37096.4 37313.0 37471.8 37706.6 36353.0 36950.0 36995.3 37381.4 37675.8 31894.4 33864.8 34191.8 34707.0 34812.5 25453.5 26034.0 26081.7 26158.5 26266.6 18:47:31 INFO - PROCESS | 3411 | 18:47:31 INFO - PROCESS | 3411 | [#2] jquery.html Cycles:180 Average:22500.91 Median:25421.51 stddev:57422.47 (225.9%) stddev-sans-first:57559.43 18:47:31 INFO - PROCESS | 3411 | Values: 333.6 346.7 353.6 356.8 380.7 12091.6 15399.3 16141.2 16230.8 17096.9 16239.4 16251.7 16389.6 16611.9 17168.0 4038.5 4984.4 5006.0 5218.4 5226.0 5059.5 5200.5 5204.7 5204.8 5211.6 4954.7 5166.6 5167.8 5169.1 5171.7 5074.1 5111.7 5114.0 5132.9 5163.9 4361.8 4618.8 4621.2 4624.5 4626.7 20253.8 20315.7 20395.8 20614.6 20625.3 1719.7 1791.2 1909.5 1946.5 2045.3 8954.9 10429.2 12829.0 13222.5 13621.2 1688.7 1760.9 1763.3 1795.4 1828.2 67297.0 67839.3 67973.0 68212.7 68986.7 9696.0 10027.2 10027.6 10247.9 10327.5 13939.0 13942.5 13958.4 13966.7 13982.0 7014.4 7360.2 7387.6 7516.1 7579.6 6998.3 7050.3 7267.9 7309.5 7348.7 4233.8 4236.0 4280.8 4385.4 4494.5 1781.5 1806.6 1809.8 1853.0 1876.0 817.6 818.3 822.6 835.9 859.6 16062.4 16358.8 16580.4 17317.2 17531.1 833.2 845.4 850.3 859.1 873.5 9180.2 9775.3 9852.9 9855.8 9868.5 340265.0 344814.0 346791.0 348665.0 358020.0 41706.6 47170.5 74431.6 74503.6 75250.0 772.7 809.8 869.5 926.6 931.4 14078.5 15283.2 16296.3 16490.4 16533.8 36702.0 36732.0 36986.4 37631.4 37871.8 46221.8 48114.8 48157.0 48195.0 50046.5 4314.6 7514.0 7591.2 7604.1 8037.0 8872.8 10728.7 10840.5 10938.4 11640.1 9680.3 9735.7 9894.6 10045.1 10411.0 4428.6 9625.4 9716.8 10027.9 10207.8 9630.2 9737.4 9954.8 10061.9 10181.0 7477.6 7516.8 7659.5 7812.1 7821.8 9121.9 9892.2 9969.0 9985.8 10070.7 18:47:31 INFO - PROCESS | 3411 | 18:47:31 INFO - PROCESS | 3411 | [#3] mootools.html Cycles:180 Average:5052.05 Median:3400.74 stddev:2863.18 (84.2%) stddev-sans-first:2857.66 18:47:31 INFO - PROCESS | 3411 | Values: 1345.8 1379.7 1426.7 1633.9 1687.8 6889.7 7180.4 7360.2 7967.4 7976.6 7266.6 7583.7 7608.4 7940.8 7941.7 2094.0 2134.7 2139.6 2147.5 2153.8 1774.8 1844.6 2135.1 2166.5 2196.4 2011.3 2069.4 2076.9 2086.4 2087.1 2097.6 2115.3 2115.9 2123.3 2125.6 2124.4 2141.3 2141.4 2146.0 2146.8 7904.5 7967.5 7978.1 7995.6 8000.5 4082.2 4128.2 4146.8 4165.5 4249.6 2669.9 2745.3 2791.3 2793.3 2802.4 898.7 904.0 922.8 935.8 945.8 9895.0 9897.2 9921.1 9948.4 9968.3 3646.3 3746.2 3857.8 3920.1 3927.8 8618.3 8621.7 8630.5 8633.3 8635.4 4231.8 4236.8 4238.3 4253.3 4254.1 3859.6 3865.8 3866.4 3868.7 3872.7 3475.6 3618.0 3674.4 3681.8 3855.6 1051.0 1077.2 1115.4 1182.7 1191.1 579.1 768.0 798.2 806.2 811.4 5047.2 5105.2 5175.5 5240.9 5276.0 811.0 853.4 860.6 860.7 895.3 3447.6 3468.2 3484.9 3496.7 3518.6 9018.9 9609.6 9628.9 9635.4 9651.2 8880.7 9183.3 9343.9 9537.5 9655.6 7192.7 7401.5 7405.0 7417.4 7423.2 5246.5 5348.3 5472.0 5498.3 5664.5 9002.6 9074.3 9265.3 9359.0 9376.9 8468.5 8840.1 8842.5 9392.8 9395.6 6790.9 6955.5 6957.1 6963.5 6966.1 7540.0 7571.2 7599.6 7600.5 7612.1 6769.3 6968.1 6984.8 7156.2 7202.3 6734.6 6879.1 6883.0 6970.9 7070.9 6222.4 6302.7 6304.1 6322.0 6329.7 4315.3 4383.9 4450.0 4483.3 4552.1 4270.2 4365.2 4446.0 4474.0 4485.1 18:47:31 INFO - PROCESS | 3411 | 18:47:31 INFO - PROCESS | 3411 | [#4] prototype.html Cycles:180 Average:4281.43 Median:4947.18 stddev:1268.38 (25.6%) stddev-sans-first:1235.71 18:47:31 INFO - PROCESS | 3411 | Values: 271.0 276.5 280.6 280.9 283.5 4997.3 4998.8 5008.4 5032.6 5053.0 4870.4 4883.0 4943.5 4949.4 4966.4 3526.8 3651.2 3690.5 3845.7 3849.3 3822.7 3833.2 3841.9 3843.3 3854.8 3799.9 3816.7 3834.5 3836.0 3844.3 3554.9 3697.9 3719.8 3786.8 3802.6 3305.4 3330.4 3336.8 3344.7 3353.3 4744.4 4750.5 4750.9 4759.7 4811.1 4279.5 4286.7 4347.9 4376.5 4391.7 5118.8 5124.4 5130.2 5147.8 5170.7 3680.8 3684.6 3686.5 3689.3 3699.2 5187.4 5375.8 5456.2 5459.3 5476.8 3726.8 3733.4 3743.0 3745.3 3748.3 3795.8 3798.1 3817.2 3822.5 3823.5 4358.8 4365.3 4368.5 4376.4 4387.2 4884.1 5133.4 5152.1 5174.9 5212.2 1264.4 1277.5 1278.8 1282.1 1282.6 764.2 767.8 799.8 815.6 818.2 4476.8 4512.2 4602.4 4606.4 4623.7 5270.8 5296.5 5308.4 5324.9 5371.8 4411.7 4590.5 4595.0 4598.0 4611.7 2766.2 2806.9 2810.7 2822.3 2826.6 4969.5 4976.3 4985.4 5002.6 5057.5 5258.2 5496.7 5497.3 5502.9 5518.9 4944.9 4965.9 5019.1 5019.8 5080.5 5311.6 5350.6 5359.5 5362.7 5378.6 5077.0 5171.9 5226.6 5228.4 5265.8 4968.0 4978.6 4983.0 4989.6 4997.9 3663.3 3690.6 3712.8 3721.5 3730.5 5036.3 5354.4 5358.7 5360.3 5370.6 5193.0 5196.0 5216.2 5227.4 5250.2 5208.8 5224.8 5260.7 5268.0 5273.7 4859.5 5116.6 5145.4 5191.1 5209.7 4964.9 5073.3 5148.4 5238.3 5239.7 5105.6 5123.5 5133.2 5133.4 5155.0 18:47:31 INFO - PROCESS | 3411 | 18:47:31 INFO - PROCESS | 3411 | [#5] yui.html Cycles:180 Average:17633.70 Median:4171.71 stddev:25225.46 (604.7%) stddev-sans-first:25263.99 18:47:31 INFO - PROCESS | 3411 | Values: 650.0 663.9 680.8 698.0 741.1 13022.7 14239.1 14244.4 14262.9 14290.0 13504.7 13592.1 13615.3 13620.9 13689.8 577.9 592.2 734.1 735.3 754.2 757.8 764.4 765.7 766.4 767.7 809.9 810.9 811.3 811.3 811.4 603.4 619.1 621.1 621.2 804.2 557.9 574.7 578.2 578.8 578.8 13032.9 13174.7 13678.1 13678.8 13693.9 12541.7 12942.2 13140.8 13278.8 13364.7 11619.6 11632.9 11781.2 11916.6 12188.2 4230.8 4287.9 4315.6 4467.6 4483.9 62447.7 64095.4 64266.0 64307.0 65179.3 10558.9 10761.5 10817.9 10918.5 11014.6 19818.6 19825.2 19833.3 19843.0 19859.4 6579.0 6641.4 6805.7 7032.7 7077.5 3703.2 3732.7 3751.5 3795.4 3877.2 2731.6 2851.7 2856.8 2857.3 2857.7 476.9 482.1 484.4 486.2 491.7 440.8 528.9 544.9 569.1 578.0 7725.7 8049.7 8092.2 8110.6 8305.3 519.3 546.9 549.7 554.3 557.2 3921.2 4160.4 4183.1 4268.8 4289.6 93137.5 99551.5 100358.5 103285.0 103298.0 59120.7 87370.0 91106.0 93679.0 94935.0 72604.0 75705.6 77563.0 81038.6 81721.0 8157.3 8781.8 9029.2 9294.4 9345.3 29033.7 29536.7 37671.0 38981.0 39297.0 37532.8 44548.1 48754.0 58123.4 59256.1 11363.2 11444.4 11477.9 11711.8 11813.8 11629.6 12087.4 12989.7 13063.7 13080.9 11267.4 11582.8 11590.1 11731.2 11932.1 12049.8 12119.9 12567.2 12673.7 12684.0 11536.8 12257.9 12415.1 12486.3 12659.5 10235.8 10667.0 10701.1 10788.5 10949.3 10590.0 10719.5 11038.9 11158.9 11197.4 18:47:31 INFO - PROCESS | 3411 | -------- Summary: end -------- 18:47:31 INFO - PROCESS | 3411 | 18:47:32 INFO - TEST-INFO | 3411: exit 0 18:47:32 INFO - TEST-OK | dromaeo_css | took 1127054ms 18:47:32 INFO - TEST-START | kraken 18:47:32 INFO - operating with platform_type : linux_ 18:47:32 INFO - Initialising browser for kraken test... 18:47:32 INFO - TEST-INFO | started process 3719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbGKi3C/profile http://localhost:46417/getInfo.html) 18:47:37 INFO - PROCESS | 3719 | __metrics Screen width/height:1600/1200 18:47:37 INFO - PROCESS | 3719 | colorDepth:24 18:47:37 INFO - PROCESS | 3719 | Browser inner width/height: 1024/697 18:47:37 INFO - PROCESS | 3719 | __metrics 18:47:38 INFO - PROCESS | 3719 | 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" 18:47:38 INFO - PROCESS | 3719 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:47:39 INFO - PROCESS | 3719 | console.error: PushService: 18:47:39 INFO - PROCESS | 3719 | stateChangeProcessEnqueue: Error transitioning state 18:47:39 INFO - PROCESS | 3719 | UnknownError 18:47:39 INFO - TEST-INFO | 3719: exit 0 18:47:39 INFO - Browser initialized. 18:47:39 INFO - Running cycle 1/1 for kraken test... 18:47:39 INFO - TEST-INFO | started process 3803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbGKi3C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:47:52 INFO - PROCESS | 3803 | RSS: Main: 174497792 18:47:52 INFO - PROCESS | 3803 | 18:47:54 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46417/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46417/tests/kraken/driver.html?testName=audio-beat-detection) 18:47:55 INFO - PROCESS | 3803 | RSS: Main: 241913856 18:47:55 INFO - PROCESS | 3803 | 18:47:58 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46417/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46417/tests/kraken/driver.html?testName=audio-dft) 18:47:59 INFO - PROCESS | 3803 | RSS: Main: 218091520 18:47:59 INFO - PROCESS | 3803 | 18:48:02 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46417/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46417/tests/kraken/driver.html?testName=audio-fft) 18:48:03 INFO - PROCESS | 3803 | RSS: Main: 300601344 18:48:03 INFO - PROCESS | 3803 | 18:48:05 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46417/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46417/tests/kraken/driver.html?testName=audio-oscillator) 18:48:05 INFO - PROCESS | 3803 | RSS: Main: 209104896 18:48:05 INFO - PROCESS | 3803 | 18:48:08 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46417/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46417/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:48:08 INFO - PROCESS | 3803 | RSS: Main: 214048768 18:48:08 INFO - PROCESS | 3803 | 18:48:11 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46417/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46417/tests/kraken/driver.html?testName=imaging-darkroom) 18:48:12 INFO - PROCESS | 3803 | RSS: Main: 250449920 18:48:12 INFO - PROCESS | 3803 | 18:48:16 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46417/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46417/tests/kraken/driver.html?testName=imaging-desaturate) 18:48:16 INFO - PROCESS | 3803 | RSS: Main: 243712000 18:48:16 INFO - PROCESS | 3803 | 18:48:19 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46417/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46417/tests/kraken/driver.html?testName=json-parse-financial) 18:48:20 INFO - PROCESS | 3803 | RSS: Main: 246738944 18:48:20 INFO - PROCESS | 3803 | 18:48:21 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46417/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46417/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:48:22 INFO - PROCESS | 3803 | RSS: Main: 210071552 18:48:22 INFO - PROCESS | 3803 | 18:48:24 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46417/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46417/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:48:25 INFO - PROCESS | 3803 | RSS: Main: 218292224 18:48:25 INFO - PROCESS | 3803 | 18:48:27 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46417/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46417/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:48:27 INFO - PROCESS | 3803 | RSS: Main: 226443264 18:48:27 INFO - PROCESS | 3803 | 18:48:30 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46417/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46417/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:48:31 INFO - PROCESS | 3803 | RSS: Main: 235536384 18:48:31 INFO - PROCESS | 3803 | 18:48:34 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46417/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46417/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:48:35 INFO - PROCESS | 3803 | RSS: Main: 232468480 18:48:35 INFO - PROCESS | 3803 | 18:48:36 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46417/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46417/tests/kraken/driver.html?testName=ai-astar) 18:48:37 INFO - PROCESS | 3803 | RSS: Main: 282542080 18:48:37 INFO - PROCESS | 3803 | 18:48:37 INFO - PROCESS | 3803 | __start_tp_report 18:48:37 INFO - PROCESS | 3803 | _x_x_mozilla_page_load 18:48:37 INFO - PROCESS | 3803 | _x_x_mozilla_page_load_details 18:48:37 INFO - PROCESS | 3803 | |i|pagename|runs| 18:48:37 INFO - PROCESS | 3803 | |0;ai-astar;111;117;114;113;113;114;114;113;114;114 18:48:37 INFO - PROCESS | 3803 | |1;audio-beat-detection;155;130;125;166;138;133;129;125;164;127 18:48:37 INFO - PROCESS | 3803 | |2;audio-dft;162;161;161;162;161;161;161;163;164;160 18:48:37 INFO - PROCESS | 3803 | |3;audio-fft;76;78;75;113;75;77;78;78;97;76 18:48:37 INFO - PROCESS | 3803 | |4;audio-oscillator;82;85;116;83;83;83;109;82;82;122 18:48:37 INFO - PROCESS | 3803 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 18:48:37 INFO - PROCESS | 3803 | |6;imaging-darkroom;147;147;146;146;148;148;147;146;146;146 18:48:37 INFO - PROCESS | 3803 | |7;imaging-desaturate;95;94;95;95;94;96;95;95;96;95 18:48:37 INFO - PROCESS | 3803 | |8;json-parse-financial;65;63;65;64;64;65;65;63;64;64 18:48:37 INFO - PROCESS | 3803 | |9;json-stringify-tinderbox;65;72;65;65;68;66;66;65;66;66 18:48:37 INFO - PROCESS | 3803 | |10;stanford-crypto-aes;82;81;84;82;82;83;83;92;82;87 18:48:37 INFO - PROCESS | 3803 | |11;stanford-crypto-ccm;147;139;150;139;139;149;138;151;178;138 18:48:37 INFO - PROCESS | 3803 | |12;stanford-crypto-pbkdf2;175;177;171;173;174;174;173;174;171;174 18:48:37 INFO - PROCESS | 3803 | |13;stanford-crypto-sha256-iterative;69;69;71;68;71;70;69;70;68;71 18:48:37 INFO - PROCESS | 3803 | __end_tp_report 18:48:37 INFO - PROCESS | 3803 | __start_cc_report 18:48:37 INFO - PROCESS | 3803 | _x_x_mozilla_cycle_collect,1927 18:48:37 INFO - PROCESS | 3803 | __end_cc_report 18:48:37 INFO - PROCESS | 3803 | __startTimestamp1475977717021__endTimestamp 18:48:37 INFO - PROCESS | 3803 | 18:48:37 INFO - PROCESS | 3803 | ------- Summary: start ------- 18:48:37 INFO - PROCESS | 3803 | Number of tests: 14 18:48:37 INFO - PROCESS | 3803 | 18:48:37 INFO - PROCESS | 3803 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:1.49 (1.3%) stddev-sans-first:1.22 18:48:37 INFO - PROCESS | 3803 | Values: 111.0 117.0 114.0 113.0 113.0 114.0 114.0 113.0 114.0 114.0 18:48:37 INFO - PROCESS | 3803 | 18:48:37 INFO - PROCESS | 3803 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:135.50 stddev:16.21 (12.0%) stddev-sans-first:16.15 18:48:37 INFO - PROCESS | 3803 | Values: 155.0 130.0 125.0 166.0 138.0 133.0 129.0 125.0 164.0 127.0 18:48:37 INFO - PROCESS | 3803 | 18:48:37 INFO - PROCESS | 3803 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.24 18:48:37 INFO - PROCESS | 3803 | Values: 162.0 161.0 161.0 162.0 161.0 161.0 161.0 163.0 164.0 160.0 18:48:37 INFO - PROCESS | 3803 | 18:48:37 INFO - PROCESS | 3803 | [#3] audio-fft Cycles:10 Average:82.30 Median:77.50 stddev:12.60 (16.3%) stddev-sans-first:13.15 18:48:37 INFO - PROCESS | 3803 | Values: 76.0 78.0 75.0 113.0 75.0 77.0 78.0 78.0 97.0 76.0 18:48:37 INFO - PROCESS | 3803 | 18:48:37 INFO - PROCESS | 3803 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:82.50 stddev:16.17 (19.6%) stddev-sans-first:16.68 18:48:37 INFO - PROCESS | 3803 | Values: 82.0 85.0 116.0 83.0 83.0 83.0 109.0 82.0 82.0 122.0 18:48:37 INFO - PROCESS | 3803 | 18:48:37 INFO - PROCESS | 3803 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:48:37 INFO - PROCESS | 3803 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 18:48:37 INFO - PROCESS | 3803 | 18:48:37 INFO - PROCESS | 3803 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 18:48:37 INFO - PROCESS | 3803 | Values: 147.0 147.0 146.0 146.0 148.0 148.0 147.0 146.0 146.0 146.0 18:48:37 INFO - PROCESS | 3803 | 18:48:37 INFO - PROCESS | 3803 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 18:48:37 INFO - PROCESS | 3803 | Values: 95.0 94.0 95.0 95.0 94.0 96.0 95.0 95.0 96.0 95.0 18:48:37 INFO - PROCESS | 3803 | 18:48:37 INFO - PROCESS | 3803 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 18:48:37 INFO - PROCESS | 3803 | Values: 65.0 63.0 65.0 64.0 64.0 65.0 65.0 63.0 64.0 64.0 18:48:37 INFO - PROCESS | 3803 | 18:48:37 INFO - PROCESS | 3803 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.00 stddev:2.17 (3.3%) stddev-sans-first:2.24 18:48:37 INFO - PROCESS | 3803 | Values: 65.0 72.0 65.0 65.0 68.0 66.0 66.0 65.0 66.0 66.0 18:48:37 INFO - PROCESS | 3803 | 18:48:37 INFO - PROCESS | 3803 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.00 stddev:3.33 (4.0%) stddev-sans-first:3.46 18:48:37 INFO - PROCESS | 3803 | Values: 82.0 81.0 84.0 82.0 82.0 83.0 83.0 92.0 82.0 87.0 18:48:37 INFO - PROCESS | 3803 | 18:48:37 INFO - PROCESS | 3803 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:148.00 stddev:12.22 (8.3%) stddev-sans-first:12.96 18:48:37 INFO - PROCESS | 3803 | Values: 147.0 139.0 150.0 139.0 139.0 149.0 138.0 151.0 178.0 138.0 18:48:37 INFO - PROCESS | 3803 | 18:48:37 INFO - PROCESS | 3803 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:174.00 stddev:1.78 (1.0%) stddev-sans-first:1.81 18:48:37 INFO - PROCESS | 3803 | Values: 175.0 177.0 171.0 173.0 174.0 174.0 173.0 174.0 171.0 174.0 18:48:37 INFO - PROCESS | 3803 | 18:48:37 INFO - PROCESS | 3803 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:1.17 (1.7%) stddev-sans-first:1.22 18:48:37 INFO - PROCESS | 3803 | Values: 69.0 69.0 71.0 68.0 71.0 70.0 69.0 70.0 68.0 71.0 18:48:37 INFO - PROCESS | 3803 | -------- Summary: end -------- 18:48:37 INFO - PROCESS | 3803 | 18:48:38 INFO - TEST-INFO | 3803: exit 0 18:48:38 INFO - TEST-OK | kraken | took 66117ms 18:48:38 INFO - SUITE-END | took 1193s 18:48:38 INFO - Completed test suite (00:19:53) 18:48:38 INFO - javascript benchmark 18:48:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2582.1349847800984, 2602.869856507174, 2636.2223144172467, 2646.7750241229505, 2654.0710751237057, 4608.493065762764, 4681.789319480623, 4717.150912835693, 4742.691725037875, 4744.240921452564, 4708.128996135717, 4709.27006314021, 4737.644676649256, 4775.403074615673, 4822.758862056892, 4257.574242575749, 4263.168682106991, 4318.5033721122, 4332.545082766312, 4369.0, 4120.17596480705, 4403.779811009436, 4405.80173892174, 4434.977825110886, 4490.348899409583, 4217.283061879488, 4395.538468460798, 4417.4919884213405, 4438.045820148667, 4522.68341216115, 4260.957390426087, 4317.568243175658, 4326.783660816978, 4366.323219900921, 4390.8902277443, 4359.367891655724, 4362.2366085935155, 4373.562643735633, 4415.139047885664, 4428.889277768049, 4721.598664113554, 4728.929066064012, 4752.263399173134, 4761.095391875532, 4764.452088009889, 4823.734694591796, 4880.316755654211, 4982.60139188864, 5051.621128415383, 5052.545270925598, 5048.924266136011, 5083.542481176712, 5091.618128640367, 5135.178371460548, 5141.6143789215585, 4726.550977657117, 4727.669063165546, 4730.739809310521, 4730.763461826895, 4786.95213047872, 5035.84892453227, 5081.898362032739, 5106.336176297132, 5164.92252616211, 5237.711925844039, 4883.218685010382, 4893.877653058702, 4895.167821470359, 4900.632452566072, 4948.826791062295, 5020.648554601143, 5149.742512874342, 5152.587792976553, 5152.639315247971, 5162.070827251131, 4951.034548263054, 5023.799048038038, 5032.0, 5051.217061355495, 5104.821331253388, 5008.173651347487, 5008.398992120969, 5018.899622007612, 5020.146575082244, 5089.541941225233, 4117.505899292104, 4150.418941348214, 4151.294279972351, 4201.68487363449, 4235.97882010588, 3713.628637136319, 3722.181120153562, 3749.4000959846294, 3771.453139294787, 3787.0, 4378.627816635558, 4383.0, 4387.648988080946, 4389.429374181336, 4437.134758722018, 4919.0407870464915, 4946.802127914843, 4979.128652485801, 5067.113255180402, 5102.158143906214, 4330.696851220384, 4371.846985355497, 4387.802548885308, 4409.162259170747, 4467.0, 4549.931751023737, 4556.407667003268, 4559.863204103882, 4560.95439045612, 4609.1703493371515, 4647.349371088118, 4772.761361931959, 4780.4741478436645, 4796.640251981115, 4825.638077144228, 4977.228529577921, 5021.6735912165595, 5079.136546787129, 5084.084864724385, 5165.509276618715, 4787.593054590259, 4788.5211478853225, 4791.448983366958, 4802.327674125695, 4861.781219845045, 4981.701097934136, 5003.674761140514, 5014.724190169576, 5016.197408414636, 5062.721550314768, 4871.683340582851, 4919.065377578248, 4922.040202160544, 4973.552380285647, 4974.204127339608, 4784.234522476387, 4839.540243676845, 4840.0, 4842.104210721028, 4844.249141383091, 4776.283557466408, 4778.7849546769785, 4852.660313778002, 4880.1215781159735, 4959.156943319716, 4829.323894654681, 4836.879078023077, 4839.41926968766, 4841.201201801663, 4884.633652476007, 4902.7058376497525, 4921.311016457627, 4924.03981223658, 4924.679895806761, 4985.277134815504, 4731.266653668687, 4783.689060211075, 4824.396950381202, 4824.638152138534, 4862.562369386772], "value": 4628.6066841485, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.1515608385045, 565.6153815405523, 566.5920537213206, 577.3072313224133, 577.898867698153, 27448.0, 37960.62039379605, 39224.0, 39369.0, 43139.56860431395, 41613.0, 42071.579284207146, 42115.57884421155, 42123.57876421235, 42134.0, 7636.885446718304, 7778.222177782205, 7789.065312162548, 7790.805229869242, 7791.337736292422, 7641.9617901910415, 7729.652165652531, 7731.922680773205, 7733.22667733225, 7733.304002639761, 7717.459777815555, 7779.2998630123275, 7780.727674531393, 7782.805429864242, 7787.299143077122, 7696.807579810494, 7733.342665873408, 7737.264959828807, 7739.7678069658, 7744.9931508903765, 7635.236476352376, 7683.039620047494, 7688.384929205706, 7690.846183076363, 7695.192004839467, 37861.621383786085, 38195.23609527822, 38236.80881595602, 38274.425883611766, 38319.233615327816, 3077.1691643256418, 3297.917552061194, 3359.277755282626, 3427.7600567960253, 3625.6918161956264, 27800.721992780014, 28584.571231431546, 28816.423671526663, 29419.70580294191, 29705.40589188204, 3303.636599974001, 3429.176997520602, 3458.4466485362473, 3542.4509201073874, 3544.3088597723454, 246441.0, 246649.0, 247789.0, 247798.76100619562, 249201.0, 32928.506072408934, 34423.311533769185, 54310.72844635751, 54841.177382339294, 54944.0, 34353.48469772955, 34560.308793823984, 34706.65293347085, 34759.52404759504, 34760.47859282113, 12721.109522333349, 12836.55072072473, 12839.550615728405, 12842.0, 12842.550510732079, 11256.943715281372, 11334.149938754626, 11342.262752921033, 11344.829827552594, 11348.716282093013, 7852.803679908048, 7888.881666775003, 7959.164287749819, 7991.200879911962, 8074.192580741997, 3066.6013418255484, 3112.937741245162, 3150.6534281229046, 3174.2540502981783, 3178.6026746656667, 805.2068712318362, 861.9439736417113, 862.7584276402617, 886.1050339157497, 920.3695468604028, 26218.73781262201, 28097.297567560974, 28154.43691126166, 28264.43471130607, 28592.14223573296, 724.8187953011748, 792.5680504125265, 903.2503022491317, 944.5607792376578, 955.8040601676639, 12028.752236895989, 14921.552353429197, 15170.696586068218, 15314.846851531565, 15351.539453816404, 343768.0, 639194.0, 649428.0, 650438.0, 653288.0, 50694.49305506972, 50976.74511627418, 51121.0, 51426.228606570934, 51533.0, 1040.6305761454726, 1075.5751478166237, 1136.812425949709, 1173.5892437646755, 1188.6909403554964, 27575.0, 29056.56415153732, 29592.0, 29769.25576860596, 29997.700022999492, 41776.0, 42461.363079553215, 42463.0, 42491.0, 42529.78735106428, 239576.0, 240905.0, 241040.0, 242558.0, 243355.0, 38653.420198697604, 39023.414648779726, 39153.608463915, 40191.397129043675, 42241.0, 40555.0, 42671.0, 42799.0, 42932.570674294104, 43015.35476967911, 36048.63951360558, 36403.63596364002, 36566.45150322694, 36634.8168259157, 37598.248035038596, 34962.65037349594, 37096.44355334618, 37313.0, 37471.81264093662, 37706.62293377141, 36353.0, 36950.0, 36995.26009479849, 37381.439278410304, 37675.81162094282, 31894.36211275715, 33864.83067584646, 34191.829040855635, 34707.0, 34812.477812833335, 25453.490930180924, 26034.0, 26081.73918260869, 26158.476830462903, 26266.606000909618], "value": 16698.953924982827, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.6263385008788, 346.6897127071271, 353.59160170003656, 356.8447725239521, 380.6840322532299, 12091.576794812183, 15399.307031183596, 16141.192940352994, 16230.756538651929, 17096.914515427437, 16239.431619893307, 16251.674966500663, 16389.5902602435, 16611.91694041531, 17168.0, 4038.4749982502235, 4984.352034235553, 5006.0, 5218.425973142951, 5225.973870130644, 5059.544640982311, 5200.531952124308, 5204.661696989702, 5204.765785539641, 5211.557017653504, 4954.702717836942, 5166.586673066165, 5167.7932882684645, 5169.121249387595, 5171.663841850286, 5074.137396642561, 5111.744412779346, 5113.974430127825, 5132.923006154911, 5163.870903227431, 4361.781910904442, 4618.838340658061, 4621.168189725848, 4624.5144259852905, 4626.699264547794, 20253.797462025486, 20315.695264571044, 20395.796042039685, 20614.5877082459, 20625.278115265894, 1719.7076496995417, 1791.2118667786262, 1909.5130741660787, 1946.4939115829845, 2045.3045964372036, 8954.910450895473, 10429.21780866438, 12829.0, 13222.471101155943, 13621.182729036289, 1688.7456737080743, 1760.8943463392109, 1763.312308199803, 1795.4344381519911, 1828.2138680367436, 67297.0, 67839.3216067838, 67972.9999999995, 68212.6589367055, 68986.65506672434, 9696.0, 10027.197824174049, 10027.598896044077, 10247.897521024843, 10327.483625818679, 13939.0, 13942.512012079529, 13958.441662333596, 13966.650833729238, 13982.0, 7014.403775679124, 7360.190379058299, 7387.556746595222, 7516.135644400964, 7579.621018949141, 6998.265182155902, 7050.330218629222, 7267.854642907112, 7309.488335816548, 7348.669309881068, 4233.830646774156, 4235.97882010588, 4280.807363668642, 4385.407969924083, 4494.505604383515, 1781.5278951077976, 1806.5844855683004, 1809.7556829827804, 1852.9629407411776, 1876.0432179588236, 817.5830326533511, 818.3453237410048, 822.5558198572704, 835.9456635318685, 859.5702148925537, 16062.437814676665, 16358.83641163597, 16580.419685310957, 17317.220725067404, 17531.123443827757, 833.2460171339364, 845.3955421873267, 850.3409857360595, 859.0507489224317, 873.4715497124275, 9180.20003898804, 9775.315727898978, 9852.852207216898, 9855.753606159904, 9868.506574671237, 340265.0, 344814.0, 346791.0, 348665.0, 358020.0, 41706.582934170874, 47170.52829471661, 74431.62784186153, 74503.62748186225, 75250.0, 772.7372693284198, 809.7813590330578, 869.5391442535466, 926.6478738079487, 931.3945935142211, 14078.507252246121, 15283.155554445393, 16296.348146074024, 16490.422835200712, 16533.751993720343, 36702.0, 36732.0, 36986.44520332251, 37631.43552846655, 37871.81064094662, 46221.84445388892, 48114.75942620265, 48157.0, 48195.0, 50046.499535004186, 4314.6339406626375, 7514.0, 7591.164971853203, 7604.125525564631, 8036.9953755780525, 8872.778180545538, 10728.73178170552, 10840.5121769519, 10938.398388088413, 11640.126990475579, 9680.322377433513, 9735.659251926432, 9894.554745036347, 10045.146162575971, 10411.0, 4428.623566996841, 9625.374350667184, 9716.805663886824, 10027.899721002697, 10207.805321855836, 9630.229581633592, 9737.367071140636, 9954.800903982024, 10061.949690251502, 10181.0, 7477.626118694152, 7516.774496765106, 7659.502132361602, 7812.140664526783, 7821.843563128592, 9121.908780912107, 9892.208623310262, 9968.950155249177, 9985.800283994135, 10070.69787906364], "value": 7952.717504904564, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.7644912140372, 1379.6826729852135, 1426.7146570685866, 1633.9379403387804, 1687.7974643042837, 6889.689963951621, 7180.353768160864, 7360.190379058306, 7967.362610991121, 7976.601169941494, 7266.636668166584, 7583.696652133922, 7608.429367797409, 7940.76177714668, 7941.722039728611, 2093.968590471144, 2134.7331583552054, 2139.5934772393275, 2147.5168087180336, 2153.827693784501, 1774.751534785131, 1844.5849683821168, 2135.1459416233474, 2166.458385403649, 2196.3959911024435, 2011.2960463837685, 2069.4102180878454, 2076.8546201765885, 2086.3636590839787, 2087.092114930003, 2097.5595125023765, 2115.270231770037, 2115.9153633854626, 2123.299311227291, 2125.5748850230016, 2124.373309873591, 2141.29337318686, 2141.4046535331277, 2145.967810482844, 2146.8175205107586, 7904.486208396436, 7967.521948683097, 7978.122406535276, 7995.600219988977, 8000.519968801832, 4082.163156552929, 4128.195001974616, 4146.834126634961, 4165.520965089023, 4249.6387807036435, 2669.919902402931, 2745.258780129374, 2791.2742686901347, 2793.329600895791, 2802.383475635357, 898.734873212404, 904.0462312260562, 922.7508572685338, 935.7707361696359, 945.8392073347547, 9895.0, 9897.208223342115, 9921.107100361001, 9948.403095814274, 9968.252381071376, 3646.3072016316814, 3746.157114649182, 3857.8071096445065, 3920.0591857953887, 3927.8036098194975, 8618.310535157172, 8621.655133794704, 8630.5253211074, 8633.309335253165, 8635.438696484709, 4231.7672528010635, 4236.830526778956, 4238.3006803877015, 4253.298205796071, 4254.127903779718, 3859.55615104261, 3865.8067096645054, 3866.4007078902814, 3868.709846761504, 3872.6514613684903, 3475.5829300483597, 3617.963820361763, 3674.412094064937, 3681.7790932544135, 3855.633714797146, 1051.0, 1077.159815344033, 1115.4478533126155, 1182.6629410617932, 1191.106669997502, 579.0937183308109, 767.9692812287446, 798.1898373151256, 806.2340776262574, 811.4157806379397, 5047.192449208109, 5105.234214867725, 5175.4824517548695, 5240.9213861792105, 5276.0, 810.9594520273963, 853.3940901959554, 860.6342304520554, 860.7245681381897, 895.3016647015338, 3447.5690538682666, 3468.2196505785996, 3484.91287717804, 3496.7027802636553, 3518.648135186461, 9018.86471702925, 9609.615615375447, 9628.9037109628, 9635.373700709431, 9651.179649729711, 8880.73357799267, 9183.311251656152, 9343.859842102374, 9537.523123843781, 9655.613775449045, 7192.748253811092, 7401.48189626721, 7405.0, 7417.406607471389, 7423.220561840929, 5246.475352464723, 5348.251244825806, 5471.972640136773, 5498.3127109111365, 5664.518515926027, 9002.63989440415, 9074.274058075207, 9265.258779297776, 9358.953205233931, 9376.859347109936, 8468.534230617375, 8840.115988401109, 8842.513661748666, 9392.812143757223, 9395.577199025924, 6790.898136527857, 6955.547889387173, 6957.060796792571, 6963.477739169683, 6966.059581956573, 7540.0, 7571.242875712384, 7599.620018998918, 7600.543967361976, 7612.1246056701975, 6769.323067693192, 6968.0941477607585, 6984.825379365557, 7156.212816590067, 7202.279772022755, 6734.629595372302, 6879.071325371211, 6882.965585172042, 6970.930290697231, 7070.893936590853, 6222.377762223741, 6302.65335406557, 6304.148939893055, 6322.0, 6329.715162817776, 4315.266404711269, 4383.912321753483, 4450.0, 4483.349914262349, 4552.066826300535, 4270.167317373082, 4365.236083685406, 4446.044100518404, 4473.977630111829, 4485.080558485437], "value": 4042.594537641707, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [271.033650862989, 276.49125608879655, 280.62676640068696, 280.85957021489247, 283.54774135254263, 4997.2753950677225, 4998.825041123561, 5008.373953255843, 5032.622553308503, 5052.974735126324, 4870.366852309195, 4883.046781287487, 4943.456219815817, 4949.416186820219, 4966.354373931384, 3526.7531272810916, 3651.214988777412, 3690.520232369788, 3845.692344612424, 3849.287881741887, 3822.7384962962155, 3833.195029043904, 3841.885853102611, 3843.327417701905, 3854.8265328060306, 3799.9430008549894, 3816.694664426839, 3834.5206849143856, 3835.9808200958955, 3844.2695887781374, 3554.8578056877695, 3697.8705745299053, 3719.828254099977, 3786.8106594670157, 3802.5627052888995, 3305.3554556861422, 3330.3672302262494, 3336.816475093869, 3344.745720354867, 3353.279045005336, 4744.383230180055, 4750.524947505256, 4750.881227969294, 4759.666823322369, 4811.085893680224, 4279.486461624625, 4286.699931004831, 4347.869563913087, 4376.496702879146, 4391.692581519295, 5118.769655365518, 5124.436312005676, 5130.153524668425, 5147.7683504242395, 5170.741462926839, 3680.8159592020293, 3684.5578530576504, 3686.502322186497, 3689.2990331836863, 3699.2046709957217, 5187.351581052369, 5375.784968601212, 5456.236126942231, 5459.262999495097, 5476.780928762844, 3726.795026273581, 3733.383991641403, 3742.962570374316, 3745.250949810049, 3748.325301445766, 3795.8102094895144, 3798.145417281145, 3817.2174704185577, 3822.522184726909, 3823.541175058955, 4358.8038538265855, 4365.293518018849, 4368.453943257093, 4376.365427013129, 4387.166438376698, 4884.12085824555, 5133.358330208724, 5152.124138896396, 5174.922376164361, 5212.166053431432, 1264.431006047264, 1277.4890043982482, 1278.7762141625178, 1282.1409655530817, 1282.5639282643758, 764.1746913333586, 767.8425922685836, 799.8360336131195, 815.575900531732, 818.1695578987333, 4476.776161191992, 4512.187806194851, 4602.3786788783755, 4606.447226332794, 4623.722576645412, 5270.789168433296, 5296.549793267538, 5308.442613525602, 5324.946750532445, 5371.785128594813, 4411.669124815651, 4590.472095708969, 4595.035042641016, 4597.977010114928, 4611.700239484423, 2766.2392841968217, 2806.8877244909977, 2810.7329803668617, 2822.252103192656, 2826.590144429046, 4969.503049695001, 4976.328195693607, 4985.401751789808, 5002.59979201663, 5057.519535644108, 5258.158694608845, 5496.725163741797, 5497.26836046644, 5502.889942201134, 5518.91721624176, 4944.936838579651, 4965.90068198634, 5019.071471777733, 5019.774110165052, 5080.49195080489, 5311.575073994149, 5350.625456218183, 5359.490848369399, 5362.70505122222, 5378.623496355218, 5076.974615126901, 5171.870703232449, 5226.634135610623, 5228.424873263862, 5265.815696450606, 4968.0, 4978.556218696537, 4983.0, 4989.575886049726, 4997.875053123701, 3663.3405986921543, 3690.55713314404, 3712.8119001919126, 3721.4603882437436, 3730.459083432833, 5036.345275114211, 5354.437784032776, 5358.651687640291, 5360.303160589098, 5370.62405631602, 5193.0, 5195.999540176984, 5216.191490319006, 5227.35338368428, 5250.212468129811, 5208.765605547836, 5224.817131400383, 5260.658057226268, 5267.9736601316745, 5273.707941554344, 4859.538343857328, 5116.590672746246, 5145.408278047923, 5191.091558977088, 5209.723617713685, 4964.851054468371, 5073.34046573943, 5148.382194136728, 5238.319018527567, 5239.738013099406, 5105.591552675852, 5123.538881500683, 5133.230015497706, 5133.358330208724, 5155.0], "value": 3862.8199764623664, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.9837504062399, 663.9402453779159, 680.775344136435, 697.9965100174499, 741.1217707017183, 13022.674433139176, 14239.145651260931, 14244.430222791101, 14262.857371426282, 14290.0, 13504.662383440418, 13592.116512426684, 13615.319234038308, 13620.931895340535, 13689.794653080187, 577.8815342854705, 592.1709606550842, 734.0530715377157, 735.2904447208443, 754.226917409654, 757.7991832164481, 764.3999460423569, 765.74730338988, 766.4060353226266, 767.746643607611, 809.8623234050197, 810.9229623185818, 811.2739098506833, 811.3387589114882, 811.3630799822141, 603.405645439242, 619.1301221783401, 621.1459243540132, 621.2203684376125, 804.2158895077312, 557.9079451890433, 574.6896675795066, 578.2049681687679, 578.7598146769086, 578.7945279425785, 13032.934835325763, 13174.67063323415, 13678.110922789987, 13678.794818077737, 13693.931530342385, 12541.686457838536, 12942.158759680591, 13140.802887956592, 13278.800817987738, 13364.732705345936, 11619.593314233962, 11632.941835290854, 11781.175317727762, 11916.582919597859, 12188.207766495238, 4230.788460576959, 4287.882180262196, 4315.568443155659, 4467.642588592905, 4483.865484035484, 62447.687761561356, 64095.35904640941, 64266.03600946036, 64307.0, 65179.3482065178, 10558.944404087768, 10761.46192690378, 10817.891821081688, 10918.50866710984, 11014.614488492864, 19818.60362792736, 19825.206991720457, 19833.30583429573, 19843.0, 19859.404217873485, 6578.967105164444, 6641.44304442793, 6805.693743781541, 7032.718691252293, 7077.504574679723, 3703.222323312081, 3732.682721968609, 3751.4935483709896, 3795.373763329075, 3877.2439374321734, 2731.617573539706, 2851.7148285171734, 2856.757175640094, 2857.2571131505542, 2857.6856545779947, 476.87124476391875, 482.0647942990587, 484.4211167654689, 486.18321220349446, 491.6681240162947, 440.77520464563304, 528.873070463086, 544.9291592093002, 569.1320735877737, 578.0462237308391, 7725.690972361042, 8049.718259860877, 8092.150324215991, 8110.5539195343645, 8305.294050005696, 519.3248776590493, 546.8605505596048, 549.7114015142002, 554.27666894702, 557.2171099605061, 3921.235359105004, 4160.355144952538, 4183.058811767389, 4268.786560671954, 4289.571042895748, 93137.534312328, 99551.50224248832, 100358.49820750995, 103285.0, 103298.0, 59120.704396478606, 87370.0, 91106.0, 93679.0, 94935.0, 72604.0, 75705.62147189229, 77563.0, 81038.59480702558, 81721.0, 8157.265846073645, 8781.780455488664, 9029.187373136187, 9294.442333460014, 9345.252379809735, 29033.7096629031, 29536.704632953395, 37671.0, 38980.999999998865, 39297.0, 37532.81233593814, 44548.109037818416, 48754.0, 58123.4187658118, 59256.1111583318, 11363.204575679623, 11444.427778611203, 11477.885221148015, 11711.76576468483, 11813.76372472563, 11629.59296424621, 12087.39563021863, 12989.740205196033, 13063.673408164492, 13080.934595327342, 11267.380294083903, 11582.826257605973, 11590.130740194687, 11731.178817482694, 11932.105092117952, 12049.759004820029, 12119.878801212228, 12567.18313309632, 12673.746525069262, 12684.0, 11536.769264614493, 12257.938710306391, 12415.130940834055, 12486.25135009262, 12659.493620255087, 10235.795284094425, 10666.98413643262, 10701.090407315465, 10788.460576971276, 10949.288296260718, 10590.0, 10719.464026798785, 11038.944805275922, 11158.888411115784, 11197.384143872165], "value": 6572.879017190325, "unit": "score"}], "name": "dromaeo_css", "value": 6309.628588106429, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 117.0, 114.0, 113.0, 113.0, 114.0, 114.0, 113.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 130.0, 125.0, 166.0, 138.0, 133.0, 129.0, 125.0, 164.0, 127.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 161.0, 161.0, 161.0, 163.0, 164.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 75.0, 113.0, 75.0, 77.0, 78.0, 78.0, 97.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 116.0, 83.0, 83.0, 83.0, 109.0, 82.0, 82.0, 122.0], "value": 92.7, "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, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 148.0, 148.0, 147.0, 146.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 64.0, 64.0, 65.0, 65.0, 63.0, 64.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 65.0, 65.0, 68.0, 66.0, 66.0, 65.0, 66.0, 66.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 84.0, 82.0, 82.0, 83.0, 83.0, 92.0, 82.0, 87.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 139.0, 150.0, 139.0, 139.0, 149.0, 138.0, 151.0, 178.0, 138.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 177.0, 171.0, 173.0, 174.0, 174.0, 173.0, 174.0, 171.0, 174.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 71.0, 68.0, 71.0, 70.0, 69.0, 70.0, 68.0, 71.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1552.4999999999998, "alertThreshold": 2.0}]} 18:48:38 INFO - Return code: 0 18:48:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:48:38 INFO - # TBPL SUCCESS # 18:48:38 INFO - Running post-action listener: _resource_record_post_action 18:48:38 INFO - [mozharness: 2016-10-09 01:48:38.816984Z] Finished run-tests step (success) 18:48:38 INFO - Running post-run listener: _resource_record_post_run 18:48:38 INFO - Total resource usage - Wall time: 1210s; CPU: 13.0%; Read bytes: 8056832; Write bytes: 416129024; Read time: 3524; Write time: 684852 18:48:38 INFO - TinderboxPrint: CPU usage
13.1% 18:48:38 INFO - TinderboxPrint: I/O read bytes / time
8,056,832 / 3,524 18:48:38 INFO - TinderboxPrint: I/O write bytes / time
416,129,024 / 684,852 18:48:38 INFO - TinderboxPrint: CPU idle
8,390.8 (86.9%) 18:48:38 INFO - TinderboxPrint: CPU user
1,205.2 (12.5%) 18:48:38 INFO - TinderboxPrint: Swap in / out
0 / 0 18:48:38 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 8192; Write bytes: 80404480; Read time: 260; Write time: 87168 18:48:38 INFO - run-tests - Wall time: 1194s; CPU: 13.0%; Read bytes: 5881856; Write bytes: 335724544; Read time: 2132; Write time: 597684 18:48:39 INFO - Running post-run listener: _upload_blobber_files 18:48:39 INFO - Blob upload gear active. 18:48:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:48:39 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 18:48:39 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'] 18:48:39 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 18:48:39 INFO - (blobuploader) - INFO - Open directory for files ... 18:48:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:48:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:48:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:48:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:48:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:48:44 INFO - (blobuploader) - INFO - Done attempting. 18:48:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:48:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:48:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:48:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:48:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:48:45 INFO - (blobuploader) - INFO - Done attempting. 18:48:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:48:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:48:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:48:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:48:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:48:46 INFO - (blobuploader) - INFO - Done attempting. 18:48:46 INFO - (blobuploader) - INFO - Iteration through files over. 18:48:46 INFO - Return code: 0 18:48:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:48:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:48:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a307a55e7aeb35e553d57044c1c1d5229cd147273e94851cbe0a5f8fbd6c5370b50045445106df5872cda548b92954224b3c205bceb6dc6d0922c8a4ca57b255", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/684447e5a95fd2254b4f475b2bf442b0d661b467aa84209c672ec8f34d1a8665769e68bd0d23dc7b54513451e5f86f1713fd8abb0c27c394cdd474a416616fac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3012a2500059fca0da72127276e9dd405fd2c84a868c85039f25d009a443af585dec19849a4d280ede0ad8aa1170efc453e80eab2a62e884b509db14adee6142"} 18:48:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:48:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:48:46 INFO - Contents: 18:48:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a307a55e7aeb35e553d57044c1c1d5229cd147273e94851cbe0a5f8fbd6c5370b50045445106df5872cda548b92954224b3c205bceb6dc6d0922c8a4ca57b255", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/684447e5a95fd2254b4f475b2bf442b0d661b467aa84209c672ec8f34d1a8665769e68bd0d23dc7b54513451e5f86f1713fd8abb0c27c394cdd474a416616fac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3012a2500059fca0da72127276e9dd405fd2c84a868c85039f25d009a443af585dec19849a4d280ede0ad8aa1170efc453e80eab2a62e884b509db14adee6142"} 18:48:46 INFO - Running post-run listener: copy_logs_to_upload_dir 18:48:46 INFO - Copying logs to upload dir... 18:48:46 INFO - mkdir: /builds/slave/test/build/upload/logs 18:48:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.547122 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-10-08 18:48:46.250522) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-08 18:48:46.254075) ========= 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=745a4373a2a16df560f216e000000264-1475973570.624102-1554800475 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/a307a55e7aeb35e553d57044c1c1d5229cd147273e94851cbe0a5f8fbd6c5370b50045445106df5872cda548b92954224b3c205bceb6dc6d0922c8a4ca57b255", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/684447e5a95fd2254b4f475b2bf442b0d661b467aa84209c672ec8f34d1a8665769e68bd0d23dc7b54513451e5f86f1713fd8abb0c27c394cdd474a416616fac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3012a2500059fca0da72127276e9dd405fd2c84a868c85039f25d009a443af585dec19849a4d280ede0ad8aa1170efc453e80eab2a62e884b509db14adee6142"} build_url:https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011214 build_url: 'https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/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/a307a55e7aeb35e553d57044c1c1d5229cd147273e94851cbe0a5f8fbd6c5370b50045445106df5872cda548b92954224b3c205bceb6dc6d0922c8a4ca57b255", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/684447e5a95fd2254b4f475b2bf442b0d661b467aa84209c672ec8f34d1a8665769e68bd0d23dc7b54513451e5f86f1713fd8abb0c27c394cdd474a416616fac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3012a2500059fca0da72127276e9dd405fd2c84a868c85039f25d009a443af585dec19849a4d280ede0ad8aa1170efc453e80eab2a62e884b509db14adee6142"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-08 18:48:46.279588) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 18:48:46.279982) ========= 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=745a4373a2a16df560f216e000000264-1475973570.624102-1554800475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 18:48:46.365387) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-08 18:48:46.365733) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-08 18:48:46.365996) ========= ========= Total master_lag: 0.17 =========