builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1480076006.57 results: success (0) buildid: 20161125021618 builduid: bb3d2e8a301943f5b8ce26405d2f01dd revision: 75453f12b616711e72c5a090b2041ae32450345e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 04:13:26.566494) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 04:13:26.566981) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 04:13:26.567257) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 04:13:26.582253) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 04:13:26.582622) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-25 04:13:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-11-25 04:13:27 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.078631 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 04:13:26.676458) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 04:13:26.676805) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017499 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 04:13:26.727046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-25 04:13:26.727440) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 75453f12b616711e72c5a090b2041ae32450345e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 75453f12b616711e72c5a090b2041ae32450345e --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=e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-25 04:13:27,312 truncating revision to first 12 chars 2016-11-25 04:13:27,312 Setting DEBUG logging. 2016-11-25 04:13:27,312 attempt 1/10 2016-11-25 04:13:27,312 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/75453f12b616?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-25 04:13:28,093 unpacking tar archive at: graphics-75453f12b616/testing/mozharness/ program finished with exit code 0 elapsedTime=1.086189 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-25 04:13:27.828045) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 04:13:27.828520) ========= script_repo_revision: 75453f12b616711e72c5a090b2041ae32450345e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 04:13:27.829172) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 04:13:27.829557) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 04:13:27.839969) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-25 04:13:27.840473) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:13:28 INFO - MultiFileLogger online at 20161125 04:13:28 in /builds/slave/test 04:13:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 04:13:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:13:28 INFO - {'append_to_log': False, 04:13:28 INFO - 'base_work_dir': '/builds/slave/test', 04:13:28 INFO - 'blob_upload_branch': 'Graphics', 04:13:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:13:28 INFO - 'branch': 'Graphics', 04:13:28 INFO - 'buildbot_json_path': 'buildprops.json', 04:13:28 INFO - 'config_files': ('talos/linux_config.py',), 04:13:28 INFO - 'default_actions': ('clobber', 04:13:28 INFO - 'read-buildbot-config', 04:13:28 INFO - 'download-and-extract', 04:13:28 INFO - 'populate-webroot', 04:13:28 INFO - 'create-virtualenv', 04:13:28 INFO - 'install', 04:13:28 INFO - 'run-tests'), 04:13:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:13:28 INFO - 'download_minidump_stackwalk': True, 04:13:28 INFO - 'download_symbols': 'ondemand', 04:13:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:13:28 INFO - 'tooltool.py': '/tools/tooltool.py', 04:13:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:13:28 INFO - '/tools/misc-python/virtualenv.py')}, 04:13:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:13:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:13:28 INFO - 'installer_path': 'installer.exe', 04:13:28 INFO - 'log_level': 'info', 04:13:28 INFO - 'log_name': 'talos', 04:13:28 INFO - 'log_to_console': True, 04:13:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:13:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:13:28 INFO - 'opt_config_files': (), 04:13:28 INFO - 'pip_index': False, 04:13:28 INFO - 'sps_profile': False, 04:13:28 INFO - 'sps_profile_interval': 0, 04:13:28 INFO - 'suite': 'dromaeojs', 04:13:28 INFO - 'system_bits': '32', 04:13:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:13:28 INFO - 'title': 'talos-linux64-ix-006', 04:13:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:13:28 INFO - 'use_talos_json': True, 04:13:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:13:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:13:28 INFO - 'work_dir': 'build'} 04:13:28 INFO - [mozharness: 2016-11-25 12:13:28.528237Z] Running clobber step. 04:13:28 INFO - Running pre-action listener: _resource_record_pre_action 04:13:28 INFO - Running main action method: clobber 04:13:28 INFO - rmtree: /builds/slave/test/build 04:13:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:13:28 INFO - Running post-action listener: _resource_record_post_action 04:13:28 INFO - [mozharness: 2016-11-25 12:13:28.998989Z] Finished clobber step (success) 04:13:28 INFO - [mozharness: 2016-11-25 12:13:28.999088Z] Running read-buildbot-config step. 04:13:28 INFO - Running pre-action listener: _resource_record_pre_action 04:13:28 INFO - Running main action method: read_buildbot_config 04:13:28 INFO - Using buildbot properties: 04:13:28 INFO - { 04:13:28 INFO - "project": "", 04:13:28 INFO - "product": "firefox", 04:13:28 INFO - "script_repo_revision": "default", 04:13:29 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 04:13:29 INFO - "repository": "", 04:13:29 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 04:13:29 INFO - "buildid": "20161125021618", 04:13:29 INFO - "pgo_build": "False", 04:13:29 INFO - "basedir": "/builds/slave/test", 04:13:29 INFO - "buildnumber": 8, 04:13:29 INFO - "slavename": "talos-linux64-ix-006", 04:13:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:13:29 INFO - "platform": "ubuntu64_hw", 04:13:29 INFO - "scheduler": "tests-graphics-linux64-talos", 04:13:29 INFO - "branch": "graphics", 04:13:29 INFO - "repo_path": "projects/graphics", 04:13:29 INFO - "revision": "75453f12b616711e72c5a090b2041ae32450345e", 04:13:29 INFO - "stage_platform": "linux64", 04:13:29 INFO - "builduid": "bb3d2e8a301943f5b8ce26405d2f01dd", 04:13:29 INFO - "slavebuilddir": "test" 04:13:29 INFO - } 04:13:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 04:13:29 INFO - Running post-action listener: _resource_record_post_action 04:13:29 INFO - [mozharness: 2016-11-25 12:13:29.001536Z] Finished read-buildbot-config step (success) 04:13:29 INFO - [mozharness: 2016-11-25 12:13:29.001626Z] Running download-and-extract step. 04:13:29 INFO - Running pre-action listener: _resource_record_pre_action 04:13:29 INFO - Running main action method: download_and_extract 04:13:29 INFO - mkdir: /builds/slave/test/build/tests 04:13:29 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')]} 04:13:29 INFO - trying https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:13:29 INFO - Downloading https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:13:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:13:29 INFO - Downloaded 1361 bytes. 04:13:29 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:13:29 INFO - Using the following test package requirements: 04:13:29 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:29 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:13:29 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:13:29 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:29 INFO - u'jsshell-linux-x86_64.zip'], 04:13:29 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:13:29 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:29 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:13:29 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:13:29 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:13:29 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:13:29 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:13:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 04:13:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:13:29 INFO - Fetch https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:13:30 INFO - Http code: 200 04:13:30 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 04:13:30 INFO - x-amz-cf-id: bJXOPtWNvL3XVL0pIejenVXqhmjqUnk3oL8ocuIRwDf7AEl2IN_0Kg== 04:13:30 INFO - x-amz-version-id: Py9KwypsQmKctsPFW2jnFe.zx3xOEsNa 04:13:30 INFO - Expected file size: 20202013 04:13:30 INFO - Obtained file size: 20202013 04:13:34 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:13:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 04:13:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:13:34 INFO - Fetch https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:13:34 INFO - Http code: 200 04:13:34 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 04:13:34 INFO - x-amz-cf-id: 9YCmnGcOFVtcqVl2RwJorK7uK2cUxfkuL7EtKKxa4UXOOlnN6grCgw== 04:13:34 INFO - x-amz-version-id: Py9KwypsQmKctsPFW2jnFe.zx3xOEsNa 04:13:35 INFO - Expected file size: 20202013 04:13:35 INFO - Obtained file size: 20202013 04:13:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:13:39 INFO - Fetch https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:13:40 INFO - Http code: 200 04:13:40 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 04:13:40 INFO - x-amz-cf-id: LZ3SuqtcS-TfyfsqX3WNpHlopZUUTjvm8ZivhgsSIXmReNRHPa13rQ== 04:13:40 INFO - x-amz-version-id: FOkghGXjBgPLnM8eENI3YHa.iL.qsk4V 04:13:40 INFO - Expected file size: 14409506 04:13:40 INFO - Obtained file size: 14409506 04:13:40 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')]} 04:13:40 INFO - trying https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:13:40 INFO - Downloading https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:13:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:13:41 INFO - Downloaded 55602681 bytes. 04:13:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:13:41 INFO - mkdir: /builds/slave/test/properties 04:13:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:41 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:41 INFO - Contents: 04:13:41 INFO - build_url:https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:13:42 INFO - Running post-action listener: _resource_record_post_action 04:13:42 INFO - Running post-action listener: set_extra_try_arguments 04:13:42 INFO - [mozharness: 2016-11-25 12:13:42.524987Z] Finished download-and-extract step (success) 04:13:42 INFO - [mozharness: 2016-11-25 12:13:42.525286Z] Running populate-webroot step. 04:13:42 INFO - Running pre-action listener: _resource_record_pre_action 04:13:42 INFO - Running main action method: populate_webroot 04:13:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:42 INFO - '--tppagecycles', 04:13:42 INFO - '7'], 04:13:42 INFO - 'tests': ['tsvgm']}}, 04:13:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:13:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:13:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:13:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:13:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:13:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:13:42 INFO - 'talos_options': ['--disable-e10s'], 04:13:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:13:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:13:42 INFO - 'talos_options': ['--disable-e10s'], 04:13:42 INFO - 'tests': ['damp', 'tps']}, 04:13:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:13:42 INFO - 'tests': ['damp', 'tps']}, 04:13:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:13:42 INFO - 'tests': ['dromaeo_dom']}, 04:13:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:13:42 INFO - 'tests': ['basic_compositor_video']}, 04:13:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:13:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:13:42 INFO - 'tests': ['a11yr', 04:13:42 INFO - 'ts_paint', 04:13:42 INFO - 'tpaint', 04:13:42 INFO - 'sessionrestore', 04:13:42 INFO - 'sessionrestore_no_auto_restore', 04:13:42 INFO - 'tabpaint']}, 04:13:42 INFO - 'other-e10s': {'tests': ['a11yr', 04:13:42 INFO - 'ts_paint', 04:13:42 INFO - 'tpaint', 04:13:42 INFO - 'sessionrestore', 04:13:42 INFO - 'sessionrestore_no_auto_restore', 04:13:42 INFO - 'tabpaint']}, 04:13:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:13:42 INFO - 'ts_paint', 04:13:42 INFO - 'tpaint', 04:13:42 INFO - 'sessionrestore', 04:13:42 INFO - 'sessionrestore_no_auto_restore', 04:13:42 INFO - 'tabpaint']}, 04:13:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:13:42 INFO - 'ts_paint', 04:13:42 INFO - 'tpaint', 04:13:42 INFO - 'sessionrestore', 04:13:42 INFO - 'sessionrestore_no_auto_restore', 04:13:42 INFO - 'tabpaint']}, 04:13:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:13:42 INFO - 'tests': ['a11yr', 04:13:42 INFO - 'ts_paint', 04:13:42 INFO - 'tpaint', 04:13:42 INFO - 'sessionrestore', 04:13:42 INFO - 'sessionrestore_no_auto_restore', 04:13:42 INFO - 'tabpaint']}, 04:13:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:13:42 INFO - 'tests': ['a11yr', 04:13:42 INFO - 'ts_paint', 04:13:42 INFO - 'tpaint', 04:13:42 INFO - 'sessionrestore', 04:13:42 INFO - 'sessionrestore_no_auto_restore', 04:13:42 INFO - 'tabpaint']}, 04:13:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:13:42 INFO - 'tests': ['tsvgx', 04:13:42 INFO - 'tsvgr_opacity', 04:13:42 INFO - 'tart', 04:13:42 INFO - 'tscrollx', 04:13:42 INFO - 'cart']}, 04:13:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:13:42 INFO - 'tsvgr_opacity', 04:13:42 INFO - 'tart', 04:13:42 INFO - 'tscrollx', 04:13:42 INFO - 'cart']}, 04:13:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:13:42 INFO - 'talos_options': ['--disable-e10s'], 04:13:42 INFO - 'tests': ['tp5o']}, 04:13:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:13:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:13:42 INFO - 'talos_options': ['--disable-e10s', 04:13:42 INFO - '--xperf_path', 04:13:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:42 INFO - 'tests': ['tp5n']}, 04:13:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:13:42 INFO - 'talos_options': ['--xperf_path', 04:13:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:42 INFO - 'tests': ['tp5n']}}, 04:13:42 INFO - 'talos.zip': {'path': '', 04:13:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:42 INFO - Running post-action listener: _resource_record_post_action 04:13:42 INFO - [mozharness: 2016-11-25 12:13:42.542430Z] Finished populate-webroot step (success) 04:13:42 INFO - [mozharness: 2016-11-25 12:13:42.542522Z] Running create-virtualenv step. 04:13:42 INFO - Running pre-action listener: _resource_record_pre_action 04:13:42 INFO - Running main action method: create_virtualenv 04:13:42 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:42 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 04:13:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:42 INFO - Using real prefix '/usr' 04:13:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:43 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:45 INFO - Installing pip.................done. 04:13:45 INFO - Return code: 0 04:13:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:13:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:13:45 INFO - Reading from file tmpfile_stdout 04:13:45 INFO - Output received: 04:13:45 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) 04:13:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:45 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')]} 04:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:45 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')]} 04:13:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:45 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 0x7fada7a33e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2947fc0>, '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 0x2948ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2949350>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', '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 04:13:45 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 04:13:45 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 04:13:45 INFO - Using env: {'DISPLAY': ':0', 04:13:45 INFO - 'HOME': '/home/cltbld', 04:13:45 INFO - 'LANG': 'en_US.UTF-8', 04:13:45 INFO - 'LANGUAGE': 'en_US:en', 04:13:45 INFO - 'LOGNAME': 'cltbld', 04:13:45 INFO - 'MAIL': '/var/mail/cltbld', 04:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:45 INFO - 'MOZ_NO_REMOTE': '1', 04:13:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:45 INFO - 'NO_EM_RESTART': '1', 04:13:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:45 INFO - 'PWD': '/builds/slave/test', 04:13:45 INFO - 'SHELL': '/bin/bash', 04:13:45 INFO - 'SHLVL': '1', 04:13:45 INFO - 'TERM': 'linux', 04:13:45 INFO - 'TMOUT': '86400', 04:13:45 INFO - 'USER': 'cltbld', 04:13:45 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', 04:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:45 INFO - '_': '/tools/buildbot/bin/python'} 04:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:45 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 04:13:45 INFO - Cleaning up... 04:13:45 INFO - Return code: 0 04:13:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:13:45 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')]} 04:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:45 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')]} 04:13:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:45 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 0x7fada7a33e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2947fc0>, '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 0x2948ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2949350>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', '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 04:13:45 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 04:13:45 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 04:13:45 INFO - Using env: {'DISPLAY': ':0', 04:13:45 INFO - 'HOME': '/home/cltbld', 04:13:45 INFO - 'LANG': 'en_US.UTF-8', 04:13:45 INFO - 'LANGUAGE': 'en_US:en', 04:13:45 INFO - 'LOGNAME': 'cltbld', 04:13:45 INFO - 'MAIL': '/var/mail/cltbld', 04:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:45 INFO - 'MOZ_NO_REMOTE': '1', 04:13:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:45 INFO - 'NO_EM_RESTART': '1', 04:13:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:45 INFO - 'PWD': '/builds/slave/test', 04:13:45 INFO - 'SHELL': '/bin/bash', 04:13:45 INFO - 'SHLVL': '1', 04:13:45 INFO - 'TERM': 'linux', 04:13:45 INFO - 'TMOUT': '86400', 04:13:45 INFO - 'USER': 'cltbld', 04:13:45 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', 04:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:45 INFO - '_': '/tools/buildbot/bin/python'} 04:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:45 INFO - Downloading/unpacking psutil>=3.1.1 04:13:45 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 04:13:45 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 04:13:45 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 04:13:45 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 04:13:45 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 04:13:45 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 04:13:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:47 INFO - Installing collected packages: psutil 04:13:47 INFO - Running setup.py install for psutil 04:13:47 INFO - building 'psutil._psutil_linux' extension 04:13:47 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 04:13:48 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 04:13:48 INFO - building 'psutil._psutil_posix' extension 04:13:48 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 04:13:48 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 04:13:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:48 INFO - Successfully installed psutil 04:13:48 INFO - Cleaning up... 04:13:48 INFO - Return code: 0 04:13:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:13:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:48 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 0x7fada7a33e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2947fc0>, '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 0x2948ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2949350>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', '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 04:13:48 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 04:13:48 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 04:13:48 INFO - Using env: {'DISPLAY': ':0', 04:13:48 INFO - 'HOME': '/home/cltbld', 04:13:48 INFO - 'LANG': 'en_US.UTF-8', 04:13:48 INFO - 'LANGUAGE': 'en_US:en', 04:13:48 INFO - 'LOGNAME': 'cltbld', 04:13:48 INFO - 'MAIL': '/var/mail/cltbld', 04:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:48 INFO - 'MOZ_NO_REMOTE': '1', 04:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:48 INFO - 'NO_EM_RESTART': '1', 04:13:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:48 INFO - 'PWD': '/builds/slave/test', 04:13:48 INFO - 'SHELL': '/bin/bash', 04:13:48 INFO - 'SHLVL': '1', 04:13:48 INFO - 'TERM': 'linux', 04:13:48 INFO - 'TMOUT': '86400', 04:13:48 INFO - 'USER': 'cltbld', 04:13:48 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', 04:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:48 INFO - '_': '/tools/buildbot/bin/python'} 04:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:13:48 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 04:13:48 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 04:13:48 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 04:13:48 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 04:13:48 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 04:13:48 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 04:13:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:13:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:13:50 INFO - Installing collected packages: mozsystemmonitor 04:13:50 INFO - Running setup.py install for mozsystemmonitor 04:13:50 INFO - Successfully installed mozsystemmonitor 04:13:50 INFO - Cleaning up... 04:13:50 INFO - Return code: 0 04:13:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:13:50 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')]} 04:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:50 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')]} 04:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:50 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 0x7fada7a33e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2947fc0>, '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 0x2948ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2949350>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', '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 04:13:50 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 04:13:50 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 04:13:50 INFO - Using env: {'DISPLAY': ':0', 04:13:50 INFO - 'HOME': '/home/cltbld', 04:13:50 INFO - 'LANG': 'en_US.UTF-8', 04:13:50 INFO - 'LANGUAGE': 'en_US:en', 04:13:50 INFO - 'LOGNAME': 'cltbld', 04:13:50 INFO - 'MAIL': '/var/mail/cltbld', 04:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:50 INFO - 'MOZ_NO_REMOTE': '1', 04:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:50 INFO - 'NO_EM_RESTART': '1', 04:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:50 INFO - 'PWD': '/builds/slave/test', 04:13:50 INFO - 'SHELL': '/bin/bash', 04:13:50 INFO - 'SHLVL': '1', 04:13:50 INFO - 'TERM': 'linux', 04:13:50 INFO - 'TMOUT': '86400', 04:13:50 INFO - 'USER': 'cltbld', 04:13:50 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', 04:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:50 INFO - '_': '/tools/buildbot/bin/python'} 04:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:50 INFO - Downloading/unpacking jsonschema==2.5.1 04:13:50 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 04:13:50 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 04:13:50 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 04:13:50 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 04:13:50 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 04:13:50 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 04:13:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:13:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:53 INFO - Downloading functools32-3.2.3-2.tar.gz 04:13:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:13:53 INFO - warning: no files found matching '*.txt' 04:13:53 INFO - no previously-included directories found matching 'build' 04:13:53 INFO - no previously-included directories found matching 'dist' 04:13:53 INFO - no previously-included directories found matching '.git*' 04:13:53 INFO - Installing collected packages: jsonschema, functools32 04:13:53 INFO - Running setup.py install for functools32 04:13:53 INFO - warning: no files found matching '*.txt' 04:13:53 INFO - no previously-included directories found matching 'build' 04:13:53 INFO - no previously-included directories found matching 'dist' 04:13:53 INFO - no previously-included directories found matching '.git*' 04:13:53 INFO - Successfully installed jsonschema functools32 04:13:53 INFO - Cleaning up... 04:13:53 INFO - Return code: 0 04:13:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:13:53 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')]} 04:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:53 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')]} 04:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:53 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 0x7fada7a33e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2947fc0>, '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 0x2948ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2949350>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', '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 04:13:53 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 04:13:53 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 04:13:53 INFO - Using env: {'DISPLAY': ':0', 04:13:53 INFO - 'HOME': '/home/cltbld', 04:13:53 INFO - 'LANG': 'en_US.UTF-8', 04:13:53 INFO - 'LANGUAGE': 'en_US:en', 04:13:53 INFO - 'LOGNAME': 'cltbld', 04:13:53 INFO - 'MAIL': '/var/mail/cltbld', 04:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:53 INFO - 'MOZ_NO_REMOTE': '1', 04:13:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:53 INFO - 'NO_EM_RESTART': '1', 04:13:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:53 INFO - 'PWD': '/builds/slave/test', 04:13:53 INFO - 'SHELL': '/bin/bash', 04:13:53 INFO - 'SHLVL': '1', 04:13:53 INFO - 'TERM': 'linux', 04:13:53 INFO - 'TMOUT': '86400', 04:13:53 INFO - 'USER': 'cltbld', 04:13:53 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', 04:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:53 INFO - '_': '/tools/buildbot/bin/python'} 04:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:13:53 INFO - Cleaning up... 04:13:53 INFO - Return code: 0 04:13:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:13:53 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')]} 04:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:53 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')]} 04:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:53 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 0x7fada7a33e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2947fc0>, '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 0x2948ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2949350>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', '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 04:13:53 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 04:13:53 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 04:13:53 INFO - Using env: {'DISPLAY': ':0', 04:13:53 INFO - 'HOME': '/home/cltbld', 04:13:53 INFO - 'LANG': 'en_US.UTF-8', 04:13:53 INFO - 'LANGUAGE': 'en_US:en', 04:13:53 INFO - 'LOGNAME': 'cltbld', 04:13:53 INFO - 'MAIL': '/var/mail/cltbld', 04:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:53 INFO - 'MOZ_NO_REMOTE': '1', 04:13:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:53 INFO - 'NO_EM_RESTART': '1', 04:13:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:53 INFO - 'PWD': '/builds/slave/test', 04:13:53 INFO - 'SHELL': '/bin/bash', 04:13:53 INFO - 'SHLVL': '1', 04:13:53 INFO - 'TERM': 'linux', 04:13:53 INFO - 'TMOUT': '86400', 04:13:53 INFO - 'USER': 'cltbld', 04:13:53 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', 04:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:53 INFO - '_': '/tools/buildbot/bin/python'} 04:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:53 INFO - Downloading/unpacking blobuploader==1.2.4 04:13:53 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 04:13:53 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 04:13:53 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 04:13:53 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 04:13:53 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 04:13:53 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 04:13:55 INFO - Downloading blobuploader-1.2.4.tar.gz 04:13:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:13:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:13:56 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 04:13:56 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 04:13:56 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 04:13:56 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 04:13:56 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 04:13:56 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 04:13:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:13:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:13:56 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 04:13:56 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 04:13:56 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 04:13:56 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 04:13:56 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 04:13:56 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 04:13:56 INFO - Downloading docopt-0.6.1.tar.gz 04:13:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:13:56 INFO - Installing collected packages: blobuploader, requests, docopt 04:13:56 INFO - Running setup.py install for blobuploader 04:13:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:13:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:13:56 INFO - Running setup.py install for requests 04:13:57 INFO - Running setup.py install for docopt 04:13:57 INFO - Successfully installed blobuploader requests docopt 04:13:57 INFO - Cleaning up... 04:13:57 INFO - Return code: 0 04:13:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:57 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')]} 04:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:57 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')]} 04:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:57 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 0x7fada7a33e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2947fc0>, '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 0x2948ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2949350>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', '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 04:13:57 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 04:13:57 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 04:13:57 INFO - Using env: {'DISPLAY': ':0', 04:13:57 INFO - 'HOME': '/home/cltbld', 04:13:57 INFO - 'LANG': 'en_US.UTF-8', 04:13:57 INFO - 'LANGUAGE': 'en_US:en', 04:13:57 INFO - 'LOGNAME': 'cltbld', 04:13:57 INFO - 'MAIL': '/var/mail/cltbld', 04:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:57 INFO - 'MOZ_NO_REMOTE': '1', 04:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:57 INFO - 'NO_EM_RESTART': '1', 04:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:57 INFO - 'PWD': '/builds/slave/test', 04:13:57 INFO - 'SHELL': '/bin/bash', 04:13:57 INFO - 'SHLVL': '1', 04:13:57 INFO - 'TERM': 'linux', 04:13:57 INFO - 'TMOUT': '86400', 04:13:57 INFO - 'USER': 'cltbld', 04:13:57 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', 04:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:57 INFO - '_': '/tools/buildbot/bin/python'} 04:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:57 INFO - Running setup.py (path:/tmp/pip-6WjaXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:57 INFO - Running setup.py (path:/tmp/pip-1ukN95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:57 INFO - Running setup.py (path:/tmp/pip-njfMN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:57 INFO - Running setup.py (path:/tmp/pip-kvd4Uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:57 INFO - Running setup.py (path:/tmp/pip-gvhiKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:57 INFO - Running setup.py (path:/tmp/pip-U9kJCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:58 INFO - Running setup.py (path:/tmp/pip-9SvCio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:58 INFO - Running setup.py (path:/tmp/pip-kgrErp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:58 INFO - Running setup.py (path:/tmp/pip-3JoSmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:58 INFO - Running setup.py (path:/tmp/pip-6KOarH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:58 INFO - Running setup.py (path:/tmp/pip-aawSv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:58 INFO - Running setup.py (path:/tmp/pip-4i_zrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:58 INFO - Running setup.py (path:/tmp/pip-wmPadi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:58 INFO - Running setup.py (path:/tmp/pip-AQ0FNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:58 INFO - Running setup.py (path:/tmp/pip-GhFIRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:58 INFO - Running setup.py (path:/tmp/pip-iDyRi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:58 INFO - Running setup.py (path:/tmp/pip-lrDeNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:13:58 INFO - Running setup.py install for manifestparser 04:13:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:13:58 INFO - Running setup.py install for mozcrash 04:13:59 INFO - Running setup.py install for mozdebug 04:13:59 INFO - Running setup.py install for mozdevice 04:13:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:13:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:13:59 INFO - Running setup.py install for mozfile 04:13:59 INFO - Running setup.py install for mozhttpd 04:13:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:13:59 INFO - Running setup.py install for mozinfo 04:13:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:13:59 INFO - Running setup.py install for mozInstall 04:13:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:13:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:13:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:13:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:13:59 INFO - Running setup.py install for mozleak 04:13:59 INFO - Running setup.py install for mozlog 04:13:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:13:59 INFO - Running setup.py install for moznetwork 04:13:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:13:59 INFO - Running setup.py install for mozprocess 04:14:00 INFO - Running setup.py install for mozprofile 04:14:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:14:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:14:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:14:00 INFO - Running setup.py install for mozrunner 04:14:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:14:00 INFO - Running setup.py install for mozscreenshot 04:14:00 INFO - Running setup.py install for moztest 04:14:00 INFO - Running setup.py install for mozversion 04:14:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:14:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:14:00 INFO - Cleaning up... 04:14:00 INFO - Return code: 0 04:14:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:00 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 0x7fada7a33e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2947fc0>, '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 0x2948ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2949350>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', '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 04:14:00 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 04:14:00 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 04:14:00 INFO - Using env: {'DISPLAY': ':0', 04:14:00 INFO - 'HOME': '/home/cltbld', 04:14:00 INFO - 'LANG': 'en_US.UTF-8', 04:14:00 INFO - 'LANGUAGE': 'en_US:en', 04:14:00 INFO - 'LOGNAME': 'cltbld', 04:14:00 INFO - 'MAIL': '/var/mail/cltbld', 04:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:00 INFO - 'MOZ_NO_REMOTE': '1', 04:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:00 INFO - 'NO_EM_RESTART': '1', 04:14:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:00 INFO - 'PWD': '/builds/slave/test', 04:14:00 INFO - 'SHELL': '/bin/bash', 04:14:00 INFO - 'SHLVL': '1', 04:14:00 INFO - 'TERM': 'linux', 04:14:00 INFO - 'TMOUT': '86400', 04:14:00 INFO - 'USER': 'cltbld', 04:14:00 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', 04:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:00 INFO - '_': '/tools/buildbot/bin/python'} 04:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:00 INFO - Running setup.py (path:/tmp/pip-b4_42m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:00 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)) 04:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:00 INFO - Running setup.py (path:/tmp/pip-x1sOV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 04:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:00 INFO - Running setup.py (path:/tmp/pip-NBXlIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:01 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)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:01 INFO - Running setup.py (path:/tmp/pip-21o9U9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:01 INFO - Running setup.py (path:/tmp/pip-SEbFO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:01 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)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:01 INFO - Running setup.py (path:/tmp/pip-SkudFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:01 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)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:01 INFO - Running setup.py (path:/tmp/pip-CDLaof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:01 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)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:01 INFO - Running setup.py (path:/tmp/pip-xHVaFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:01 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)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:01 INFO - Running setup.py (path:/tmp/pip-KnOD6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:01 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)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:01 INFO - Running setup.py (path:/tmp/pip-hlcl18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:01 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)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:01 INFO - Running setup.py (path:/tmp/pip-1LFL1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:01 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)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:01 INFO - Running setup.py (path:/tmp/pip-O1E1lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:01 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)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:01 INFO - Running setup.py (path:/tmp/pip-7kpe5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:01 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)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:01 INFO - Running setup.py (path:/tmp/pip-JAihOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:01 INFO - Running setup.py (path:/tmp/pip-grxWjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:01 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)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:01 INFO - Running setup.py (path:/tmp/pip-HWjHAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:01 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)) 04:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:02 INFO - Running setup.py (path:/tmp/pip-e4R7U0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:02 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)) 04:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:14:02 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)) 04:14:02 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:14:02 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:14:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:02 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 04:14:02 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 04:14:02 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 04:14:02 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 04:14:02 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 04:14:02 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 04:14:04 INFO - Downloading blessings-1.6.tar.gz 04:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:14:04 INFO - Installing collected packages: blessings 04:14:04 INFO - Running setup.py install for blessings 04:14:04 INFO - Successfully installed blessings 04:14:04 INFO - Cleaning up... 04:14:04 INFO - Return code: 0 04:14:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:14:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:04 INFO - Reading from file tmpfile_stdout 04:14:04 INFO - Current package versions: 04:14:04 INFO - argparse == 1.2.1 04:14:04 INFO - blessings == 1.6 04:14:04 INFO - blobuploader == 1.2.4 04:14:04 INFO - docopt == 0.6.1 04:14:04 INFO - functools32 == 3.2.3-2 04:14:04 INFO - jsonschema == 2.5.1 04:14:04 INFO - manifestparser == 1.1 04:14:04 INFO - mozInstall == 1.12 04:14:04 INFO - mozcrash == 1.0 04:14:04 INFO - mozdebug == 0.1 04:14:04 INFO - mozdevice == 0.49 04:14:04 INFO - mozfile == 1.2 04:14:04 INFO - mozhttpd == 0.7 04:14:04 INFO - mozinfo == 0.9 04:14:04 INFO - mozleak == 0.1 04:14:04 INFO - mozlog == 3.4 04:14:04 INFO - moznetwork == 0.27 04:14:04 INFO - mozprocess == 0.23 04:14:04 INFO - mozprofile == 0.28 04:14:04 INFO - mozrunner == 6.13 04:14:04 INFO - mozscreenshot == 0.1 04:14:04 INFO - mozsystemmonitor == 0.3 04:14:04 INFO - moztest == 0.7 04:14:04 INFO - mozversion == 1.4 04:14:04 INFO - psutil == 3.1.1 04:14:04 INFO - requests == 1.2.3 04:14:04 INFO - wsgiref == 0.1.2 04:14:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:04 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')]} 04:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:04 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')]} 04:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:04 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 0x7fada7a33e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2947fc0>, '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 0x2948ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2949350>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', '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 04:14:04 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 04:14:04 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 04:14:04 INFO - Using env: {'DISPLAY': ':0', 04:14:04 INFO - 'HOME': '/home/cltbld', 04:14:04 INFO - 'LANG': 'en_US.UTF-8', 04:14:04 INFO - 'LANGUAGE': 'en_US:en', 04:14:04 INFO - 'LOGNAME': 'cltbld', 04:14:04 INFO - 'MAIL': '/var/mail/cltbld', 04:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:04 INFO - 'MOZ_NO_REMOTE': '1', 04:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:04 INFO - 'NO_EM_RESTART': '1', 04:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:04 INFO - 'PWD': '/builds/slave/test', 04:14:04 INFO - 'SHELL': '/bin/bash', 04:14:04 INFO - 'SHLVL': '1', 04:14:04 INFO - 'TERM': 'linux', 04:14:04 INFO - 'TMOUT': '86400', 04:14:04 INFO - 'USER': 'cltbld', 04:14:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', 04:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:04 INFO - '_': '/tools/buildbot/bin/python'} 04:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:04 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)) 04:14:04 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)) 04:14:04 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)) 04:14:04 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)) 04:14:04 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)) 04:14:04 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)) 04:14:04 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)) 04:14:04 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)) 04:14:04 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)) 04:14:04 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)) 04:14:04 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)) 04:14:04 INFO - Cleaning up... 04:14:04 INFO - Return code: 0 04:14:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:14:04 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')]} 04:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:04 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')]} 04:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:04 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 0x7fada7a33e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2947fc0>, '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 0x2948ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2949350>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', '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 04:14:04 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 04:14:04 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 04:14:04 INFO - Using env: {'DISPLAY': ':0', 04:14:04 INFO - 'HOME': '/home/cltbld', 04:14:04 INFO - 'LANG': 'en_US.UTF-8', 04:14:04 INFO - 'LANGUAGE': 'en_US:en', 04:14:04 INFO - 'LOGNAME': 'cltbld', 04:14:04 INFO - 'MAIL': '/var/mail/cltbld', 04:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:04 INFO - 'MOZ_NO_REMOTE': '1', 04:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:04 INFO - 'NO_EM_RESTART': '1', 04:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:04 INFO - 'PWD': '/builds/slave/test', 04:14:04 INFO - 'SHELL': '/bin/bash', 04:14:04 INFO - 'SHLVL': '1', 04:14:04 INFO - 'TERM': 'linux', 04:14:04 INFO - 'TMOUT': '86400', 04:14:04 INFO - 'USER': 'cltbld', 04:14:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', 04:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:04 INFO - '_': '/tools/buildbot/bin/python'} 04:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:14:04 INFO - Cleaning up... 04:14:04 INFO - Return code: 0 04:14:04 INFO - Running post-action listener: _resource_record_post_action 04:14:04 INFO - Running post-action listener: _start_resource_monitoring 04:14:04 INFO - Starting resource monitoring. 04:14:04 INFO - [mozharness: 2016-11-25 12:14:04.984911Z] Finished create-virtualenv step (success) 04:14:04 INFO - [mozharness: 2016-11-25 12:14:04.985447Z] Running install step. 04:14:04 INFO - Running pre-action listener: _resource_record_pre_action 04:14:04 INFO - Running main action method: install 04:14:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:05 INFO - Reading from file tmpfile_stdout 04:14:05 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:14:05 INFO - Reading from file tmpfile_stdout 04:14:05 INFO - Output received: 04:14:05 INFO - Usage: mozinstall [options] installer 04:14:05 INFO - Options: 04:14:05 INFO - -h, --help show this help message and exit 04:14:05 INFO - -d DEST, --destination=DEST 04:14:05 INFO - Directory to install application into. [default: 04:14:05 INFO - "/builds/slave/test"] 04:14:05 INFO - --app=APP Application being installed. [default: firefox] 04:14:05 INFO - mkdir: /builds/slave/test/build/application 04:14:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:14:21 INFO - Reading from file tmpfile_stdout 04:14:21 INFO - Output received: 04:14:21 INFO - /builds/slave/test/build/application/firefox/firefox 04:14:21 INFO - Running post-action listener: _resource_record_post_action 04:14:21 INFO - [mozharness: 2016-11-25 12:14:21.294557Z] Finished install step (success) 04:14:21 INFO - [mozharness: 2016-11-25 12:14:21.294810Z] Running run-tests step. 04:14:21 INFO - Running pre-action listener: _resource_record_pre_action 04:14:21 INFO - Running main action method: run_tests 04:14:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:21 INFO - Python 2.7.3 04:14:21 INFO - Return code: 0 04:14:21 INFO - grabbing minidump binary from tooltool 04:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:21 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 0x2947fc0>, '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 0x2948ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2949350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14:21 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 04:14:21 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 04:14:21 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 04:14:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:21 INFO - Return code: 0 04:14:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:14:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:14:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 04:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 04:14:21 INFO - Using env: {'DISPLAY': ':0', 04:14:21 INFO - 'HOME': '/home/cltbld', 04:14:21 INFO - 'LANG': 'en_US.UTF-8', 04:14:21 INFO - 'LANGUAGE': 'en_US:en', 04:14:21 INFO - 'LOGNAME': 'cltbld', 04:14:21 INFO - 'MAIL': '/var/mail/cltbld', 04:14:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:21 INFO - 'MOZ_NO_REMOTE': '1', 04:14:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:21 INFO - 'NO_EM_RESTART': '1', 04:14:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:21 INFO - 'PWD': '/builds/slave/test', 04:14:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:21 INFO - 'SHELL': '/bin/bash', 04:14:21 INFO - 'SHLVL': '1', 04:14:21 INFO - 'TERM': 'linux', 04:14:21 INFO - 'TMOUT': '86400', 04:14:21 INFO - 'USER': 'cltbld', 04:14:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270', 04:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:21 INFO - '_': '/tools/buildbot/bin/python'} 04:14:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 04:14:21 INFO - mozversion application_buildid: 20161125021618 04:14:21 INFO - mozversion application_changeset: 75453f12b616711e72c5a090b2041ae32450345e 04:14:21 INFO - mozversion application_display_name: Nightly 04:14:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:14:21 INFO - mozversion application_name: Firefox 04:14:21 INFO - mozversion application_remotingname: firefox 04:14:21 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 04:14:21 INFO - mozversion application_vendor: Mozilla 04:14:21 INFO - mozversion application_version: 53.0a1 04:14:21 INFO - mozversion platform_buildid: 20161125021618 04:14:21 INFO - mozversion platform_changeset: 75453f12b616711e72c5a090b2041ae32450345e 04:14:21 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 04:14:21 INFO - mozversion platform_version: 53.0a1 04:14:21 INFO - using testdate: 1480076061 04:14:21 INFO - actual date: 1480076061 04:14:21 INFO - starting webserver on 'localhost:49939' 04:14:21 INFO - SUITE-START | Running 2 tests 04:14:21 INFO - TEST-START | dromaeo_css 04:14:21 INFO - operating with platform_type : linux_ 04:14:21 INFO - Initialising browser for dromaeo_css test... 04:14:21 INFO - TEST-INFO | started process 18610 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGxFZRh/profile http://localhost:49939/getInfo.html) 04:14:25 INFO - PROCESS | 18610 | __metrics Screen width/height:1600/1200 04:14:25 INFO - PROCESS | 18610 | colorDepth:24 04:14:25 INFO - PROCESS | 18610 | Browser inner width/height: 1024/697 04:14:25 INFO - PROCESS | 18610 | __metrics 04:14:26 INFO - PROCESS | 18610 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:14:26 INFO - PROCESS | 18610 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:14:28 INFO - TEST-INFO | 18610: exit 0 04:14:28 INFO - Browser initialized. 04:14:28 INFO - Running cycle 1/1 for dromaeo_css test... 04:14:28 INFO - TEST-INFO | started process 18693 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGxFZRh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:40 INFO - PROCESS | 18693 | RSS: Main: 174190592 04:14:40 INFO - PROCESS | 18693 | 04:15:31 INFO - PROCESS | 18693 | 1480076131744 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] 04:17:45 INFO - PROCESS | 18693 | Cycle 1(1): loaded http://localhost:49939/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49939/tests/dromaeo/cssquery-ext.html) 04:17:46 INFO - PROCESS | 18693 | RSS: Main: 315195392 04:17:46 INFO - PROCESS | 18693 | 04:20:49 INFO - PROCESS | 18693 | Cycle 1(1): loaded http://localhost:49939/tests/dromaeo/cssquery-ext.html (next: http://localhost:49939/tests/dromaeo/cssquery-jquery.html) 04:20:50 INFO - PROCESS | 18693 | RSS: Main: 284811264 04:20:50 INFO - PROCESS | 18693 | 04:23:53 INFO - PROCESS | 18693 | Cycle 1(1): loaded http://localhost:49939/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49939/tests/dromaeo/cssquery-mootools.html) 04:23:53 INFO - PROCESS | 18693 | RSS: Main: 222912512 04:23:53 INFO - PROCESS | 18693 | 04:26:56 INFO - PROCESS | 18693 | Cycle 1(1): loaded http://localhost:49939/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49939/tests/dromaeo/cssquery-prototype.html) 04:26:56 INFO - PROCESS | 18693 | RSS: Main: 263847936 04:26:56 INFO - PROCESS | 18693 | 04:29:59 INFO - PROCESS | 18693 | Cycle 1(1): loaded http://localhost:49939/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49939/tests/dromaeo/cssquery-yui.html) 04:30:00 INFO - PROCESS | 18693 | RSS: Main: 221298688 04:30:00 INFO - PROCESS | 18693 | 04:33:03 INFO - PROCESS | 18693 | Cycle 1(1): loaded http://localhost:49939/tests/dromaeo/cssquery-yui.html (next: http://localhost:49939/tests/dromaeo/cssquery-dojo.html) 04:33:03 INFO - PROCESS | 18693 | RSS: Main: 321581056 04:33:03 INFO - PROCESS | 18693 | 04:33:03 INFO - PROCESS | 18693 | __start_tp_report 04:33:03 INFO - PROCESS | 18693 | _x_x_mozilla_page_load 04:33:03 INFO - PROCESS | 18693 | _x_x_mozilla_page_load_details 04:33:03 INFO - PROCESS | 18693 | |i|pagename|runs| 04:33:03 INFO - PROCESS | 18693 | |0;dojo.html;2539.4032402385437;2558.8976440942365;2589.5727205011176;2590.7927365810738;2599.298189488838;4474.328850672401;4535.7278563286145;4590.013147173357;4598.241290187119;4599.65502587306;4535.501094879569;4547.795349209286;4548.181327361073;4551.8634440966825;4554.703944243622;4188.246115699165;4198.223328684188;4219.2616292148905;4228.344606585969;4248.044190057243;4223.61987421132;4252.808623611945;4259.403683484315;4282.700210985232;4348.913021739563;4219.936700949488;4234.06850492891;4261.701680882339;4301.827926882921;4315.331123675835;4300.526942036405;4304.978475107636;4305.311150215982;4307.870763877088;4356.716813407118;4113.650339721127;4166.416701661769;4207.368894665794;4220.3036498977635;4271.530131685512;4575.22221222393;4582.1981153298375;4602.79287432063;4605.723656580616;4670.602998745111;4842.806287748486;4847.248676455155;4866.902661946777;4901.068796928572;4952.108620448318;4721.409823772028;4766.880827979294;4771.308160316769;4924.064427758714;4924.507549245047;4542.954570454319;4607.838725644653;4624.375709279271;4626.329182268552;4649;5045.066662667418;5045.470225626256;5054.747262636927;5055.165897626924;5102.158143906214;4645.953540464552;4848.442429120696;4848.611588271381;4859.65982381237;4907.509249075064;4738.384010078667;4816.8073277069225;4819.638527110411;4869.172240719086;4879.26810978349;4844.733539655283;4846.079244943449;4861.951380486221;4887.853364399074;4894.706317620883;4828.855134345975;4829.1307564638;4832.903341933142;4833.178359678863;4878.682885612424;4139.875803725893;4160.729552579072;4195.58044195578;4198.286291330481;4251.638610718123;3681.2821499807815;3701.1672373716237;3731.3470142724914;3734.682551983112;3744.4944932433773;4203.117345357448;4221.641160501392;4227.154569086195;4230.49234091911;4265.552117027667;4744.976275118603;4874.683145595525;4883.316335713003;4895.828645997373;4941.975290123526;4158.334666453353;4184.058586818002;4204.789760511962;4223.619874211275;4231.809568569422;4476.910461790746;4477.059817438374;4480.215962206601;4514.503404625489;4525.072360166158;4543.636509079266;4578.839740609063;4585.495595484561;4587.357769912148;4630.814767409401;4728.527147285244;4824.8793780155775;4829.299751536078;4853.102176097434;4928.901421971612;4523.570260825217;4585.380973568525;4586.036932244266;4624.190766615761;4636.8145274188655;4798.904021919612;4833.009233107275;4836.322914791862;4838.951610483991;4884.633652476007;4722.7874745635845;4828.106800241966;4900.26496025599;4903.8528844134735;4937.5556199942175;4708;4721.079389519148;4753.239481682914;4759.3574867393845;4810.542998415145;4755.667103302874;4761.523847615211;4764.737939413227;4768.642351823696;4810.975945120252;4687.531246875285;4688.718676879398;4688.835890743808;4697.248440249544;4728.668993170445;4680.672352935262;4742.146413645577;4745.145873742759;4787.593054590398;4838.540338667821;4757.595604373667;4764.4282686077895;4799.856004319876;4807.302941073594;4816.783244754065 04:33:03 INFO - PROCESS | 18693 | |1;ext.html;554.2849723856226;563.9999999999999;577.1112486770373;580.8605934575701;586.4165155670106;28358.57462138067;37832.62167378325;39690;39726.80136599317;42650.786746066304;39332.7067669173;39656;39704.602953970454;39769.20461590766;39828.40257396134;7434.070741157342;7568.318851303382;7579.279968403021;7580.6967721291085;7584.393248540131;7407.55554666719;7592.240775922419;9660.710178694615;9884.159846413027;9909.405435673847;9927.056929591678;9970.800583988315;9986.950065249664;9990.50047497626;9995.800083998316;9870.851937220912;9913.058259465339;9934.602615895428;9943.303968722192;9947.403155810674;9612.471314077722;9684.806303873884;9730.172935300508;9735.26985476085;9742.220622350194;35642.28715425677;35826.28347433063;35887;35942;35991.640083599355;2907.912762617125;2945.7937944343903;2974.598429212072;3136.764742644311;3254.088855120546;27327.863360683266;27792.58311125335;27796.30509237265;27872.442551149066;29195.270118247;3405.8126803025825;3422.691957723792;3436.0894362993827;3535.5934067582302;3589.587197472298;242999;243150;243508.99999999822;244043;244248;43932.78033609811;44009;44025;44118.33822492601;44123.558764412584;50654.49345506498;51114.48885511172;51184;51216.74391628018;51277;13252.403641836141;13816.654583635289;13828.861711382959;13838.723225535434;13841.723165536632;9055.18503334703;9342.57958391874;9938.354006989523;10168.694939151837;10171.54228059739;14284.714305713827;14466.20435876037;14662.706745865024;14988.47540336083;15067.547973560811;5393.191021346829;5568.610197286151;5578.832635020955;5627.634203776742;5698.116791897262;756.3684323589864;790.0234724310686;886.7384121684119;953.947532885684;973.9853902191472;25574.48851022969;26734;27307;27397;27649.91701825595;887.3522328700085;894.7002754077457;934.065934065934;965.1940629574244;1000.3044838997974;14130;14281.642958925902;14488.565343039725;14730.263486825615;14742;328602;329697;336798;338289;338889;46619;46635.533644663796;46727.76636116866;46800.29799553009;46836.297455538195;1010.777628921636;1052.8368102944055;1057.5346847387125;1123.6794525051166;1128.1651577832345;26097.608535871597;29533;30318.84840575783;30785.8460707695;31273.687263127078;43925.780371099216;44484;44595.777021114685;44617.33074003828;44631;312543;319151;319810;320579;320602;33125.503117453736;34015;34171.4874276891;34193.829030854686;34242;39305.41041884317;39398;39731.40402894017;40546;40571.928508936384;33387;33854.322913542084;34315.313693726486;34432.483512746825;34457.31085378329;33687.663123369435;34050;34261.82869085639;34655.480167796995;35208.47187292244;32907.83546082254;33472.330553389285;33664.66335336615;33956.1510962218;34036.14909627279;29637.85181074081;30946.226344341572;31274;31645.367092657558;31997.680023200403;24067;24305.878470607535;24780.752192478565;25100.372490687147;25143.622845657697 04:33:03 INFO - PROCESS | 18693 | |2;jquery.html;343.4830579977134;364.12064863355;368.50988185713004;370.53497860185473;389.4042115563187;12616.432260548274;15635;15754.291056902453;16584.751228731548;17597.912010439963;16183.514494565152;16580.088095154762;16885.15574221287;16982.660346793087;17012.48962531126;4779.880502987418;5023.346964894558;5206.7917283308625;5486.91769623456;5525.917111243334;3426.6059403168706;3626.0390996385977;5487.780488780464;5527.060399732035;5527.143292789604;5135.8202462913805;5374.91937620936;5397.73011349431;5452.945470545284;5456.072467680504;5270.973645131749;5435.130379139318;5436.015854213203;5441.863953401177;5442.755076021588;5356.571474282048;5356.892862142774;5357.035733567956;5362.356517217959;5365.758540865631;12153.635390938285;14066.85933140676;19543.218271269132;19638.312659056865;19738.21047158112;1721.9311227550884;1846.4829847642682;1864.4779461750732;2169.208238992772;2395.2814155753204;8705.782355441164;8754;8961.059088795713;9233.815323693489;9346.205572526344;1708.7864016997876;1720.8021077575988;1726.3181043487878;1743.0848804377677;1804.3053424431557;69206.9618955711;69706;69903;70187;71361;9336.813263734823;9407;9895.356801807859;9970.501474926225;9980.262764409104;13709;13727.588172354845;13748.243846588533;13748.93125534386;13767.655808604664;6821.420179284717;6831.11195544576;6890.414314783199;7029.8242543935785;7146.642667866586;6437.871242575122;6639.966800165968;6731.158605174353;6923.273056329013;6962.7911162665205;4244.405783190356;4348.195583817004;4360.084382279693;4426.557344265612;4453.665975051884;1753.6931037068716;1826.8355847973746;1832.1114259584092;1882.143624650808;1890.0549725137432;781.8475397297473;800.9639566219535;820.1265652080515;836.5273620404573;896.789254525186;16002.119883406524;16473.588160296087;17100.230489627997;17312.134393280536;17359.82640173582;785.09713829097;792.1484404265437;842.4439869685978;853.4964371021003;916.1479823763964;9407.670731524364;9440.716778496657;9688.46713430768;9772.560234789451;9888.159506441889;269921;272322;273893;348259;348996;78533.60733196298;79840;80407.59796201099;80542.5972870132;81532.59233703793;897.7441429192779;916.8624706293975;948.5067764762285;953.7329547726648;955.7610597350663;15322.923385383001;15327.15700636431;16020.439284624983;16280;16304.918475407547;35154.25417568596;36042.63957360393;36226.63773362338;36624;36802.447963281105;51309.743451282506;52262;52282.73858630683;53133.734331328094;53511.46488535065;7162.247963963709;7251.311125443285;7361.2638736125955;7521.5111017783665;7673.309402153833;9822.852657210005;11390.430478476208;11482.655520334403;11484.655460336204;11952.462139203582;9665.323427360017;9892.208623310262;9953.15398191133;10011.949940250252;10464.895351046393;10090.445025523666;10121.59513619447;10134.543945522617;10140.087392134743;10293.691189264335;9810.920798712279;9973.900260997587;10069.798604027732;10164.491775411348;10341.741456463347;7019.789406317818;7061.505694601534;7134.250903655249;7356.117265928123;7408.259174082548;8405.70580029696;9787.853182202414;10032.247581431568;10061.245406594388;10076.69769906904 04:33:03 INFO - PROCESS | 18693 | |3;mootools.html;1137.74400759829;1333.359987206141;1363.8022486739424;1428.621415324939;1628.9104099274534;6108;6769.796906092819;7009.439244860411;7024.859502809947;7165.570065796056;7026.1217347831525;7084.362407383334;7084.362407383334;7089.822754431142;7160.64196790161;1785.803561608222;1863.8881667100018;2029.939101826944;2057.187410972665;2064.194963964055;1990.0945069993118;2054.60962417141;2057.6501994660944;2060.361288000717;2061.907214175366;2000.769911460179;2004.4587961250454;2004.9498762530907;2005.8495612829024;2007.7590689117253;1977.3968939473455;2024.534357097861;2025.5543780368296;2025.9088341024615;2030.3198428526462;1985.851061170418;2032.623964566545;2038.520947577318;2060.4333808202714;2060.8557400981936;6910.965445172742;7047.400970917478;7110.822229444254;7111.679974401164;7119.50163488556;4268.338407546835;4377.277749171383;4399.670024748125;4401.317795741633;4401.339799030139;2764.156932135698;2798.1605518344413;2843.061789609424;2912.184588315275;2972.4055188962293;854.7307598106577;872.2672954718067;899.7210864631919;900.3157600223811;909.7498187998287;9232.215261702764;9429.575669094907;9462;9492.525373731354;9539.666111686058;3775.2260786538695;3854.5952674969285;3904.8438062477185;3922.941155882664;4005.1589166274825;8243.629036693363;8267.586620668942;8270.25567698898;8270.338372930151;8272.214139656722;4400.71395359307;4405.163019026375;4405.537418571068;4410.757408342572;4411.404460397869;3433.484977253432;3485.6165821759587;3886.1839013806853;3953.327934251184;3953.8220780064967;3155.605549306337;3332.7000569948336;3355.496675498695;3380.2563436044525;3402.9489557656657;1108.1854836695022;1108.844761733358;1112.788570171681;1121.2935850414187;1129.1982692288568;794.0550744613892;800.9719659811879;809.4212637963884;816.6488409983646;822.5517093184229;4835.927461088087;4939.53074457926;4987.900241995139;5097.617678674114;5175.171972484384;388.74342933663644;392.5309255439722;400.74352414454773;404.79557823299047;413.20251913806044;3554.147004718849;3556.6798988090677;3565.5186549815962;3582.387925433565;3664.486971823947;7821.765347039598;8218.547979861165;8229.95885020583;8234.917650823416;8244.258016778518;7971.60141992898;8163.265306122477;8184.058833234135;8190.058143313595;8199.057108432487;6286.402791734778;6289.339619339995;6358.205224346957;6374.171357723559;6380.872382552323;4778.283257511401;4909.361782968192;4918.82784102569;4933.703977761203;4938.777755000961;7405.666744996596;7436.219196984455;7489.400847932044;7494.213107623839;7529.171791103084;7537.057867766529;7547.73582924595;7582.962085189539;7612.80967975805;7626.199249078767;5426.755795989269;5696.886062278814;5900.586958912835;5959.851003724768;6072.210612620331;6060.212172417558;6504.674766261763;6793;6797.72809087631;6921;6043.36544662804;6131.049687298476;6150.477209437248;6368.299487056513;6442.806715798533;6127.295361033538;6128.846778830565;6202.224721909762;6203.565750397429;6217.440430361289;5837.270341207349;5932.406759324033;5942.465178133989;5944.6730429826775;5949.8215053548465;4293.677974152014;4315.978420107879;4371.344298355145;4443.600075993176;4528.275475923836;4213.1784302060805;4296.4414626098405;4353.172897149531;4381.934270985874;4409.889752756078 04:33:03 INFO - PROCESS | 18693 | |4;prototype.html;285.5987337790405;288.38142185013146;296.0924765593456;298.119058183069;300.03090019237874;4605.194091034064;4740.871025123419;4742.9288560671575;4766.761661916903;4795.184818580837;4616.861494155172;4657.301404789283;4707.388039554853;4727.9290810637785;4739.90520189596;3778.6599206071446;3786.394176931685;3797.316483033053;3808.6762625176752;3811.3330167220624;3784.6026167252453;3814.218085292522;3818.06457417933;3826.827792749333;3832.1222600925626;3615.8734444294455;3703.1482758965453;3726.9068273293115;3733;3750.399936010239;3707.480952666629;3739.476473293741;3739.6260373962523;3747.2692824899154;3748.9437658435145;3211.1008917503136;3211.6306624737986;3216.4371235033777;3220.806751594912;3242.610886693612;4539.335254639552;4548.226801443762;4617.699849509805;4637.234856248715;4665;4140.192662430827;4149.83400663973;4168.270552653274;4176.373543968429;4183.644390226835;4940.629452791055;4949.267756285308;4951.801927922878;4954.851354459336;4956.1822299320565;3523.119220194951;3527.9118022049397;3528.153243221634;3534.7879127252445;3536.328097661436;4890.266460030988;5122.667026643294;5169.4830516948;5178.870528236825;5203.297554830087;3539.663731945461;3548.8757893473603;3552.8401221945073;3562.1450851795385;3567.4113771227976;3592.5688917329567;3592.586852511942;3624.6919011883756;3650.288193802236;3652.8904132876055;3950.3876899080115;4123.752574845459;4142.5857414258335;4145.66834653227;4152.522459917088;4963.851084467472;4996.550310472075;5004.224345226496;5005.5745261653165;5026.4973502649445;1161.361251311775;1199.8920097191294;1206.2822620540765;1210.4129497193853;1215.8905698487179;801.903771547418;813.4996976859308;816.9264766171074;820.5938060660012;827.4828232354778;4254.234237837219;4256.5105012923295;4258.510271318776;4266.530681625019;4273.957260427418;4950.628702847301;4955.90088198234;4985.4266759323145;4996.7501624918605;4999.725015124203;4281.571842815693;4297.333913243452;4299.828006879752;4302.7848607569495;4311.6335111515245;2507.749225077514;2630.4348912397095;2643.220250026247;2659.842968308792;2662.9600555991674;4658.976705116453;4664.553988263649;4670.929936050962;4682.672212945061;4684.695494792828;5102.8214012510125;5136.126858434075;5136.563392111712;5140.997505486469;5149.2791009258735;4520.344550040226;4612.215923293115;4618.95381046192;4660.207764680013;4662.254039353755;4978.6763860348965;4987.950120498748;4988.501149884983;5001.524855138756;5023.4725353838785;4928.841722195353;4931.852044438672;4937.481564435682;4944.5549900507685;4950.9257361140335;4423.270160423623;4599.701019433726;4637.498688490168;4652.744099074584;4654.581087702123;3438.277961628086;3449.6032956210356;3452.8778147102794;3454.5336379588434;3463.4631632097066;4965.45380008206;4968.701877887338;4970.3657061755885;4971.726555039363;4972.751362431936;4439.644828413655;4797.856064318076;4808.158572249912;4910.779014944407;4919.360483137312;4881.267809828554;4945.851624451272;4967.304577359245;4998.700077995332;4999.150144475375;4802.959309494451;4843.418789745253;4868.2210846264425;4869.589553171203;4878.536539028786;4825.710457372569;4966.205407134841;4978.576820970258;4986.354503014069;4993.975030124971;4881.780319885685;4882.072406242944;4887.951120488749;4901.803927842846;4904.558589726942 04:33:03 INFO - PROCESS | 18693 | |5;yui.html;610.8656095658955;631.2015300644682;684.0457561701423;693.916729992401;705.4673721340387;11317.207795454322;12559;12651.177673451219;12708.301043442607;12724.618261452148;11778.411079446036;11944.343061131656;11971.700707482318;12075.396230188477;12111.878881211185;757.0234397627055;773.8761798112304;776.343989329016;776.97669069928;777.6617171530374;601.6209787833681;619.6715740657459;739.3124394313313;762.2187258060477;768.8846672999039;814.1654803826096;819.0580832043139;820.233082068265;821.2649678537705;821.2977903892175;808.7007807111347;808.894843670325;808.9838203235931;809.1059379385753;809.3525179856092;477.0506691683525;484.53242620871026;576.9509591684712;586.2173997713058;596.335086378689;12269.079819013521;12271.75456490874;12276.938615306955;12277.447514861853;12305.44625491855;11562.479688413958;11569.132315076318;11981.460834262392;12283.57007504733;12346.197497162655;9615.278854085902;9633.181179599742;9851.113399793981;10247.692569222936;11066.170037247239;3173.349463360029;3192.7765056445824;3263.857649822543;3353.5305057292;4082.5509193988637;50225.55489501555;50343.24485132726;50384.496155038345;50670.7466462669;51615.74192129053;9816.705498835046;9839.704808855746;9904.752381190528;10085.445300508396;10214.744631384276;17078.146092695315;17183.1408429578;17223.3971810986;17300.740488892676;17549.649007019787;6090.116933044772;6216.378362163748;6240.656763878031;6253.874922501524;6426.903596446057;3318.419276626629;3393.0160253526697;3436.398630239698;3470.514128022079;3505.6669616386403;2689.9374746974836;2763.4473105379006;2773.3205364685377;2776.5279902416637;2780.972190278071;471.2601216090773;471.3142377840234;479.8752324395682;480.8653576998446;484.94665586785425;465.6206783337212;522.8483739715516;564.8336185776441;568.499720246189;582.8309790160806;7493.812654683677;7516.887246691304;7544;7707.574098791742;7732.57470839098;490.9877253068702;567.5062695454898;573.5125143627882;581.8748968971692;588.1119509540624;3468.930621387558;3556.6798988091195;3690.9261814763554;3691.1141326081547;3692;63649;68265.3173468269;69511.30488695149;70549.64725176444;70735.29264707287;59757.701211493666;60441.69779151076;61264;62433.375666243664;62547.374526254156;52833.94332113336;54623;55492.445075549535;56297.15554266689;57354.7132264336;6774.627395493295;6849.452043836581;6891.276415976451;7086.893696594659;7362.079740032496;37951.81024094862;38689.381665656285;39701.801490993515;39778;40100;46359.768201158775;46575;50399.74800125976;51317.7434112827;54300;10760.139188865029;10801;11346.886531134583;11464.94267528657;11490.655280341603;11371;11431.428428578703;11462.94268528652;11694.2983420995;11840.644780656594;8874.423162494417;11256.268342557707;11419.543218271509;11473.770524589629;11697.122715796178;11818.227265910182;11891.167618266638;11909.22590031645;12144.939275303566;12328.876711233132;10709.357438553712;10990.560377584807;11201.66395008151;11491.655250342503;11608.24546404481;9492.240620750184;9497.382670126419;9541.856872147062;9731.464769437465;9766.316357854881;9307.674231401868;9357.85963210566;9395.201407880133;9404.38871473352;9442.95278523603 04:33:03 INFO - PROCESS | 18693 | __end_tp_report 04:33:03 INFO - PROCESS | 18693 | __start_cc_report 04:33:03 INFO - PROCESS | 18693 | _x_x_mozilla_cycle_collect,1481 04:33:03 INFO - PROCESS | 18693 | __end_cc_report 04:33:03 INFO - PROCESS | 18693 | __startTimestamp1480077183606__endTimestamp 04:33:03 INFO - PROCESS | 18693 | 04:33:03 INFO - PROCESS | 18693 | ------- Summary: start ------- 04:33:03 INFO - PROCESS | 18693 | Number of tests: 6 04:33:03 INFO - PROCESS | 18693 | 04:33:03 INFO - PROCESS | 18693 | [#0] dojo.html Cycles:165 Average:4529.16 Median:4636.81 stddev:455.40 (9.8%) stddev-sans-first:429.21 04:33:03 INFO - PROCESS | 18693 | Values: 2539.4 2558.9 2589.6 2590.8 2599.3 4474.3 4535.7 4590.0 4598.2 4599.7 4535.5 4547.8 4548.2 4551.9 4554.7 4188.2 4198.2 4219.3 4228.3 4248.0 4223.6 4252.8 4259.4 4282.7 4348.9 4219.9 4234.1 4261.7 4301.8 4315.3 4300.5 4305.0 4305.3 4307.9 4356.7 4113.7 4166.4 4207.4 4220.3 4271.5 4575.2 4582.2 4602.8 4605.7 4670.6 4842.8 4847.2 4866.9 4901.1 4952.1 4721.4 4766.9 4771.3 4924.1 4924.5 4543.0 4607.8 4624.4 4626.3 4649.0 5045.1 5045.5 5054.7 5055.2 5102.2 4646.0 4848.4 4848.6 4859.7 4907.5 4738.4 4816.8 4819.6 4869.2 4879.3 4844.7 4846.1 4862.0 4887.9 4894.7 4828.9 4829.1 4832.9 4833.2 4878.7 4139.9 4160.7 4195.6 4198.3 4251.6 3681.3 3701.2 3731.3 3734.7 3744.5 4203.1 4221.6 4227.2 4230.5 4265.6 4745.0 4874.7 4883.3 4895.8 4942.0 4158.3 4184.1 4204.8 4223.6 4231.8 4476.9 4477.1 4480.2 4514.5 4525.1 4543.6 4578.8 4585.5 4587.4 4630.8 4728.5 4824.9 4829.3 4853.1 4928.9 4523.6 4585.4 4586.0 4624.2 4636.8 4798.9 4833.0 4836.3 4839.0 4884.6 4722.8 4828.1 4900.3 4903.9 4937.6 4708.0 4721.1 4753.2 4759.4 4810.5 4755.7 4761.5 4764.7 4768.6 4811.0 4687.5 4688.7 4688.8 4697.2 4728.7 4680.7 4742.1 4745.1 4787.6 4838.5 4757.6 4764.4 4799.9 4807.3 4816.8 04:33:03 INFO - PROCESS | 18693 | 04:33:03 INFO - PROCESS | 18693 | [#1] ext.html Cycles:180 Average:45180.64 Median:34931.98 stddev:79029.32 (226.2%) stddev-sans-first:79179.99 04:33:03 INFO - PROCESS | 18693 | Values: 554.3 564.0 577.1 580.9 586.4 28358.6 37832.6 39690.0 39726.8 42650.8 39332.7 39656.0 39704.6 39769.2 39828.4 7434.1 7568.3 7579.3 7580.7 7584.4 7407.6 7592.2 9660.7 9884.2 9909.4 9927.1 9970.8 9987.0 9990.5 9995.8 9870.9 9913.1 9934.6 9943.3 9947.4 9612.5 9684.8 9730.2 9735.3 9742.2 35642.3 35826.3 35887.0 35942.0 35991.6 2907.9 2945.8 2974.6 3136.8 3254.1 27327.9 27792.6 27796.3 27872.4 29195.3 3405.8 3422.7 3436.1 3535.6 3589.6 242999.0 243150.0 243509.0 244043.0 244248.0 43932.8 44009.0 44025.0 44118.3 44123.6 50654.5 51114.5 51184.0 51216.7 51277.0 13252.4 13816.7 13828.9 13838.7 13841.7 9055.2 9342.6 9938.4 10168.7 10171.5 14284.7 14466.2 14662.7 14988.5 15067.5 5393.2 5568.6 5578.8 5627.6 5698.1 756.4 790.0 886.7 953.9 974.0 25574.5 26734.0 27307.0 27397.0 27649.9 887.4 894.7 934.1 965.2 1000.3 14130.0 14281.6 14488.6 14730.3 14742.0 328602.0 329697.0 336798.0 338289.0 338889.0 46619.0 46635.5 46727.8 46800.3 46836.3 1010.8 1052.8 1057.5 1123.7 1128.2 26097.6 29533.0 30318.8 30785.8 31273.7 43925.8 44484.0 44595.8 44617.3 44631.0 312543.0 319151.0 319810.0 320579.0 320602.0 33125.5 34015.0 34171.5 34193.8 34242.0 39305.4 39398.0 39731.4 40546.0 40571.9 33387.0 33854.3 34315.3 34432.5 34457.3 33687.7 34050.0 34261.8 34655.5 35208.5 32907.8 33472.3 33664.7 33956.2 34036.1 29637.9 30946.2 31274.0 31645.4 31997.7 24067.0 24305.9 24780.8 25100.4 25143.6 04:33:03 INFO - PROCESS | 18693 | 04:33:03 INFO - PROCESS | 18693 | [#2] jquery.html Cycles:180 Average:21781.83 Median:28776.86 stddev:51258.73 (178.1%) stddev-sans-first:51377.25 04:33:03 INFO - PROCESS | 18693 | Values: 343.5 364.1 368.5 370.5 389.4 12616.4 15635.0 15754.3 16584.8 17597.9 16183.5 16580.1 16885.2 16982.7 17012.5 4779.9 5023.3 5206.8 5486.9 5525.9 3426.6 3626.0 5487.8 5527.1 5527.1 5135.8 5374.9 5397.7 5452.9 5456.1 5271.0 5435.1 5436.0 5441.9 5442.8 5356.6 5356.9 5357.0 5362.4 5365.8 12153.6 14066.9 19543.2 19638.3 19738.2 1721.9 1846.5 1864.5 2169.2 2395.3 8705.8 8754.0 8961.1 9233.8 9346.2 1708.8 1720.8 1726.3 1743.1 1804.3 69207.0 69706.0 69903.0 70187.0 71361.0 9336.8 9407.0 9895.4 9970.5 9980.3 13709.0 13727.6 13748.2 13748.9 13767.7 6821.4 6831.1 6890.4 7029.8 7146.6 6437.9 6640.0 6731.2 6923.3 6962.8 4244.4 4348.2 4360.1 4426.6 4453.7 1753.7 1826.8 1832.1 1882.1 1890.1 781.8 801.0 820.1 836.5 896.8 16002.1 16473.6 17100.2 17312.1 17359.8 785.1 792.1 842.4 853.5 916.1 9407.7 9440.7 9688.5 9772.6 9888.2 269921.0 272322.0 273893.0 348259.0 348996.0 78533.6 79840.0 80407.6 80542.6 81532.6 897.7 916.9 948.5 953.7 955.8 15322.9 15327.2 16020.4 16280.0 16304.9 35154.3 36042.6 36226.6 36624.0 36802.4 51309.7 52262.0 52282.7 53133.7 53511.5 7162.2 7251.3 7361.3 7521.5 7673.3 9822.9 11390.4 11482.7 11484.7 11952.5 9665.3 9892.2 9953.2 10011.9 10464.9 10090.4 10121.6 10134.5 10140.1 10293.7 9810.9 9973.9 10069.8 10164.5 10341.7 7019.8 7061.5 7134.3 7356.1 7408.3 8405.7 9787.9 10032.2 10061.2 10076.7 04:33:03 INFO - PROCESS | 18693 | 04:33:03 INFO - PROCESS | 18693 | [#3] mootools.html Cycles:180 Average:4626.39 Median:4939.15 stddev:2486.31 (50.3%) stddev-sans-first:2479.46 04:33:03 INFO - PROCESS | 18693 | Values: 1137.7 1333.4 1363.8 1428.6 1628.9 6108.0 6769.8 7009.4 7024.9 7165.6 7026.1 7084.4 7084.4 7089.8 7160.6 1785.8 1863.9 2029.9 2057.2 2064.2 1990.1 2054.6 2057.7 2060.4 2061.9 2000.8 2004.5 2004.9 2005.8 2007.8 1977.4 2024.5 2025.6 2025.9 2030.3 1985.9 2032.6 2038.5 2060.4 2060.9 6911.0 7047.4 7110.8 7111.7 7119.5 4268.3 4377.3 4399.7 4401.3 4401.3 2764.2 2798.2 2843.1 2912.2 2972.4 854.7 872.3 899.7 900.3 909.7 9232.2 9429.6 9462.0 9492.5 9539.7 3775.2 3854.6 3904.8 3922.9 4005.2 8243.6 8267.6 8270.3 8270.3 8272.2 4400.7 4405.2 4405.5 4410.8 4411.4 3433.5 3485.6 3886.2 3953.3 3953.8 3155.6 3332.7 3355.5 3380.3 3402.9 1108.2 1108.8 1112.8 1121.3 1129.2 794.1 801.0 809.4 816.6 822.6 4835.9 4939.5 4987.9 5097.6 5175.2 388.7 392.5 400.7 404.8 413.2 3554.1 3556.7 3565.5 3582.4 3664.5 7821.8 8218.5 8230.0 8234.9 8244.3 7971.6 8163.3 8184.1 8190.1 8199.1 6286.4 6289.3 6358.2 6374.2 6380.9 4778.3 4909.4 4918.8 4933.7 4938.8 7405.7 7436.2 7489.4 7494.2 7529.2 7537.1 7547.7 7583.0 7612.8 7626.2 5426.8 5696.9 5900.6 5959.9 6072.2 6060.2 6504.7 6793.0 6797.7 6921.0 6043.4 6131.0 6150.5 6368.3 6442.8 6127.3 6128.8 6202.2 6203.6 6217.4 5837.3 5932.4 5942.5 5944.7 5949.8 4293.7 4316.0 4371.3 4443.6 4528.3 4213.2 4296.4 4353.2 4381.9 4409.9 04:33:03 INFO - PROCESS | 18693 | 04:33:03 INFO - PROCESS | 18693 | [#4] prototype.html Cycles:180 Average:4072.17 Median:4628.09 stddev:1183.10 (25.6%) stddev-sans-first:1151.77 04:33:03 INFO - PROCESS | 18693 | Values: 285.6 288.4 296.1 298.1 300.0 4605.2 4740.9 4742.9 4766.8 4795.2 4616.9 4657.3 4707.4 4727.9 4739.9 3778.7 3786.4 3797.3 3808.7 3811.3 3784.6 3814.2 3818.1 3826.8 3832.1 3615.9 3703.1 3726.9 3733.0 3750.4 3707.5 3739.5 3739.6 3747.3 3748.9 3211.1 3211.6 3216.4 3220.8 3242.6 4539.3 4548.2 4617.7 4637.2 4665.0 4140.2 4149.8 4168.3 4176.4 4183.6 4940.6 4949.3 4951.8 4954.9 4956.2 3523.1 3527.9 3528.2 3534.8 3536.3 4890.3 5122.7 5169.5 5178.9 5203.3 3539.7 3548.9 3552.8 3562.1 3567.4 3592.6 3592.6 3624.7 3650.3 3652.9 3950.4 4123.8 4142.6 4145.7 4152.5 4963.9 4996.6 5004.2 5005.6 5026.5 1161.4 1199.9 1206.3 1210.4 1215.9 801.9 813.5 816.9 820.6 827.5 4254.2 4256.5 4258.5 4266.5 4274.0 4950.6 4955.9 4985.4 4996.8 4999.7 4281.6 4297.3 4299.8 4302.8 4311.6 2507.7 2630.4 2643.2 2659.8 2663.0 4659.0 4664.6 4670.9 4682.7 4684.7 5102.8 5136.1 5136.6 5141.0 5149.3 4520.3 4612.2 4619.0 4660.2 4662.3 4978.7 4988.0 4988.5 5001.5 5023.5 4928.8 4931.9 4937.5 4944.6 4950.9 4423.3 4599.7 4637.5 4652.7 4654.6 3438.3 3449.6 3452.9 3454.5 3463.5 4965.5 4968.7 4970.4 4971.7 4972.8 4439.6 4797.9 4808.2 4910.8 4919.4 4881.3 4945.9 4967.3 4998.7 4999.2 4803.0 4843.4 4868.2 4869.6 4878.5 4825.7 4966.2 4978.6 4986.4 4994.0 4881.8 4882.1 4888.0 4901.8 4904.6 04:33:03 INFO - PROCESS | 18693 | 04:33:03 INFO - PROCESS | 18693 | [#5] yui.html Cycles:180 Average:14627.10 Median:50363.87 stddev:18709.30 (37.1%) stddev-sans-first:18732.18 04:33:03 INFO - PROCESS | 18693 | Values: 610.9 631.2 684.0 693.9 705.5 11317.2 12559.0 12651.2 12708.3 12724.6 11778.4 11944.3 11971.7 12075.4 12111.9 757.0 773.9 776.3 777.0 777.7 601.6 619.7 739.3 762.2 768.9 814.2 819.1 820.2 821.3 821.3 808.7 808.9 809.0 809.1 809.4 477.1 484.5 577.0 586.2 596.3 12269.1 12271.8 12276.9 12277.4 12305.4 11562.5 11569.1 11981.5 12283.6 12346.2 9615.3 9633.2 9851.1 10247.7 11066.2 3173.3 3192.8 3263.9 3353.5 4082.6 50225.6 50343.2 50384.5 50670.7 51615.7 9816.7 9839.7 9904.8 10085.4 10214.7 17078.1 17183.1 17223.4 17300.7 17549.6 6090.1 6216.4 6240.7 6253.9 6426.9 3318.4 3393.0 3436.4 3470.5 3505.7 2689.9 2763.4 2773.3 2776.5 2781.0 471.3 471.3 479.9 480.9 484.9 465.6 522.8 564.8 568.5 582.8 7493.8 7516.9 7544.0 7707.6 7732.6 491.0 567.5 573.5 581.9 588.1 3468.9 3556.7 3690.9 3691.1 3692.0 63649.0 68265.3 69511.3 70549.6 70735.3 59757.7 60441.7 61264.0 62433.4 62547.4 52833.9 54623.0 55492.4 56297.2 57354.7 6774.6 6849.5 6891.3 7086.9 7362.1 37951.8 38689.4 39701.8 39778.0 40100.0 46359.8 46575.0 50399.7 51317.7 54300.0 10760.1 10801.0 11346.9 11464.9 11490.7 11371.0 11431.4 11462.9 11694.3 11840.6 8874.4 11256.3 11419.5 11473.8 11697.1 11818.2 11891.2 11909.2 12144.9 12328.9 10709.4 10990.6 11201.7 11491.7 11608.2 9492.2 9497.4 9541.9 9731.5 9766.3 9307.7 9357.9 9395.2 9404.4 9443.0 04:33:03 INFO - PROCESS | 18693 | -------- Summary: end -------- 04:33:03 INFO - PROCESS | 18693 | 04:33:04 INFO - TEST-INFO | 18693: exit 0 04:33:04 INFO - TEST-OK | dromaeo_css | took 1123011ms 04:33:04 INFO - TEST-START | kraken 04:33:04 INFO - operating with platform_type : linux_ 04:33:04 INFO - Initialising browser for kraken test... 04:33:04 INFO - TEST-INFO | started process 19000 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5abT4P/profile http://localhost:49939/getInfo.html) 04:33:08 INFO - PROCESS | 19000 | __metrics Screen width/height:1600/1200 04:33:08 INFO - PROCESS | 19000 | colorDepth:24 04:33:08 INFO - PROCESS | 19000 | Browser inner width/height: 1024/697 04:33:08 INFO - PROCESS | 19000 | __metrics 04:33:09 INFO - PROCESS | 19000 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:33:09 INFO - PROCESS | 19000 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:33:10 INFO - TEST-INFO | 19000: exit 0 04:33:10 INFO - Browser initialized. 04:33:10 INFO - Running cycle 1/1 for kraken test... 04:33:10 INFO - TEST-INFO | started process 19082 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5abT4P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:23 INFO - PROCESS | 19082 | RSS: Main: 174452736 04:33:23 INFO - PROCESS | 19082 | 04:33:26 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:49939/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49939/tests/kraken/driver.html?testName=audio-beat-detection) 04:33:27 INFO - PROCESS | 19082 | RSS: Main: 239218688 04:33:27 INFO - PROCESS | 19082 | 04:33:29 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:49939/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49939/tests/kraken/driver.html?testName=audio-dft) 04:33:30 INFO - PROCESS | 19082 | RSS: Main: 217833472 04:33:30 INFO - PROCESS | 19082 | 04:33:33 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:49939/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49939/tests/kraken/driver.html?testName=audio-fft) 04:33:34 INFO - PROCESS | 19082 | RSS: Main: 300679168 04:33:34 INFO - PROCESS | 19082 | 04:33:36 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:49939/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49939/tests/kraken/driver.html?testName=audio-oscillator) 04:33:36 INFO - PROCESS | 19082 | RSS: Main: 211345408 04:33:36 INFO - PROCESS | 19082 | 04:33:39 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:49939/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49939/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:39 INFO - PROCESS | 19082 | RSS: Main: 213884928 04:33:39 INFO - PROCESS | 19082 | 04:33:42 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:49939/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49939/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:43 INFO - PROCESS | 19082 | RSS: Main: 253087744 04:33:43 INFO - PROCESS | 19082 | 04:33:46 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:49939/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49939/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:47 INFO - PROCESS | 19082 | RSS: Main: 247590912 04:33:47 INFO - PROCESS | 19082 | 04:33:50 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:49939/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49939/tests/kraken/driver.html?testName=json-parse-financial) 04:33:51 INFO - PROCESS | 19082 | RSS: Main: 249815040 04:33:51 INFO - PROCESS | 19082 | 04:33:52 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:49939/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49939/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:33:53 INFO - PROCESS | 19082 | RSS: Main: 212865024 04:33:53 INFO - PROCESS | 19082 | 04:33:55 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:49939/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49939/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:33:55 INFO - PROCESS | 19082 | RSS: Main: 221057024 04:33:55 INFO - PROCESS | 19082 | 04:33:58 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:49939/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49939/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:33:58 INFO - PROCESS | 19082 | RSS: Main: 229781504 04:33:58 INFO - PROCESS | 19082 | 04:34:01 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:49939/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:34:02 INFO - PROCESS | 19082 | RSS: Main: 237490176 04:34:02 INFO - PROCESS | 19082 | 04:34:05 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:49939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:34:06 INFO - PROCESS | 19082 | RSS: Main: 233689088 04:34:06 INFO - PROCESS | 19082 | 04:34:07 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:49939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49939/tests/kraken/driver.html?testName=ai-astar) 04:34:08 INFO - PROCESS | 19082 | RSS: Main: 285200384 04:34:08 INFO - PROCESS | 19082 | 04:34:08 INFO - PROCESS | 19082 | __start_tp_report 04:34:08 INFO - PROCESS | 19082 | _x_x_mozilla_page_load 04:34:08 INFO - PROCESS | 19082 | _x_x_mozilla_page_load_details 04:34:08 INFO - PROCESS | 19082 | |i|pagename|runs| 04:34:08 INFO - PROCESS | 19082 | |0;ai-astar;109;116;115;117;116;115;115;115;114;116 04:34:08 INFO - PROCESS | 19082 | |1;audio-beat-detection;153;129;133;167;133;133;127;137;155;130 04:34:08 INFO - PROCESS | 19082 | |2;audio-dft;162;162;161;164;164;161;163;162;160;162 04:34:08 INFO - PROCESS | 19082 | |3;audio-fft;76;77;77;103;78;76;77;77;96;75 04:34:08 INFO - PROCESS | 19082 | |4;audio-oscillator;83;83;111;83;84;84;107;84;84;111 04:34:08 INFO - PROCESS | 19082 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;117;117 04:34:08 INFO - PROCESS | 19082 | |6;imaging-darkroom;147;147;147;146;147;146;148;147;147;146 04:34:08 INFO - PROCESS | 19082 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 04:34:08 INFO - PROCESS | 19082 | |8;json-parse-financial;65;65;65;64;64;66;66;64;65;65 04:34:08 INFO - PROCESS | 19082 | |9;json-stringify-tinderbox;66;65;66;67;66;66;67;65;66;66 04:34:08 INFO - PROCESS | 19082 | |10;stanford-crypto-aes;87;84;84;85;95;85;94;85;84;85 04:34:08 INFO - PROCESS | 19082 | |11;stanford-crypto-ccm;162;145;144;143;144;144;144;141;197;141 04:34:08 INFO - PROCESS | 19082 | |12;stanford-crypto-pbkdf2;179;179;180;180;178;178;182;189;184;182 04:34:08 INFO - PROCESS | 19082 | |13;stanford-crypto-sha256-iterative;76;69;69;68;69;70;69;68;70;67 04:34:08 INFO - PROCESS | 19082 | __end_tp_report 04:34:08 INFO - PROCESS | 19082 | __start_cc_report 04:34:08 INFO - PROCESS | 19082 | _x_x_mozilla_cycle_collect,1964 04:34:08 INFO - PROCESS | 19082 | __end_cc_report 04:34:08 INFO - PROCESS | 19082 | __startTimestamp1480077248157__endTimestamp 04:34:08 INFO - PROCESS | 19082 | 04:34:08 INFO - PROCESS | 19082 | ------- Summary: start ------- 04:34:08 INFO - PROCESS | 19082 | Number of tests: 14 04:34:08 INFO - PROCESS | 19082 | 04:34:08 INFO - PROCESS | 19082 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.50 stddev:2.20 (1.9%) stddev-sans-first:0.88 04:34:08 INFO - PROCESS | 19082 | Values: 109.0 116.0 115.0 117.0 116.0 115.0 115.0 115.0 114.0 116.0 04:34:08 INFO - PROCESS | 19082 | 04:34:08 INFO - PROCESS | 19082 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:135.00 stddev:13.61 (10.1%) stddev-sans-first:13.56 04:34:08 INFO - PROCESS | 19082 | Values: 153.0 129.0 133.0 167.0 133.0 133.0 127.0 137.0 155.0 130.0 04:34:08 INFO - PROCESS | 19082 | 04:34:08 INFO - PROCESS | 19082 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.29 (0.8%) stddev-sans-first:1.36 04:34:08 INFO - PROCESS | 19082 | Values: 162.0 162.0 161.0 164.0 164.0 161.0 163.0 162.0 160.0 162.0 04:34:08 INFO - PROCESS | 19082 | 04:34:08 INFO - PROCESS | 19082 | [#3] audio-fft Cycles:10 Average:81.20 Median:77.00 stddev:9.82 (12.8%) stddev-sans-first:10.23 04:34:08 INFO - PROCESS | 19082 | Values: 76.0 77.0 77.0 103.0 78.0 76.0 77.0 77.0 96.0 75.0 04:34:08 INFO - PROCESS | 19082 | 04:34:08 INFO - PROCESS | 19082 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:83.50 stddev:12.66 (15.2%) stddev-sans-first:13.06 04:34:08 INFO - PROCESS | 19082 | Values: 83.0 83.0 111.0 83.0 84.0 84.0 107.0 84.0 84.0 111.0 04:34:08 INFO - PROCESS | 19082 | 04:34:08 INFO - PROCESS | 19082 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:34:08 INFO - PROCESS | 19082 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 04:34:08 INFO - PROCESS | 19082 | 04:34:08 INFO - PROCESS | 19082 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 04:34:08 INFO - PROCESS | 19082 | Values: 147.0 147.0 147.0 146.0 147.0 146.0 148.0 147.0 147.0 146.0 04:34:08 INFO - PROCESS | 19082 | 04:34:08 INFO - PROCESS | 19082 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 04:34:08 INFO - PROCESS | 19082 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 04:34:08 INFO - PROCESS | 19082 | 04:34:08 INFO - PROCESS | 19082 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 04:34:08 INFO - PROCESS | 19082 | Values: 65.0 65.0 65.0 64.0 64.0 66.0 66.0 64.0 65.0 65.0 04:34:08 INFO - PROCESS | 19082 | 04:34:08 INFO - PROCESS | 19082 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 04:34:08 INFO - PROCESS | 19082 | Values: 66.0 65.0 66.0 67.0 66.0 66.0 67.0 65.0 66.0 66.0 04:34:08 INFO - PROCESS | 19082 | 04:34:08 INFO - PROCESS | 19082 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:85.00 stddev:4.16 (4.9%) stddev-sans-first:4.41 04:34:08 INFO - PROCESS | 19082 | Values: 87.0 84.0 84.0 85.0 95.0 85.0 94.0 85.0 84.0 85.0 04:34:08 INFO - PROCESS | 19082 | 04:34:08 INFO - PROCESS | 19082 | [#11] stanford-crypto-ccm Cycles:10 Average:150.50 Median:144.00 stddev:17.42 (12.1%) stddev-sans-first:17.97 04:34:08 INFO - PROCESS | 19082 | Values: 162.0 145.0 144.0 143.0 144.0 144.0 144.0 141.0 197.0 141.0 04:34:08 INFO - PROCESS | 19082 | 04:34:08 INFO - PROCESS | 19082 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.10 Median:181.00 stddev:3.38 (1.9%) stddev-sans-first:3.50 04:34:08 INFO - PROCESS | 19082 | Values: 179.0 179.0 180.0 180.0 178.0 178.0 182.0 189.0 184.0 182.0 04:34:08 INFO - PROCESS | 19082 | 04:34:08 INFO - PROCESS | 19082 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.00 stddev:2.46 (3.6%) stddev-sans-first:0.97 04:34:08 INFO - PROCESS | 19082 | Values: 76.0 69.0 69.0 68.0 69.0 70.0 69.0 68.0 70.0 67.0 04:34:08 INFO - PROCESS | 19082 | -------- Summary: end -------- 04:34:08 INFO - PROCESS | 19082 | 04:34:09 INFO - TEST-INFO | 19082: exit 0 04:34:09 INFO - TEST-OK | kraken | took 64834ms 04:34:09 INFO - SUITE-END | took 1187s 04:34:09 INFO - Completed test suite (00:19:48) 04:34:09 INFO - javascript benchmark 04:34:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2539.4032402385437, 2558.8976440942365, 2589.5727205011176, 2590.7927365810738, 2599.298189488838, 4474.328850672401, 4535.7278563286145, 4590.013147173357, 4598.241290187119, 4599.65502587306, 4535.501094879569, 4547.795349209286, 4548.181327361073, 4551.8634440966825, 4554.703944243622, 4188.246115699165, 4198.223328684188, 4219.2616292148905, 4228.344606585969, 4248.044190057243, 4223.61987421132, 4252.808623611945, 4259.403683484315, 4282.700210985232, 4348.913021739563, 4219.936700949488, 4234.06850492891, 4261.701680882339, 4301.827926882921, 4315.331123675835, 4300.526942036405, 4304.978475107636, 4305.311150215982, 4307.870763877088, 4356.716813407118, 4113.650339721127, 4166.416701661769, 4207.368894665794, 4220.3036498977635, 4271.530131685512, 4575.22221222393, 4582.1981153298375, 4602.79287432063, 4605.723656580616, 4670.602998745111, 4842.806287748486, 4847.248676455155, 4866.902661946777, 4901.068796928572, 4952.108620448318, 4721.409823772028, 4766.880827979294, 4771.308160316769, 4924.064427758714, 4924.507549245047, 4542.954570454319, 4607.838725644653, 4624.375709279271, 4626.329182268552, 4649.0, 5045.066662667418, 5045.470225626256, 5054.747262636927, 5055.165897626924, 5102.158143906214, 4645.953540464552, 4848.442429120696, 4848.611588271381, 4859.65982381237, 4907.509249075064, 4738.384010078667, 4816.8073277069225, 4819.638527110411, 4869.172240719086, 4879.26810978349, 4844.733539655283, 4846.079244943449, 4861.951380486221, 4887.853364399074, 4894.706317620883, 4828.855134345975, 4829.1307564638, 4832.903341933142, 4833.178359678863, 4878.682885612424, 4139.875803725893, 4160.729552579072, 4195.58044195578, 4198.286291330481, 4251.638610718123, 3681.2821499807815, 3701.1672373716237, 3731.3470142724914, 3734.682551983112, 3744.4944932433773, 4203.117345357448, 4221.641160501392, 4227.154569086195, 4230.49234091911, 4265.552117027667, 4744.976275118603, 4874.683145595525, 4883.316335713003, 4895.828645997373, 4941.975290123526, 4158.334666453353, 4184.058586818002, 4204.789760511962, 4223.619874211275, 4231.809568569422, 4476.910461790746, 4477.059817438374, 4480.215962206601, 4514.503404625489, 4525.072360166158, 4543.636509079266, 4578.839740609063, 4585.495595484561, 4587.357769912148, 4630.814767409401, 4728.527147285244, 4824.8793780155775, 4829.299751536078, 4853.102176097434, 4928.901421971612, 4523.570260825217, 4585.380973568525, 4586.036932244266, 4624.190766615761, 4636.8145274188655, 4798.904021919612, 4833.009233107275, 4836.322914791862, 4838.951610483991, 4884.633652476007, 4722.7874745635845, 4828.106800241966, 4900.26496025599, 4903.8528844134735, 4937.5556199942175, 4708.0, 4721.079389519148, 4753.239481682914, 4759.3574867393845, 4810.542998415145, 4755.667103302874, 4761.523847615211, 4764.737939413227, 4768.642351823696, 4810.975945120252, 4687.531246875285, 4688.718676879398, 4688.835890743808, 4697.248440249544, 4728.668993170445, 4680.672352935262, 4742.146413645577, 4745.145873742759, 4787.593054590398, 4838.540338667821, 4757.595604373667, 4764.4282686077895, 4799.856004319876, 4807.302941073594, 4816.783244754065], "value": 4501.024048262265, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.2849723856226, 563.9999999999999, 577.1112486770373, 580.8605934575701, 586.4165155670106, 28358.57462138067, 37832.62167378325, 39690.0, 39726.80136599317, 42650.786746066304, 39332.7067669173, 39656.0, 39704.602953970454, 39769.20461590766, 39828.40257396134, 7434.070741157342, 7568.318851303382, 7579.279968403021, 7580.6967721291085, 7584.393248540131, 7407.55554666719, 7592.240775922419, 9660.710178694615, 9884.159846413027, 9909.405435673847, 9927.056929591678, 9970.800583988315, 9986.950065249664, 9990.50047497626, 9995.800083998316, 9870.851937220912, 9913.058259465339, 9934.602615895428, 9943.303968722192, 9947.403155810674, 9612.471314077722, 9684.806303873884, 9730.172935300508, 9735.26985476085, 9742.220622350194, 35642.28715425677, 35826.28347433063, 35887.0, 35942.0, 35991.640083599355, 2907.912762617125, 2945.7937944343903, 2974.598429212072, 3136.764742644311, 3254.088855120546, 27327.863360683266, 27792.58311125335, 27796.30509237265, 27872.442551149066, 29195.270118247, 3405.8126803025825, 3422.691957723792, 3436.0894362993827, 3535.5934067582302, 3589.587197472298, 242999.0, 243150.0, 243508.99999999822, 244043.0, 244248.0, 43932.78033609811, 44009.0, 44025.0, 44118.33822492601, 44123.558764412584, 50654.49345506498, 51114.48885511172, 51184.0, 51216.74391628018, 51277.0, 13252.403641836141, 13816.654583635289, 13828.861711382959, 13838.723225535434, 13841.723165536632, 9055.18503334703, 9342.57958391874, 9938.354006989523, 10168.694939151837, 10171.54228059739, 14284.714305713827, 14466.20435876037, 14662.706745865024, 14988.47540336083, 15067.547973560811, 5393.191021346829, 5568.610197286151, 5578.832635020955, 5627.634203776742, 5698.116791897262, 756.3684323589864, 790.0234724310686, 886.7384121684119, 953.947532885684, 973.9853902191472, 25574.48851022969, 26734.0, 27307.0, 27397.0, 27649.91701825595, 887.3522328700085, 894.7002754077457, 934.065934065934, 965.1940629574244, 1000.3044838997974, 14130.0, 14281.642958925902, 14488.565343039725, 14730.263486825615, 14742.0, 328602.0, 329697.0, 336798.0, 338289.0, 338889.0, 46619.0, 46635.533644663796, 46727.76636116866, 46800.29799553009, 46836.297455538195, 1010.777628921636, 1052.8368102944055, 1057.5346847387125, 1123.6794525051166, 1128.1651577832345, 26097.608535871597, 29533.0, 30318.84840575783, 30785.8460707695, 31273.687263127078, 43925.780371099216, 44484.0, 44595.777021114685, 44617.33074003828, 44631.0, 312543.0, 319151.0, 319810.0, 320579.0, 320602.0, 33125.503117453736, 34015.0, 34171.4874276891, 34193.829030854686, 34242.0, 39305.41041884317, 39398.0, 39731.40402894017, 40546.0, 40571.928508936384, 33387.0, 33854.322913542084, 34315.313693726486, 34432.483512746825, 34457.31085378329, 33687.663123369435, 34050.0, 34261.82869085639, 34655.480167796995, 35208.47187292244, 32907.83546082254, 33472.330553389285, 33664.66335336615, 33956.1510962218, 34036.14909627279, 29637.85181074081, 30946.226344341572, 31274.0, 31645.367092657558, 31997.680023200403, 24067.0, 24305.878470607535, 24780.752192478565, 25100.372490687147, 25143.622845657697], "value": 17234.125229163736, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.4830579977134, 364.12064863355, 368.50988185713004, 370.53497860185473, 389.4042115563187, 12616.432260548274, 15635.0, 15754.291056902453, 16584.751228731548, 17597.912010439963, 16183.514494565152, 16580.088095154762, 16885.15574221287, 16982.660346793087, 17012.48962531126, 4779.880502987418, 5023.346964894558, 5206.7917283308625, 5486.91769623456, 5525.917111243334, 3426.6059403168706, 3626.0390996385977, 5487.780488780464, 5527.060399732035, 5527.143292789604, 5135.8202462913805, 5374.91937620936, 5397.73011349431, 5452.945470545284, 5456.072467680504, 5270.973645131749, 5435.130379139318, 5436.015854213203, 5441.863953401177, 5442.755076021588, 5356.571474282048, 5356.892862142774, 5357.035733567956, 5362.356517217959, 5365.758540865631, 12153.635390938285, 14066.85933140676, 19543.218271269132, 19638.312659056865, 19738.21047158112, 1721.9311227550884, 1846.4829847642682, 1864.4779461750732, 2169.208238992772, 2395.2814155753204, 8705.782355441164, 8754.0, 8961.059088795713, 9233.815323693489, 9346.205572526344, 1708.7864016997876, 1720.8021077575988, 1726.3181043487878, 1743.0848804377677, 1804.3053424431557, 69206.9618955711, 69706.0, 69903.0, 70187.0, 71361.0, 9336.813263734823, 9407.0, 9895.356801807859, 9970.501474926225, 9980.262764409104, 13709.0, 13727.588172354845, 13748.243846588533, 13748.93125534386, 13767.655808604664, 6821.420179284717, 6831.11195544576, 6890.414314783199, 7029.8242543935785, 7146.642667866586, 6437.871242575122, 6639.966800165968, 6731.158605174353, 6923.273056329013, 6962.7911162665205, 4244.405783190356, 4348.195583817004, 4360.084382279693, 4426.557344265612, 4453.665975051884, 1753.6931037068716, 1826.8355847973746, 1832.1114259584092, 1882.143624650808, 1890.0549725137432, 781.8475397297473, 800.9639566219535, 820.1265652080515, 836.5273620404573, 896.789254525186, 16002.119883406524, 16473.588160296087, 17100.230489627997, 17312.134393280536, 17359.82640173582, 785.09713829097, 792.1484404265437, 842.4439869685978, 853.4964371021003, 916.1479823763964, 9407.670731524364, 9440.716778496657, 9688.46713430768, 9772.560234789451, 9888.159506441889, 269921.0, 272322.0, 273893.0, 348259.0, 348996.0, 78533.60733196298, 79840.0, 80407.59796201099, 80542.5972870132, 81532.59233703793, 897.7441429192779, 916.8624706293975, 948.5067764762285, 953.7329547726648, 955.7610597350663, 15322.923385383001, 15327.15700636431, 16020.439284624983, 16280.0, 16304.918475407547, 35154.25417568596, 36042.63957360393, 36226.63773362338, 36624.0, 36802.447963281105, 51309.743451282506, 52262.0, 52282.73858630683, 53133.734331328094, 53511.46488535065, 7162.247963963709, 7251.311125443285, 7361.2638736125955, 7521.5111017783665, 7673.309402153833, 9822.852657210005, 11390.430478476208, 11482.655520334403, 11484.655460336204, 11952.462139203582, 9665.323427360017, 9892.208623310262, 9953.15398191133, 10011.949940250252, 10464.895351046393, 10090.445025523666, 10121.59513619447, 10134.543945522617, 10140.087392134743, 10293.691189264335, 9810.920798712279, 9973.900260997587, 10069.798604027732, 10164.491775411348, 10341.741456463347, 7019.789406317818, 7061.505694601534, 7134.250903655249, 7356.117265928123, 7408.259174082548, 8405.70580029696, 9787.853182202414, 10032.247581431568, 10061.245406594388, 10076.69769906904], "value": 7992.546498002533, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1137.74400759829, 1333.359987206141, 1363.8022486739424, 1428.621415324939, 1628.9104099274534, 6108.0, 6769.796906092819, 7009.439244860411, 7024.859502809947, 7165.570065796056, 7026.1217347831525, 7084.362407383334, 7084.362407383334, 7089.822754431142, 7160.64196790161, 1785.803561608222, 1863.8881667100018, 2029.939101826944, 2057.187410972665, 2064.194963964055, 1990.0945069993118, 2054.60962417141, 2057.6501994660944, 2060.361288000717, 2061.907214175366, 2000.769911460179, 2004.4587961250454, 2004.9498762530907, 2005.8495612829024, 2007.7590689117253, 1977.3968939473455, 2024.534357097861, 2025.5543780368296, 2025.9088341024615, 2030.3198428526462, 1985.851061170418, 2032.623964566545, 2038.520947577318, 2060.4333808202714, 2060.8557400981936, 6910.965445172742, 7047.400970917478, 7110.822229444254, 7111.679974401164, 7119.50163488556, 4268.338407546835, 4377.277749171383, 4399.670024748125, 4401.317795741633, 4401.339799030139, 2764.156932135698, 2798.1605518344413, 2843.061789609424, 2912.184588315275, 2972.4055188962293, 854.7307598106577, 872.2672954718067, 899.7210864631919, 900.3157600223811, 909.7498187998287, 9232.215261702764, 9429.575669094907, 9462.0, 9492.525373731354, 9539.666111686058, 3775.2260786538695, 3854.5952674969285, 3904.8438062477185, 3922.941155882664, 4005.1589166274825, 8243.629036693363, 8267.586620668942, 8270.25567698898, 8270.338372930151, 8272.214139656722, 4400.71395359307, 4405.163019026375, 4405.537418571068, 4410.757408342572, 4411.404460397869, 3433.484977253432, 3485.6165821759587, 3886.1839013806853, 3953.327934251184, 3953.8220780064967, 3155.605549306337, 3332.7000569948336, 3355.496675498695, 3380.2563436044525, 3402.9489557656657, 1108.1854836695022, 1108.844761733358, 1112.788570171681, 1121.2935850414187, 1129.1982692288568, 794.0550744613892, 800.9719659811879, 809.4212637963884, 816.6488409983646, 822.5517093184229, 4835.927461088087, 4939.53074457926, 4987.900241995139, 5097.617678674114, 5175.171972484384, 388.74342933663644, 392.5309255439722, 400.74352414454773, 404.79557823299047, 413.20251913806044, 3554.147004718849, 3556.6798988090677, 3565.5186549815962, 3582.387925433565, 3664.486971823947, 7821.765347039598, 8218.547979861165, 8229.95885020583, 8234.917650823416, 8244.258016778518, 7971.60141992898, 8163.265306122477, 8184.058833234135, 8190.058143313595, 8199.057108432487, 6286.402791734778, 6289.339619339995, 6358.205224346957, 6374.171357723559, 6380.872382552323, 4778.283257511401, 4909.361782968192, 4918.82784102569, 4933.703977761203, 4938.777755000961, 7405.666744996596, 7436.219196984455, 7489.400847932044, 7494.213107623839, 7529.171791103084, 7537.057867766529, 7547.73582924595, 7582.962085189539, 7612.80967975805, 7626.199249078767, 5426.755795989269, 5696.886062278814, 5900.586958912835, 5959.851003724768, 6072.210612620331, 6060.212172417558, 6504.674766261763, 6793.0, 6797.72809087631, 6921.0, 6043.36544662804, 6131.049687298476, 6150.477209437248, 6368.299487056513, 6442.806715798533, 6127.295361033538, 6128.846778830565, 6202.224721909762, 6203.565750397429, 6217.440430361289, 5837.270341207349, 5932.406759324033, 5942.465178133989, 5944.6730429826775, 5949.8215053548465, 4293.677974152014, 4315.978420107879, 4371.344298355145, 4443.600075993176, 4528.275475923836, 4213.1784302060805, 4296.4414626098405, 4353.172897149531, 4381.934270985874, 4409.889752756078], "value": 3724.382863011169, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.5987337790405, 288.38142185013146, 296.0924765593456, 298.119058183069, 300.03090019237874, 4605.194091034064, 4740.871025123419, 4742.9288560671575, 4766.761661916903, 4795.184818580837, 4616.861494155172, 4657.301404789283, 4707.388039554853, 4727.9290810637785, 4739.90520189596, 3778.6599206071446, 3786.394176931685, 3797.316483033053, 3808.6762625176752, 3811.3330167220624, 3784.6026167252453, 3814.218085292522, 3818.06457417933, 3826.827792749333, 3832.1222600925626, 3615.8734444294455, 3703.1482758965453, 3726.9068273293115, 3733.0, 3750.399936010239, 3707.480952666629, 3739.476473293741, 3739.6260373962523, 3747.2692824899154, 3748.9437658435145, 3211.1008917503136, 3211.6306624737986, 3216.4371235033777, 3220.806751594912, 3242.610886693612, 4539.335254639552, 4548.226801443762, 4617.699849509805, 4637.234856248715, 4665.0, 4140.192662430827, 4149.83400663973, 4168.270552653274, 4176.373543968429, 4183.644390226835, 4940.629452791055, 4949.267756285308, 4951.801927922878, 4954.851354459336, 4956.1822299320565, 3523.119220194951, 3527.9118022049397, 3528.153243221634, 3534.7879127252445, 3536.328097661436, 4890.266460030988, 5122.667026643294, 5169.4830516948, 5178.870528236825, 5203.297554830087, 3539.663731945461, 3548.8757893473603, 3552.8401221945073, 3562.1450851795385, 3567.4113771227976, 3592.5688917329567, 3592.586852511942, 3624.6919011883756, 3650.288193802236, 3652.8904132876055, 3950.3876899080115, 4123.752574845459, 4142.5857414258335, 4145.66834653227, 4152.522459917088, 4963.851084467472, 4996.550310472075, 5004.224345226496, 5005.5745261653165, 5026.4973502649445, 1161.361251311775, 1199.8920097191294, 1206.2822620540765, 1210.4129497193853, 1215.8905698487179, 801.903771547418, 813.4996976859308, 816.9264766171074, 820.5938060660012, 827.4828232354778, 4254.234237837219, 4256.5105012923295, 4258.510271318776, 4266.530681625019, 4273.957260427418, 4950.628702847301, 4955.90088198234, 4985.4266759323145, 4996.7501624918605, 4999.725015124203, 4281.571842815693, 4297.333913243452, 4299.828006879752, 4302.7848607569495, 4311.6335111515245, 2507.749225077514, 2630.4348912397095, 2643.220250026247, 2659.842968308792, 2662.9600555991674, 4658.976705116453, 4664.553988263649, 4670.929936050962, 4682.672212945061, 4684.695494792828, 5102.8214012510125, 5136.126858434075, 5136.563392111712, 5140.997505486469, 5149.2791009258735, 4520.344550040226, 4612.215923293115, 4618.95381046192, 4660.207764680013, 4662.254039353755, 4978.6763860348965, 4987.950120498748, 4988.501149884983, 5001.524855138756, 5023.4725353838785, 4928.841722195353, 4931.852044438672, 4937.481564435682, 4944.5549900507685, 4950.9257361140335, 4423.270160423623, 4599.701019433726, 4637.498688490168, 4652.744099074584, 4654.581087702123, 3438.277961628086, 3449.6032956210356, 3452.8778147102794, 3454.5336379588434, 3463.4631632097066, 4965.45380008206, 4968.701877887338, 4970.3657061755885, 4971.726555039363, 4972.751362431936, 4439.644828413655, 4797.856064318076, 4808.158572249912, 4910.779014944407, 4919.360483137312, 4881.267809828554, 4945.851624451272, 4967.304577359245, 4998.700077995332, 4999.150144475375, 4802.959309494451, 4843.418789745253, 4868.2210846264425, 4869.589553171203, 4878.536539028786, 4825.710457372569, 4966.205407134841, 4978.576820970258, 4986.354503014069, 4993.975030124971, 4881.780319885685, 4882.072406242944, 4887.951120488749, 4901.803927842846, 4904.558589726942], "value": 3693.2921728600936, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.8656095658955, 631.2015300644682, 684.0457561701423, 693.916729992401, 705.4673721340387, 11317.207795454322, 12559.0, 12651.177673451219, 12708.301043442607, 12724.618261452148, 11778.411079446036, 11944.343061131656, 11971.700707482318, 12075.396230188477, 12111.878881211185, 757.0234397627055, 773.8761798112304, 776.343989329016, 776.97669069928, 777.6617171530374, 601.6209787833681, 619.6715740657459, 739.3124394313313, 762.2187258060477, 768.8846672999039, 814.1654803826096, 819.0580832043139, 820.233082068265, 821.2649678537705, 821.2977903892175, 808.7007807111347, 808.894843670325, 808.9838203235931, 809.1059379385753, 809.3525179856092, 477.0506691683525, 484.53242620871026, 576.9509591684712, 586.2173997713058, 596.335086378689, 12269.079819013521, 12271.75456490874, 12276.938615306955, 12277.447514861853, 12305.44625491855, 11562.479688413958, 11569.132315076318, 11981.460834262392, 12283.57007504733, 12346.197497162655, 9615.278854085902, 9633.181179599742, 9851.113399793981, 10247.692569222936, 11066.170037247239, 3173.349463360029, 3192.7765056445824, 3263.857649822543, 3353.5305057292, 4082.5509193988637, 50225.55489501555, 50343.24485132726, 50384.496155038345, 50670.7466462669, 51615.74192129053, 9816.705498835046, 9839.704808855746, 9904.752381190528, 10085.445300508396, 10214.744631384276, 17078.146092695315, 17183.1408429578, 17223.3971810986, 17300.740488892676, 17549.649007019787, 6090.116933044772, 6216.378362163748, 6240.656763878031, 6253.874922501524, 6426.903596446057, 3318.419276626629, 3393.0160253526697, 3436.398630239698, 3470.514128022079, 3505.6669616386403, 2689.9374746974836, 2763.4473105379006, 2773.3205364685377, 2776.5279902416637, 2780.972190278071, 471.2601216090773, 471.3142377840234, 479.8752324395682, 480.8653576998446, 484.94665586785425, 465.6206783337212, 522.8483739715516, 564.8336185776441, 568.499720246189, 582.8309790160806, 7493.812654683677, 7516.887246691304, 7544.0, 7707.574098791742, 7732.57470839098, 490.9877253068702, 567.5062695454898, 573.5125143627882, 581.8748968971692, 588.1119509540624, 3468.930621387558, 3556.6798988091195, 3690.9261814763554, 3691.1141326081547, 3692.0, 63649.0, 68265.3173468269, 69511.30488695149, 70549.64725176444, 70735.29264707287, 59757.701211493666, 60441.69779151076, 61264.0, 62433.375666243664, 62547.374526254156, 52833.94332113336, 54623.0, 55492.445075549535, 56297.15554266689, 57354.7132264336, 6774.627395493295, 6849.452043836581, 6891.276415976451, 7086.893696594659, 7362.079740032496, 37951.81024094862, 38689.381665656285, 39701.801490993515, 39778.0, 40100.0, 46359.768201158775, 46575.0, 50399.74800125976, 51317.7434112827, 54300.0, 10760.139188865029, 10801.0, 11346.886531134583, 11464.94267528657, 11490.655280341603, 11371.0, 11431.428428578703, 11462.94268528652, 11694.2983420995, 11840.644780656594, 8874.423162494417, 11256.268342557707, 11419.543218271509, 11473.770524589629, 11697.122715796178, 11818.227265910182, 11891.167618266638, 11909.22590031645, 12144.939275303566, 12328.876711233132, 10709.357438553712, 10990.560377584807, 11201.66395008151, 11491.655250342503, 11608.24546404481, 9492.240620750184, 9497.382670126419, 9541.856872147062, 9731.464769437465, 9766.316357854881, 9307.674231401868, 9357.85963210566, 9395.201407880133, 9404.38871473352, 9442.95278523603], "value": 6009.7804884074985, "unit": "score"}], "name": "dromaeo_css", "value": 6094.824614854531, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 116.0, 115.0, 117.0, 116.0, 115.0, 115.0, 115.0, 114.0, 116.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 129.0, 133.0, 167.0, 133.0, 133.0, 127.0, 137.0, 155.0, 130.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 164.0, 164.0, 161.0, 163.0, 162.0, 160.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 103.0, 78.0, 76.0, 77.0, 77.0, 96.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 111.0, 83.0, 84.0, 84.0, 107.0, 84.0, 84.0, 111.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 148.0, 147.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 64.0, 66.0, 66.0, 64.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 67.0, 66.0, 66.0, 67.0, 65.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 84.0, 85.0, 95.0, 85.0, 94.0, 85.0, 84.0, 85.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 145.0, 144.0, 143.0, 144.0, 144.0, 144.0, 141.0, 197.0, 141.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 179.0, 180.0, 180.0, 178.0, 178.0, 182.0, 189.0, 184.0, 182.0], "value": 181.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 69.0, 69.0, 68.0, 69.0, 70.0, 69.0, 68.0, 70.0, 67.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1566.8999999999999, "alertThreshold": 2.0}]} 04:34:09 INFO - Return code: 0 04:34:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:34:09 INFO - # TBPL SUCCESS # 04:34:09 INFO - Running post-action listener: _resource_record_post_action 04:34:09 INFO - [mozharness: 2016-11-25 12:34:09.941647Z] Finished run-tests step (success) 04:34:09 INFO - Running post-run listener: _resource_record_post_run 04:34:10 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 8192; Write bytes: 390516736; Read time: 152; Write time: 211972 04:34:10 INFO - TinderboxPrint: CPU usage
13.1% 04:34:10 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 152 04:34:10 INFO - TinderboxPrint: I/O write bytes / time
390,516,736 / 211,972 04:34:10 INFO - TinderboxPrint: CPU idle
8,348.2 (86.9%) 04:34:10 INFO - TinderboxPrint: CPU user
1,209.8 (12.6%) 04:34:10 INFO - TinderboxPrint: Swap in / out
0 / 0 04:34:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 98951168; Read time: 0; Write time: 47564 04:34:10 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291565568; Read time: 136; Write time: 164408 04:34:10 INFO - Running post-run listener: _upload_blobber_files 04:34:10 INFO - Blob upload gear active. 04:34:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:34:10 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 04:34:10 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:34:10 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:34:10 INFO - (blobuploader) - INFO - Open directory for files ... 04:34:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:34:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:34:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:14 INFO - (blobuploader) - INFO - Done attempting. 04:34:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:34:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:34:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:15 INFO - (blobuploader) - INFO - Done attempting. 04:34:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:34:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:34:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:16 INFO - (blobuploader) - INFO - Done attempting. 04:34:16 INFO - (blobuploader) - INFO - Iteration through files over. 04:34:16 INFO - Return code: 0 04:34:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:34:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:34:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4548c81b64d62e9ddc741afacc09ef5b63be40762341c3ffd3a2c44eb9d9877f11ee8f911a6026aaf1896d8df7065e5c4f2f631ef610b82aeffd7cb005311e11", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/dfdb777a80eaf35426cb8d89640743eeafe3e162c6f44997b0210ac12c33074cc2c58882aa7ceae463ead941470cfae26f77d1141ed34ecfe5ede4b367e322ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/662ea90af02bb3b391fb2f0c8dc1a349e8eb8148e9f4f3fb383128d827118279fcc612f654bcd8599772a550ad1c5d720ad5089bd728d854d1f15a9e9dcd6ec0"} 04:34:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:34:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:34:16 INFO - Contents: 04:34:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4548c81b64d62e9ddc741afacc09ef5b63be40762341c3ffd3a2c44eb9d9877f11ee8f911a6026aaf1896d8df7065e5c4f2f631ef610b82aeffd7cb005311e11", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/dfdb777a80eaf35426cb8d89640743eeafe3e162c6f44997b0210ac12c33074cc2c58882aa7ceae463ead941470cfae26f77d1141ed34ecfe5ede4b367e322ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/662ea90af02bb3b391fb2f0c8dc1a349e8eb8148e9f4f3fb383128d827118279fcc612f654bcd8599772a550ad1c5d720ad5089bd728d854d1f15a9e9dcd6ec0"} 04:34:16 INFO - Running post-run listener: copy_logs_to_upload_dir 04:34:16 INFO - Copying logs to upload dir... 04:34:16 INFO - mkdir: /builds/slave/test/build/upload/logs 04:34:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.923549 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-25 04:34:15.778075) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 04:34:15.781656) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4548c81b64d62e9ddc741afacc09ef5b63be40762341c3ffd3a2c44eb9d9877f11ee8f911a6026aaf1896d8df7065e5c4f2f631ef610b82aeffd7cb005311e11", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/dfdb777a80eaf35426cb8d89640743eeafe3e162c6f44997b0210ac12c33074cc2c58882aa7ceae463ead941470cfae26f77d1141ed34ecfe5ede4b367e322ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/662ea90af02bb3b391fb2f0c8dc1a349e8eb8148e9f4f3fb383128d827118279fcc612f654bcd8599772a550ad1c5d720ad5089bd728d854d1f15a9e9dcd6ec0"} build_url:https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011905 build_url: 'https://queue.taskcluster.net/v1/task/d-4kjsOdTrCaoA1r-H2rqQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4548c81b64d62e9ddc741afacc09ef5b63be40762341c3ffd3a2c44eb9d9877f11ee8f911a6026aaf1896d8df7065e5c4f2f631ef610b82aeffd7cb005311e11", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/dfdb777a80eaf35426cb8d89640743eeafe3e162c6f44997b0210ac12c33074cc2c58882aa7ceae463ead941470cfae26f77d1141ed34ecfe5ede4b367e322ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/662ea90af02bb3b391fb2f0c8dc1a349e8eb8148e9f4f3fb383128d827118279fcc612f654bcd8599772a550ad1c5d720ad5089bd728d854d1f15a9e9dcd6ec0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 04:34:15.811798) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 04:34:15.812199) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1480076006.487747-1787398270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 04:34:15.896285) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 04:34:15.896626) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 04:34:15.897010) ========= ========= Total master_lag: 0.17 =========