builder: cedar_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1479298023.66 results: success (0) buildid: 20161116024633 builduid: 299d974614a6409eb846a3c95a65d9fc revision: 5b53bda4e10d2cf2a4983cfe1114eda05540584e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 04:07:03.661816) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 04:07:03.662249) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 04:07:03.662538) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 04:07:03.737930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 04:07:03.738188) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1479297784.427762-2080687394 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-16 04:07:04-- 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% 23.0M=0.001s 2016-11-16 04:07:04 (23.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125985 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 04:07:03.880084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 04:07:03.880430) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1479297784.427762-2080687394 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016024 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 04:07:03.929929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 04:07:03.930293) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 5b53bda4e10d2cf2a4983cfe1114eda05540584e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 5b53bda4e10d2cf2a4983cfe1114eda05540584e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1479297784.427762-2080687394 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-16 04:07:04,242 truncating revision to first 12 chars 2016-11-16 04:07:04,242 Setting DEBUG logging. 2016-11-16 04:07:04,242 attempt 1/10 2016-11-16 04:07:04,242 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/5b53bda4e10d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-16 04:07:04,542 unpacking tar archive at: cedar-5b53bda4e10d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615038 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 04:07:04.559188) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 04:07:04.559504) ========= script_repo_revision: 5b53bda4e10d2cf2a4983cfe1114eda05540584e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 04:07:04.559849) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 04:07:04.560107) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 04:07:04.570206) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-11-16 04:07:04.570490) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1479297784.427762-2080687394 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:07:04 INFO - MultiFileLogger online at 20161116 04:07:04 in /builds/slave/test 04:07:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 04:07:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:07:04 INFO - {'append_to_log': False, 04:07:04 INFO - 'base_work_dir': '/builds/slave/test', 04:07:04 INFO - 'blob_upload_branch': 'Cedar', 04:07:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:07:04 INFO - 'branch': 'Cedar', 04:07:04 INFO - 'buildbot_json_path': 'buildprops.json', 04:07:04 INFO - 'config_files': ('talos/linux_config.py',), 04:07:04 INFO - 'default_actions': ('clobber', 04:07:04 INFO - 'read-buildbot-config', 04:07:04 INFO - 'download-and-extract', 04:07:04 INFO - 'populate-webroot', 04:07:04 INFO - 'create-virtualenv', 04:07:04 INFO - 'install', 04:07:04 INFO - 'run-tests'), 04:07:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:07:04 INFO - 'download_minidump_stackwalk': True, 04:07:04 INFO - 'download_symbols': 'ondemand', 04:07:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:07:04 INFO - 'tooltool.py': '/tools/tooltool.py', 04:07:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:07:04 INFO - '/tools/misc-python/virtualenv.py')}, 04:07:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:07:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:07:04 INFO - 'installer_path': 'installer.exe', 04:07:04 INFO - 'log_level': 'info', 04:07:04 INFO - 'log_name': 'talos', 04:07:04 INFO - 'log_to_console': True, 04:07:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:07:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:07:04 INFO - 'opt_config_files': (), 04:07:04 INFO - 'pip_index': False, 04:07:04 INFO - 'sps_profile': False, 04:07:04 INFO - 'sps_profile_interval': 0, 04:07:04 INFO - 'suite': 'dromaeojs', 04:07:04 INFO - 'system_bits': '32', 04:07:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:07:04 INFO - 'title': 'talos-linux64-ix-032', 04:07:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:07:04 INFO - 'use_talos_json': True, 04:07:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:07:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:07:04 INFO - 'work_dir': 'build'} 04:07:04 INFO - [mozharness: 2016-11-16 12:07:04.980398Z] Running clobber step. 04:07:04 INFO - Running pre-action listener: _resource_record_pre_action 04:07:04 INFO - Running main action method: clobber 04:07:04 INFO - rmtree: /builds/slave/test/build 04:07:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:07:05 INFO - Running post-action listener: _resource_record_post_action 04:07:05 INFO - [mozharness: 2016-11-16 12:07:05.955934Z] Finished clobber step (success) 04:07:05 INFO - [mozharness: 2016-11-16 12:07:05.956031Z] Running read-buildbot-config step. 04:07:05 INFO - Running pre-action listener: _resource_record_pre_action 04:07:05 INFO - Running main action method: read_buildbot_config 04:07:05 INFO - Using buildbot properties: 04:07:05 INFO - { 04:07:05 INFO - "project": "", 04:07:05 INFO - "product": "firefox", 04:07:05 INFO - "script_repo_revision": "default", 04:07:05 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs", 04:07:05 INFO - "repository": "", 04:07:05 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs", 04:07:05 INFO - "buildid": "20161116024633", 04:07:05 INFO - "pgo_build": "False", 04:07:05 INFO - "basedir": "/builds/slave/test", 04:07:05 INFO - "buildnumber": 4, 04:07:05 INFO - "slavename": "talos-linux64-ix-032", 04:07:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:07:05 INFO - "platform": "ubuntu64_hw", 04:07:05 INFO - "scheduler": "tests-cedar-linux64-talos", 04:07:05 INFO - "branch": "cedar", 04:07:05 INFO - "repo_path": "projects/cedar", 04:07:05 INFO - "revision": "5b53bda4e10d2cf2a4983cfe1114eda05540584e", 04:07:05 INFO - "stage_platform": "linux64", 04:07:05 INFO - "builduid": "299d974614a6409eb846a3c95a65d9fc", 04:07:05 INFO - "slavebuilddir": "test" 04:07:05 INFO - } 04:07:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 04:07:05 INFO - Running post-action listener: _resource_record_post_action 04:07:05 INFO - [mozharness: 2016-11-16 12:07:05.958445Z] Finished read-buildbot-config step (success) 04:07:05 INFO - [mozharness: 2016-11-16 12:07:05.958533Z] Running download-and-extract step. 04:07:05 INFO - Running pre-action listener: _resource_record_pre_action 04:07:05 INFO - Running main action method: download_and_extract 04:07:05 INFO - mkdir: /builds/slave/test/build/tests 04:07:05 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:07:05 INFO - trying https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:07:05 INFO - Downloading https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/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:07:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/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:07:06 INFO - Downloaded 1361 bytes. 04:07:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:07:06 INFO - Using the following test package requirements: 04:07:06 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 04:07:06 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:07:06 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:07:06 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:06 INFO - u'jsshell-linux-x86_64.zip'], 04:07:06 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:07:06 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 04:07:06 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:07:06 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:07:06 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:07:06 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:07:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:07:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 04:07:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:07:06 INFO - Fetch https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:07:07 INFO - Http code: 200 04:07:07 INFO - via: 1.1 68e4011ca1c00bec92bb202e1ddce131.cloudfront.net (CloudFront) 04:07:07 INFO - x-amz-cf-id: uUB5VO6pyCyPzVos8ytTJ49GIssBS0SBO-RQ7t-RNzNJ-xwjs9QJqw== 04:07:07 INFO - x-amz-version-id: RzBdCdiNp4fiEkAt4O1acuytjY6ysm0T 04:07:07 INFO - Expected file size: 20416510 04:07:07 INFO - Obtained file size: 20416510 04:07:11 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:07:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 04:07:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:07:11 INFO - Fetch https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:07:12 INFO - Http code: 200 04:07:12 INFO - via: 1.1 fc7da6323a08a2c16d48dd4939ce0898.cloudfront.net (CloudFront) 04:07:12 INFO - x-amz-cf-id: hmk1LsfrzO6HHTZobrVKxeCqfTcwmlpxZAH-rorT3M2PDUqgOPbxtA== 04:07:12 INFO - x-amz-version-id: RzBdCdiNp4fiEkAt4O1acuytjY6ysm0T 04:07:12 INFO - Expected file size: 20416510 04:07:12 INFO - Obtained file size: 20416510 04:07:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 04:07:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:07:16 INFO - Fetch https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:07:17 INFO - Http code: 200 04:07:17 INFO - via: 1.1 4a55d86b7263f73c6817c7c25d4b3643.cloudfront.net (CloudFront) 04:07:17 INFO - x-amz-cf-id: GSKsUeTffX3Aueo_rU-1qqPMIaew_IvM27WRjQufNXt8SBaJ5AV3kg== 04:07:17 INFO - x-amz-version-id: hFhXhsxD9mX1M.ldCu3A22W.Vw.4Ojdp 04:07:18 INFO - Expected file size: 14409038 04:07:18 INFO - Obtained file size: 14409038 04:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:18 INFO - trying https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:07:18 INFO - Downloading https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/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:07:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/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:07:20 INFO - Downloaded 55724265 bytes. 04:07:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:07:20 INFO - mkdir: /builds/slave/test/properties 04:07:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:07:20 INFO - Writing to file /builds/slave/test/properties/build_url 04:07:20 INFO - Contents: 04:07:20 INFO - build_url:https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:07:21 INFO - Running post-action listener: _resource_record_post_action 04:07:21 INFO - Running post-action listener: set_extra_try_arguments 04:07:21 INFO - [mozharness: 2016-11-16 12:07:21.173741Z] Finished download-and-extract step (success) 04:07:21 INFO - [mozharness: 2016-11-16 12:07:21.173969Z] Running populate-webroot step. 04:07:21 INFO - Running pre-action listener: _resource_record_pre_action 04:07:21 INFO - Running main action method: populate_webroot 04:07:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:07:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:07:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:07:21 INFO - '--tppagecycles', 04:07:21 INFO - '7'], 04:07:21 INFO - 'tests': ['tsvgm']}}, 04:07:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:07:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:07:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:07:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:07:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:07:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:07:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:21 INFO - 'talos_options': ['--disable-e10s'], 04:07:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:07:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:07:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:21 INFO - 'talos_options': ['--disable-e10s'], 04:07:21 INFO - 'tests': ['damp', 'tps']}, 04:07:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:21 INFO - 'tests': ['damp', 'tps']}, 04:07:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:07:21 INFO - 'tests': ['dromaeo_dom']}, 04:07:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:07:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:07:21 INFO - 'tests': ['basic_compositor_video']}, 04:07:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:07:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:07:21 INFO - 'tests': ['a11yr', 04:07:21 INFO - 'ts_paint', 04:07:21 INFO - 'tpaint', 04:07:21 INFO - 'sessionrestore', 04:07:21 INFO - 'sessionrestore_no_auto_restore', 04:07:21 INFO - 'tabpaint']}, 04:07:21 INFO - 'other-e10s': {'tests': ['a11yr', 04:07:21 INFO - 'ts_paint', 04:07:21 INFO - 'tpaint', 04:07:21 INFO - 'sessionrestore', 04:07:21 INFO - 'sessionrestore_no_auto_restore', 04:07:21 INFO - 'tabpaint']}, 04:07:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:07:21 INFO - 'ts_paint', 04:07:21 INFO - 'tpaint', 04:07:21 INFO - 'sessionrestore', 04:07:21 INFO - 'sessionrestore_no_auto_restore', 04:07:21 INFO - 'tabpaint']}, 04:07:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:07:21 INFO - 'ts_paint', 04:07:21 INFO - 'tpaint', 04:07:21 INFO - 'sessionrestore', 04:07:21 INFO - 'sessionrestore_no_auto_restore', 04:07:21 INFO - 'tabpaint']}, 04:07:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:07:21 INFO - 'tests': ['a11yr', 04:07:21 INFO - 'ts_paint', 04:07:21 INFO - 'tpaint', 04:07:21 INFO - 'sessionrestore', 04:07:21 INFO - 'sessionrestore_no_auto_restore', 04:07:21 INFO - 'tabpaint']}, 04:07:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:07:21 INFO - 'tests': ['a11yr', 04:07:21 INFO - 'ts_paint', 04:07:21 INFO - 'tpaint', 04:07:21 INFO - 'sessionrestore', 04:07:21 INFO - 'sessionrestore_no_auto_restore', 04:07:21 INFO - 'tabpaint']}, 04:07:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:07:21 INFO - 'tests': ['tsvgx', 04:07:21 INFO - 'tsvgr_opacity', 04:07:21 INFO - 'tart', 04:07:21 INFO - 'tscrollx', 04:07:21 INFO - 'cart']}, 04:07:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:07:21 INFO - 'tsvgr_opacity', 04:07:21 INFO - 'tart', 04:07:21 INFO - 'tscrollx', 04:07:21 INFO - 'cart']}, 04:07:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:21 INFO - 'talos_options': ['--disable-e10s'], 04:07:21 INFO - 'tests': ['tp5o']}, 04:07:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:21 INFO - 'tests': ['tp5o']}, 04:07:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:21 INFO - 'talos_options': ['--disable-e10s', 04:07:21 INFO - '--xperf_path', 04:07:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:07:21 INFO - 'tests': ['tp5n']}, 04:07:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:21 INFO - 'talos_options': ['--xperf_path', 04:07:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:07:21 INFO - 'tests': ['tp5n']}}, 04:07:21 INFO - 'talos.zip': {'path': '', 04:07:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:07:21 INFO - Running post-action listener: _resource_record_post_action 04:07:21 INFO - [mozharness: 2016-11-16 12:07:21.189430Z] Finished populate-webroot step (success) 04:07:21 INFO - [mozharness: 2016-11-16 12:07:21.189523Z] Running create-virtualenv step. 04:07:21 INFO - Running pre-action listener: _resource_record_pre_action 04:07:21 INFO - Running main action method: create_virtualenv 04:07:21 INFO - Creating virtualenv /builds/slave/test/build/venv 04:07:21 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:07:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:07:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:07:21 INFO - Using real prefix '/usr' 04:07:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:07:21 INFO - Installing distribute.............................................................................................................................................................................................done. 04:07:23 INFO - Installing pip.................done. 04:07:23 INFO - Return code: 0 04:07:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:07:23 INFO - Reading from file tmpfile_stdout 04:07:23 INFO - Output received: 04:07:23 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:07:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:23 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 0x7fb7675cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b397b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8790>, '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 0x2bc9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', '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:07:23 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:07:23 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:07:23 INFO - Using env: {'DISPLAY': ':0', 04:07:23 INFO - 'HOME': '/home/cltbld', 04:07:23 INFO - 'LANG': 'en_US.UTF-8', 04:07:23 INFO - 'LANGUAGE': 'en_US:en', 04:07:23 INFO - 'LOGNAME': 'cltbld', 04:07:23 INFO - 'MAIL': '/var/mail/cltbld', 04:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:23 INFO - 'MOZ_NO_REMOTE': '1', 04:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:23 INFO - 'NO_EM_RESTART': '1', 04:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:23 INFO - 'PWD': '/builds/slave/test', 04:07:23 INFO - 'SHELL': '/bin/bash', 04:07:23 INFO - 'SHLVL': '1', 04:07:23 INFO - 'TERM': 'linux', 04:07:23 INFO - 'TMOUT': '86400', 04:07:23 INFO - 'USER': 'cltbld', 04:07:23 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', 04:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:23 INFO - '_': '/tools/buildbot/bin/python'} 04:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:24 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:07:24 INFO - Cleaning up... 04:07:24 INFO - Return code: 0 04:07:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:24 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 0x7fb7675cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b397b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8790>, '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 0x2bc9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', '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:07:24 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:07:24 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:07:24 INFO - Using env: {'DISPLAY': ':0', 04:07:24 INFO - 'HOME': '/home/cltbld', 04:07:24 INFO - 'LANG': 'en_US.UTF-8', 04:07:24 INFO - 'LANGUAGE': 'en_US:en', 04:07:24 INFO - 'LOGNAME': 'cltbld', 04:07:24 INFO - 'MAIL': '/var/mail/cltbld', 04:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:24 INFO - 'MOZ_NO_REMOTE': '1', 04:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:24 INFO - 'NO_EM_RESTART': '1', 04:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:24 INFO - 'PWD': '/builds/slave/test', 04:07:24 INFO - 'SHELL': '/bin/bash', 04:07:24 INFO - 'SHLVL': '1', 04:07:24 INFO - 'TERM': 'linux', 04:07:24 INFO - 'TMOUT': '86400', 04:07:24 INFO - 'USER': 'cltbld', 04:07:24 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', 04:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:24 INFO - '_': '/tools/buildbot/bin/python'} 04:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:24 INFO - Downloading/unpacking psutil>=3.1.1 04:07:24 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:07:24 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:07:24 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:07:24 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:07:24 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:07:24 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:07:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:07:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:26 INFO - Installing collected packages: psutil 04:07:26 INFO - Running setup.py install for psutil 04:07:26 INFO - building 'psutil._psutil_linux' extension 04:07:26 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:07:26 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:07:26 INFO - building 'psutil._psutil_posix' extension 04:07:26 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:07:27 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:07:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:27 INFO - Successfully installed psutil 04:07:27 INFO - Cleaning up... 04:07:27 INFO - Return code: 0 04:07:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7675cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b397b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8790>, '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 0x2bc9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', '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:07:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:07:27 INFO - Using env: {'DISPLAY': ':0', 04:07:27 INFO - 'HOME': '/home/cltbld', 04:07:27 INFO - 'LANG': 'en_US.UTF-8', 04:07:27 INFO - 'LANGUAGE': 'en_US:en', 04:07:27 INFO - 'LOGNAME': 'cltbld', 04:07:27 INFO - 'MAIL': '/var/mail/cltbld', 04:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:27 INFO - 'MOZ_NO_REMOTE': '1', 04:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:27 INFO - 'NO_EM_RESTART': '1', 04:07:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:27 INFO - 'PWD': '/builds/slave/test', 04:07:27 INFO - 'SHELL': '/bin/bash', 04:07:27 INFO - 'SHLVL': '1', 04:07:27 INFO - 'TERM': 'linux', 04:07:27 INFO - 'TMOUT': '86400', 04:07:27 INFO - 'USER': 'cltbld', 04:07:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', 04:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:27 INFO - '_': '/tools/buildbot/bin/python'} 04:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:07:27 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:07:27 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:07:27 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:07:27 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:07:27 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:07:27 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:07:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:07:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:07:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:07:29 INFO - Installing collected packages: mozsystemmonitor 04:07:29 INFO - Running setup.py install for mozsystemmonitor 04:07:29 INFO - Successfully installed mozsystemmonitor 04:07:29 INFO - Cleaning up... 04:07:29 INFO - Return code: 0 04:07:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:07: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:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07: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:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:29 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 0x7fb7675cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b397b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8790>, '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 0x2bc9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', '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:07:29 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:07:29 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:07:29 INFO - Using env: {'DISPLAY': ':0', 04:07:29 INFO - 'HOME': '/home/cltbld', 04:07:29 INFO - 'LANG': 'en_US.UTF-8', 04:07:29 INFO - 'LANGUAGE': 'en_US:en', 04:07:29 INFO - 'LOGNAME': 'cltbld', 04:07:29 INFO - 'MAIL': '/var/mail/cltbld', 04:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:29 INFO - 'MOZ_NO_REMOTE': '1', 04:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:29 INFO - 'NO_EM_RESTART': '1', 04:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:29 INFO - 'PWD': '/builds/slave/test', 04:07:29 INFO - 'SHELL': '/bin/bash', 04:07:29 INFO - 'SHLVL': '1', 04:07:29 INFO - 'TERM': 'linux', 04:07:29 INFO - 'TMOUT': '86400', 04:07:29 INFO - 'USER': 'cltbld', 04:07:29 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', 04:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:29 INFO - '_': '/tools/buildbot/bin/python'} 04:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:29 INFO - Downloading/unpacking jsonschema==2.5.1 04:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:07:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:31 INFO - Downloading functools32-3.2.3-2.tar.gz 04:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:07:31 INFO - warning: no files found matching '*.txt' 04:07:31 INFO - no previously-included directories found matching 'build' 04:07:31 INFO - no previously-included directories found matching 'dist' 04:07:31 INFO - no previously-included directories found matching '.git*' 04:07:31 INFO - Installing collected packages: jsonschema, functools32 04:07:32 INFO - Running setup.py install for functools32 04:07:32 INFO - warning: no files found matching '*.txt' 04:07:32 INFO - no previously-included directories found matching 'build' 04:07:32 INFO - no previously-included directories found matching 'dist' 04:07:32 INFO - no previously-included directories found matching '.git*' 04:07:32 INFO - Successfully installed jsonschema functools32 04:07:32 INFO - Cleaning up... 04:07:32 INFO - Return code: 0 04:07:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb7675cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b397b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8790>, '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 0x2bc9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', '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:07:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:07:32 INFO - Using env: {'DISPLAY': ':0', 04:07:32 INFO - 'HOME': '/home/cltbld', 04:07:32 INFO - 'LANG': 'en_US.UTF-8', 04:07:32 INFO - 'LANGUAGE': 'en_US:en', 04:07:32 INFO - 'LOGNAME': 'cltbld', 04:07:32 INFO - 'MAIL': '/var/mail/cltbld', 04:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:32 INFO - 'MOZ_NO_REMOTE': '1', 04:07:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:32 INFO - 'NO_EM_RESTART': '1', 04:07:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:32 INFO - 'PWD': '/builds/slave/test', 04:07:32 INFO - 'SHELL': '/bin/bash', 04:07:32 INFO - 'SHLVL': '1', 04:07:32 INFO - 'TERM': 'linux', 04:07:32 INFO - 'TMOUT': '86400', 04:07:32 INFO - 'USER': 'cltbld', 04:07:32 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', 04:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:32 INFO - '_': '/tools/buildbot/bin/python'} 04:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:07:32 INFO - Cleaning up... 04:07:32 INFO - Return code: 0 04:07:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb7675cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b397b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8790>, '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 0x2bc9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', '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:07:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:07:32 INFO - Using env: {'DISPLAY': ':0', 04:07:32 INFO - 'HOME': '/home/cltbld', 04:07:32 INFO - 'LANG': 'en_US.UTF-8', 04:07:32 INFO - 'LANGUAGE': 'en_US:en', 04:07:32 INFO - 'LOGNAME': 'cltbld', 04:07:32 INFO - 'MAIL': '/var/mail/cltbld', 04:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:32 INFO - 'MOZ_NO_REMOTE': '1', 04:07:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:32 INFO - 'NO_EM_RESTART': '1', 04:07:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:32 INFO - 'PWD': '/builds/slave/test', 04:07:32 INFO - 'SHELL': '/bin/bash', 04:07:32 INFO - 'SHLVL': '1', 04:07:32 INFO - 'TERM': 'linux', 04:07:32 INFO - 'TMOUT': '86400', 04:07:32 INFO - 'USER': 'cltbld', 04:07:32 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', 04:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:32 INFO - '_': '/tools/buildbot/bin/python'} 04:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:32 INFO - Downloading/unpacking blobuploader==1.2.4 04:07:32 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:07:32 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:07:32 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:07:32 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:07:32 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:07:32 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:07:34 INFO - Downloading blobuploader-1.2.4.tar.gz 04:07:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:07:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:07:34 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:07:34 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:07:34 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:07:34 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:07:34 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:07:34 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:07:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:07:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:35 INFO - Downloading docopt-0.6.1.tar.gz 04:07:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:07:35 INFO - Installing collected packages: blobuploader, requests, docopt 04:07:35 INFO - Running setup.py install for blobuploader 04:07:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:07:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:07:35 INFO - Running setup.py install for requests 04:07:35 INFO - Running setup.py install for docopt 04:07:35 INFO - Successfully installed blobuploader requests docopt 04:07:35 INFO - Cleaning up... 04:07:35 INFO - Return code: 0 04:07:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:35 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:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:35 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:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:35 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 0x7fb7675cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b397b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8790>, '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 0x2bc9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', '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:07:35 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:07:35 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:07:35 INFO - Using env: {'DISPLAY': ':0', 04:07:35 INFO - 'HOME': '/home/cltbld', 04:07:35 INFO - 'LANG': 'en_US.UTF-8', 04:07:35 INFO - 'LANGUAGE': 'en_US:en', 04:07:35 INFO - 'LOGNAME': 'cltbld', 04:07:35 INFO - 'MAIL': '/var/mail/cltbld', 04:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:35 INFO - 'MOZ_NO_REMOTE': '1', 04:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:35 INFO - 'NO_EM_RESTART': '1', 04:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:35 INFO - 'PWD': '/builds/slave/test', 04:07:35 INFO - 'SHELL': '/bin/bash', 04:07:35 INFO - 'SHLVL': '1', 04:07:35 INFO - 'TERM': 'linux', 04:07:35 INFO - 'TMOUT': '86400', 04:07:35 INFO - 'USER': 'cltbld', 04:07:35 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', 04:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:35 INFO - '_': '/tools/buildbot/bin/python'} 04:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:36 INFO - Running setup.py (path:/tmp/pip-OSjSmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:36 INFO - Running setup.py (path:/tmp/pip-fG_Z0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:36 INFO - Running setup.py (path:/tmp/pip-nvczDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:36 INFO - Running setup.py (path:/tmp/pip-42vVut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:36 INFO - Running setup.py (path:/tmp/pip-sOrxvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:36 INFO - Running setup.py (path:/tmp/pip-V259IO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:36 INFO - Running setup.py (path:/tmp/pip-MWma4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:36 INFO - Running setup.py (path:/tmp/pip-ZMn0Ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:36 INFO - Running setup.py (path:/tmp/pip-mJqeOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:36 INFO - Running setup.py (path:/tmp/pip-U617mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:36 INFO - Running setup.py (path:/tmp/pip-xg7pkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:36 INFO - Running setup.py (path:/tmp/pip-nWOMHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:37 INFO - Running setup.py (path:/tmp/pip-7PPMXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:37 INFO - Running setup.py (path:/tmp/pip-bVk2DE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:37 INFO - Running setup.py (path:/tmp/pip-fytKiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:37 INFO - Running setup.py (path:/tmp/pip-_lKP_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:37 INFO - Running setup.py (path:/tmp/pip-7oXjLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:07:37 INFO - Running setup.py install for manifestparser 04:07:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:07:37 INFO - Running setup.py install for mozcrash 04:07:37 INFO - Running setup.py install for mozdebug 04:07:37 INFO - Running setup.py install for mozdevice 04:07:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:07:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:07:37 INFO - Running setup.py install for mozfile 04:07:37 INFO - Running setup.py install for mozhttpd 04:07:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:07:38 INFO - Running setup.py install for mozinfo 04:07:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:07:38 INFO - Running setup.py install for mozInstall 04:07:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:07:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:07:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:07:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:07:38 INFO - Running setup.py install for mozleak 04:07:38 INFO - Running setup.py install for mozlog 04:07:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:07:38 INFO - Running setup.py install for moznetwork 04:07:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:07:38 INFO - Running setup.py install for mozprocess 04:07:38 INFO - Running setup.py install for mozprofile 04:07:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:07:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:07:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:07:38 INFO - Running setup.py install for mozrunner 04:07:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:07:38 INFO - Running setup.py install for mozscreenshot 04:07:39 INFO - Running setup.py install for moztest 04:07:39 INFO - Running setup.py install for mozversion 04:07:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:07:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:07:39 INFO - Cleaning up... 04:07:39 INFO - Return code: 0 04:07:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:39 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 0x7fb7675cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b397b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8790>, '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 0x2bc9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', '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:07:39 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:07:39 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:07:39 INFO - Using env: {'DISPLAY': ':0', 04:07:39 INFO - 'HOME': '/home/cltbld', 04:07:39 INFO - 'LANG': 'en_US.UTF-8', 04:07:39 INFO - 'LANGUAGE': 'en_US:en', 04:07:39 INFO - 'LOGNAME': 'cltbld', 04:07:39 INFO - 'MAIL': '/var/mail/cltbld', 04:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:39 INFO - 'MOZ_NO_REMOTE': '1', 04:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:39 INFO - 'NO_EM_RESTART': '1', 04:07:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:39 INFO - 'PWD': '/builds/slave/test', 04:07:39 INFO - 'SHELL': '/bin/bash', 04:07:39 INFO - 'SHLVL': '1', 04:07:39 INFO - 'TERM': 'linux', 04:07:39 INFO - 'TMOUT': '86400', 04:07:39 INFO - 'USER': 'cltbld', 04:07:39 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', 04:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:39 INFO - '_': '/tools/buildbot/bin/python'} 04:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:39 INFO - Running setup.py (path:/tmp/pip-8lb1pV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:39 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:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:39 INFO - Running setup.py (path:/tmp/pip-tI0DSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:39 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:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:39 INFO - Running setup.py (path:/tmp/pip-uPdtGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:39 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:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:39 INFO - Running setup.py (path:/tmp/pip-F_wZI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:39 INFO - Running setup.py (path:/tmp/pip-YvziMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:39 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:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:39 INFO - Running setup.py (path:/tmp/pip-KK6PxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:39 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:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:39 INFO - Running setup.py (path:/tmp/pip-bcDHMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:39 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:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:39 INFO - Running setup.py (path:/tmp/pip-s_w8dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:40 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:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:40 INFO - Running setup.py (path:/tmp/pip-2K0ydw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:40 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:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:40 INFO - Running setup.py (path:/tmp/pip-XYEJRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:40 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:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:40 INFO - Running setup.py (path:/tmp/pip-VQJsV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:40 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:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:40 INFO - Running setup.py (path:/tmp/pip-cuwNA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:40 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:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:40 INFO - Running setup.py (path:/tmp/pip-SP43a9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:40 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:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:40 INFO - Running setup.py (path:/tmp/pip-B6sYBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:40 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:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:40 INFO - Running setup.py (path:/tmp/pip-hsEX2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:40 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:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:40 INFO - Running setup.py (path:/tmp/pip-2Tliho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:40 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:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:40 INFO - Running setup.py (path:/tmp/pip-_H6zxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:40 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:07:40 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:07:40 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:07:40 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:07:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:07:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:07:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:07:40 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:07:40 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:07:40 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:07:40 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:07:40 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:07:40 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:07:42 INFO - Downloading blessings-1.6.tar.gz 04:07:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:07:42 INFO - Installing collected packages: blessings 04:07:42 INFO - Running setup.py install for blessings 04:07:42 INFO - Successfully installed blessings 04:07:42 INFO - Cleaning up... 04:07:42 INFO - Return code: 0 04:07:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:07:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:43 INFO - Reading from file tmpfile_stdout 04:07:43 INFO - Current package versions: 04:07:43 INFO - argparse == 1.2.1 04:07:43 INFO - blessings == 1.6 04:07:43 INFO - blobuploader == 1.2.4 04:07:43 INFO - docopt == 0.6.1 04:07:43 INFO - functools32 == 3.2.3-2 04:07:43 INFO - jsonschema == 2.5.1 04:07:43 INFO - manifestparser == 1.1 04:07:43 INFO - mozInstall == 1.12 04:07:43 INFO - mozcrash == 1.0 04:07:43 INFO - mozdebug == 0.1 04:07:43 INFO - mozdevice == 0.48 04:07:43 INFO - mozfile == 1.2 04:07:43 INFO - mozhttpd == 0.7 04:07:43 INFO - mozinfo == 0.9 04:07:43 INFO - mozleak == 0.1 04:07:43 INFO - mozlog == 3.4 04:07:43 INFO - moznetwork == 0.27 04:07:43 INFO - mozprocess == 0.23 04:07:43 INFO - mozprofile == 0.28 04:07:43 INFO - mozrunner == 6.13 04:07:43 INFO - mozscreenshot == 0.1 04:07:43 INFO - mozsystemmonitor == 0.3 04:07:43 INFO - moztest == 0.7 04:07:43 INFO - mozversion == 1.4 04:07:43 INFO - psutil == 3.1.1 04:07:43 INFO - requests == 1.2.3 04:07:43 INFO - wsgiref == 0.1.2 04:07:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:43 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 0x7fb7675cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b397b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8790>, '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 0x2bc9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', '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:07:43 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:07:43 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:07:43 INFO - Using env: {'DISPLAY': ':0', 04:07:43 INFO - 'HOME': '/home/cltbld', 04:07:43 INFO - 'LANG': 'en_US.UTF-8', 04:07:43 INFO - 'LANGUAGE': 'en_US:en', 04:07:43 INFO - 'LOGNAME': 'cltbld', 04:07:43 INFO - 'MAIL': '/var/mail/cltbld', 04:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:43 INFO - 'MOZ_NO_REMOTE': '1', 04:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:43 INFO - 'NO_EM_RESTART': '1', 04:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:43 INFO - 'PWD': '/builds/slave/test', 04:07:43 INFO - 'SHELL': '/bin/bash', 04:07:43 INFO - 'SHLVL': '1', 04:07:43 INFO - 'TERM': 'linux', 04:07:43 INFO - 'TMOUT': '86400', 04:07:43 INFO - 'USER': 'cltbld', 04:07:43 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', 04:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:43 INFO - '_': '/tools/buildbot/bin/python'} 04:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:43 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:07:43 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:07:43 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:07:43 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:07:43 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:07:43 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:07:43 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:07:43 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:07:43 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:07:43 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:07:43 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:07:43 INFO - Cleaning up... 04:07:43 INFO - Return code: 0 04:07:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:43 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 0x7fb7675cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b397b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8790>, '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 0x2bc9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', '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:07:43 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:07:43 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:07:43 INFO - Using env: {'DISPLAY': ':0', 04:07:43 INFO - 'HOME': '/home/cltbld', 04:07:43 INFO - 'LANG': 'en_US.UTF-8', 04:07:43 INFO - 'LANGUAGE': 'en_US:en', 04:07:43 INFO - 'LOGNAME': 'cltbld', 04:07:43 INFO - 'MAIL': '/var/mail/cltbld', 04:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:43 INFO - 'MOZ_NO_REMOTE': '1', 04:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:43 INFO - 'NO_EM_RESTART': '1', 04:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:43 INFO - 'PWD': '/builds/slave/test', 04:07:43 INFO - 'SHELL': '/bin/bash', 04:07:43 INFO - 'SHLVL': '1', 04:07:43 INFO - 'TERM': 'linux', 04:07:43 INFO - 'TMOUT': '86400', 04:07:43 INFO - 'USER': 'cltbld', 04:07:43 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', 04:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:43 INFO - '_': '/tools/buildbot/bin/python'} 04:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:07:43 INFO - Cleaning up... 04:07:43 INFO - Return code: 0 04:07:43 INFO - Running post-action listener: _resource_record_post_action 04:07:43 INFO - Running post-action listener: _start_resource_monitoring 04:07:43 INFO - Starting resource monitoring. 04:07:43 INFO - [mozharness: 2016-11-16 12:07:43.632196Z] Finished create-virtualenv step (success) 04:07:43 INFO - [mozharness: 2016-11-16 12:07:43.632704Z] Running install step. 04:07:43 INFO - Running pre-action listener: _resource_record_pre_action 04:07:43 INFO - Running main action method: install 04:07:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:43 INFO - Reading from file tmpfile_stdout 04:07:43 INFO - Detecting whether we're running mozinstall >=1.0... 04:07:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:07:43 INFO - Reading from file tmpfile_stdout 04:07:43 INFO - Output received: 04:07:43 INFO - Usage: mozinstall [options] installer 04:07:43 INFO - Options: 04:07:43 INFO - -h, --help show this help message and exit 04:07:43 INFO - -d DEST, --destination=DEST 04:07:43 INFO - Directory to install application into. [default: 04:07:43 INFO - "/builds/slave/test"] 04:07:43 INFO - --app=APP Application being installed. [default: firefox] 04:07:43 INFO - mkdir: /builds/slave/test/build/application 04:07:43 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:07:43 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:08:00 INFO - Reading from file tmpfile_stdout 04:08:00 INFO - Output received: 04:08:00 INFO - /builds/slave/test/build/application/firefox/firefox 04:08:00 INFO - Running post-action listener: _resource_record_post_action 04:08:00 INFO - [mozharness: 2016-11-16 12:08:00.158933Z] Finished install step (success) 04:08:00 INFO - [mozharness: 2016-11-16 12:08:00.159172Z] Running run-tests step. 04:08:00 INFO - Running pre-action listener: _resource_record_pre_action 04:08:00 INFO - Running main action method: run_tests 04:08:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:08:00 INFO - Python 2.7.3 04:08:00 INFO - Return code: 0 04:08:00 INFO - grabbing minidump binary from tooltool 04:08: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:08:00 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 0x2bc8790>, '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 0x2bc9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:08:00 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:08:00 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:08:00 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:08:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:08:00 INFO - Return code: 0 04:08:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:08:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:08:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:08:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:08:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:08:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:08:00 INFO - Using env: {'DISPLAY': ':0', 04:08:00 INFO - 'HOME': '/home/cltbld', 04:08:00 INFO - 'LANG': 'en_US.UTF-8', 04:08:00 INFO - 'LANGUAGE': 'en_US:en', 04:08:00 INFO - 'LOGNAME': 'cltbld', 04:08:00 INFO - 'MAIL': '/var/mail/cltbld', 04:08:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:08:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:00 INFO - 'MOZ_NO_REMOTE': '1', 04:08:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:00 INFO - 'NO_EM_RESTART': '1', 04:08:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:00 INFO - 'PWD': '/builds/slave/test', 04:08:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:08:00 INFO - 'SHELL': '/bin/bash', 04:08:00 INFO - 'SHLVL': '1', 04:08:00 INFO - 'TERM': 'linux', 04:08:00 INFO - 'TMOUT': '86400', 04:08:00 INFO - 'USER': 'cltbld', 04:08:00 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1479297784.427762-2080687394', 04:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:00 INFO - '_': '/tools/buildbot/bin/python'} 04:08:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:08:00 INFO - mozversion application_buildid: 20161116024633 04:08:00 INFO - mozversion application_changeset: 5b53bda4e10d2cf2a4983cfe1114eda05540584e 04:08:00 INFO - mozversion application_display_name: Nightly 04:08:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:08:00 INFO - mozversion application_name: Firefox 04:08:00 INFO - mozversion application_remotingname: firefox 04:08:00 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 04:08:00 INFO - mozversion application_vendor: Mozilla 04:08:00 INFO - mozversion application_version: 53.0a1 04:08:00 INFO - mozversion platform_buildid: 20161116024633 04:08:00 INFO - mozversion platform_changeset: 5b53bda4e10d2cf2a4983cfe1114eda05540584e 04:08:00 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 04:08:00 INFO - mozversion platform_version: 53.0a1 04:08:00 INFO - using testdate: 1479298080 04:08:00 INFO - actual date: 1479298080 04:08:00 INFO - starting webserver on 'localhost:55999' 04:08:00 INFO - SUITE-START | Running 2 tests 04:08:00 INFO - TEST-START | dromaeo_css 04:08:00 INFO - operating with platform_type : linux_ 04:08:00 INFO - Initialising browser for dromaeo_css test... 04:08:00 INFO - TEST-INFO | started process 2130 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppcJ9jb/profile http://localhost:55999/getInfo.html) 04:08:05 INFO - PROCESS | 2130 | __metrics Screen width/height:1600/1200 04:08:05 INFO - PROCESS | 2130 | colorDepth:24 04:08:05 INFO - PROCESS | 2130 | Browser inner width/height: 1024/697 04:08:05 INFO - PROCESS | 2130 | __metrics 04:08:06 INFO - PROCESS | 2130 | 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:08:06 INFO - PROCESS | 2130 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:08:06 INFO - PROCESS | 2130 | console.error: PushService: 04:08:06 INFO - PROCESS | 2130 | stateChangeProcessEnqueue: Error transitioning state 04:08:06 INFO - PROCESS | 2130 | UnknownError 04:08:07 INFO - TEST-INFO | 2130: exit 0 04:08:07 INFO - Browser initialized. 04:08:07 INFO - Running cycle 1/1 for dromaeo_css test... 04:08:07 INFO - TEST-INFO | started process 2213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppcJ9jb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:19 INFO - PROCESS | 2213 | RSS: Main: 175910912 04:08:19 INFO - PROCESS | 2213 | 04:09:11 INFO - PROCESS | 2213 | 1479298151682 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:11:26 INFO - PROCESS | 2213 | Cycle 1(1): loaded http://localhost:55999/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55999/tests/dromaeo/cssquery-ext.html) 04:11:28 INFO - PROCESS | 2213 | RSS: Main: 243949568 04:11:28 INFO - PROCESS | 2213 | 04:14:30 INFO - PROCESS | 2213 | Cycle 1(1): loaded http://localhost:55999/tests/dromaeo/cssquery-ext.html (next: http://localhost:55999/tests/dromaeo/cssquery-jquery.html) 04:14:31 INFO - PROCESS | 2213 | RSS: Main: 274182144 04:14:31 INFO - PROCESS | 2213 | 04:17:33 INFO - PROCESS | 2213 | Cycle 1(1): loaded http://localhost:55999/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55999/tests/dromaeo/cssquery-mootools.html) 04:17:34 INFO - PROCESS | 2213 | RSS: Main: 218173440 04:17:34 INFO - PROCESS | 2213 | 04:20:36 INFO - PROCESS | 2213 | Cycle 1(1): loaded http://localhost:55999/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55999/tests/dromaeo/cssquery-prototype.html) 04:20:37 INFO - PROCESS | 2213 | RSS: Main: 222273536 04:20:37 INFO - PROCESS | 2213 | 04:23:40 INFO - PROCESS | 2213 | Cycle 1(1): loaded http://localhost:55999/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55999/tests/dromaeo/cssquery-yui.html) 04:23:41 INFO - PROCESS | 2213 | RSS: Main: 224272384 04:23:41 INFO - PROCESS | 2213 | 04:26:44 INFO - PROCESS | 2213 | Cycle 1(1): loaded http://localhost:55999/tests/dromaeo/cssquery-yui.html (next: http://localhost:55999/tests/dromaeo/cssquery-dojo.html) 04:26:44 INFO - PROCESS | 2213 | RSS: Main: 302870528 04:26:44 INFO - PROCESS | 2213 | 04:26:44 INFO - PROCESS | 2213 | __start_tp_report 04:26:44 INFO - PROCESS | 2213 | _x_x_mozilla_page_load 04:26:44 INFO - PROCESS | 2213 | _x_x_mozilla_page_load_details 04:26:44 INFO - PROCESS | 2213 | |i|pagename|runs| 04:26:44 INFO - PROCESS | 2213 | |0;dojo.html;2610.621459888316;2632.3813903732607;2650.960235596466;2664.547027005409;2676.130257666258;4631.282151266559;4672.2057250267535;4718.976405117974;4764.356811830402;4768.570828625423;4702.647301452396;4734.3135245389485;4738.881527961803;4765.666403351766;4816.386510518972;4288.6140247377725;4303.892402689942;4340.327249276367;4389.122175564884;4392.516823149451;4003.3194356959243;4390.67069969752;4409.691321607489;4435.645148388137;4466.285394336906;4249.3413520904305;4396.802143903532;4399.36209249657;4404.537523560028;4484.932726009096;4281.12236991416;4297.247981603238;4331.242032644306;4352.673549483769;4355.281378572532;4353.934690979638;4354.107407981356;4359.04101097758;4391.451068616423;4413.183561041185;4727.976360118212;4738.384010078702;4760.809567617292;4764.071006153801;4764.237721964504;4855.514448555152;4900.289458028566;4900.803967841282;4989.151844186497;5072.34059572257;5028.170351891933;5096.9490305097215;5099.694018358948;5147.510986456318;5151.459096794858;4739.95260047402;4740.312654665123;4742.146413645577;4745;4786.832460863922;4965.280034395065;5010.423801262901;5186.118359878829;5190.455002224788;5242.606804489678;4852.563269305709;4936.703797772145;5057.367829021372;5073.340465739504;5074.314967479343;5080.720560369141;5093.847184584469;5096.9490305097215;5097.1844504879045;5142.537171654569;5002.774875130628;5036.521530454675;5063.518965698253;5073.644844860824;5073.949260507421;4874.147024270738;4915.311856340115;4917.926231106536;5001.24981252815;5004.024215277986;4330.610245077895;4339.175556644227;4345.217860785026;4369.541198174209;4401.581849724271;3778.5843557208686;3791.976166435102;3797.316483033025;3828.502294701671;3832.7125465590193;4238.682098842599;4379.540148284448;4383.693141480066;4386.407834942242;4431.512533621299;4931.50684931504;4958.231474121445;4990.251462280615;4995.250712393097;5026;4331.4152589400655;4332.263515202423;4339.696221264544;4368.5194628590825;4373.562643735601;4554.863354099382;4557.361969324364;4559.293309537027;4567.908641827211;4571.794269257892;4582.908341833211;4618.399608051066;4620.792064357045;4648.65135114861;4658.487566367629;4999.77501012448;5083.949160508348;5092.465291144376;5128.153854614096;5141.511556402136;4733.715977041388;4740.502247263988;4741.146593613044;4742.691725037862;4793.664443488922;4774.880627984328;4802.399700037496;4983.975080124576;4984.975075124601;5036.093503169464;5032.84901452957;5073.44192138857;5080.339555857715;5131.512506311894;5179.300794392709;4963.553280204799;4973.726445045557;4974.104661160881;4975.577075948585;5021.623378246573;4699.906001880012;4717.858464246078;4980.402351717672;4992.900141997067;4993.950060499348;4772.880677983078;4784.736839473862;4790.592799611933;4849.830255941025;4898.559129678346;4935.605151587936;4948.010397920359;4950.504949505021;4953.678010929278;4998.850034498971;4684.578387944965;4733.124371991193;4739.099571081483;4862.732549709658;4873.049755297683 04:26:44 INFO - PROCESS | 2213 | |1;ext.html;554.8917960997605;568.4088547910173;583.47195787812;584.4564554963885;595.7706283081012;27775.722242777567;30274.091777246664;30276.394472110544;30316.09051728449;30358.392832143345;38742.8062859686;40369.59630403695;40431;43848.3422748659;44251.33622995658;7382.926170738291;7437;7496.13794413644;7514.2485751424965;7518.548887066766;7524.2851929066655;7592.088949326061;7592.126905405866;7593.544387336749;7598.886016709726;7598.240175982412;7630.198829122945;7633.503822251536;7639.503432276912;7646.770596882103;7546.245375462465;7574.545527268381;7582.5829579373385;7593.430492713013;7599.810004749926;7478.775636730852;7492.587907665076;7540.547567145989;7541.132769731496;7543.7359692411055;35194.64805351939;35654.28691426157;35674.8216258917;35701.64298357035;35704.10739731501;2892.566115082733;3117.9064628061196;3228.402745492068;3472.0972547137926;3528.329617372691;27645.447091058268;28042.298942526395;28162.577561336595;28190.577141342896;28370.148895533166;3405.9318813623836;3487.2676737885076;3520.4015317396106;3553.34263161316;3585.8027808470524;229607;230277;231598;232280;232283;50896.23655645168;51114.48885511172;51147.48852511427;51193.23210151851;51218.23172652339;53842.73078634582;54018.45981540213;54035.18947215795;54055.45944540583;54149.45850541444;14515.782263266059;14780.260986950609;14785.852141478448;14790.852091479162;14798;10941.398223097805;10951.726206844893;10954.342739435659;10999.505022274017;11002.119830413547;15721.371145154066;16166.676666466605;16203.918980405022;16212.432564860173;16220.432284869972;5549.361823390362;5563.63836350644;5598.412166722517;5640.32316122068;5682.261306030189;667.6689944410401;759.7151068349369;832.5421018439833;836.7740710008263;916.5234078279258;25185;27178;27232.727672723417;27312.72687273102;27369.863150684516;785.8821176823408;921.7787730944525;1003.1623594298842;1005.1606908231709;1021.8671572695501;14580.1980891052;15606;15705.921470392575;16280.918595406947;16464.586463538075;341957;344312;345722;345770;351694;49585.75207123941;49586.50413495819;49633;49664;49835;1047.6961681112543;1104.3870651788334;1142.971425714347;1189.851268591426;1229.9938500307442;26306.73693263043;28093.859530702215;28805.85597072001;28834.27914302159;28861.711382885904;40500.79749601233;40966.79516602517;40990.38514422346;41056.79471602623;41113.79443102765;275221;278312;279160;279502;280168;23869.64195537103;23960.28119156428;24865.502689945737;24903.501929960938;26192.73807261979;39513.674788662356;39530.40704389379;39860.601393985686;40195.79902100588;40708.389374160004;34271.65728342784;34552.654473454946;34702.65297346994;34736;34748;34172.65827341794;34609.30781384408;34852.30295394129;34983.65016349804;35716.64283357237;33610.15974600557;33856.83071584626;33918.83040584781;34031.48952765661;34952.475712863816;29941;31545.36909261848;31714.20714482064;31936.52095218527;31947.36105277835;23889.880550597136;24371.75628243695;24383.878080609484;24769.25692229236;24908.37729056788 04:26:44 INFO - PROCESS | 2213 | |2;jquery.html;349.168977832758;351.8698081709769;364.7865998390941;371.6803548947904;376.8210100202404;12536.185147965387;13157.802632960513;13392.59822205333;16096.275667594957;16121.677566448694;14870.256487175651;14886.543720286167;14891.106533607992;14927.477538286163;15259.618509537268;4805.279208118775;5018.723970181639;5022.04581129586;5023.974880125595;5029.647924645276;3698.3712768829228;3912.4326972588956;5557.166425036256;5748.511376532979;5784.2769653793275;5595.104783234683;5858.062709966406;5861.472467477926;5863.2670916135485;5867.090600956859;5731.312242530881;5760.423957604248;5819.068948968187;5858.326292476378;5863.976927959847;4877.34155888954;4940.777665005084;5177.326947496801;5179.326687530597;5187.688738675692;19423;19594.902025489922;19713.40859774209;19730.21079156832;19909.402717918485;1799.5231263715125;1814.718718598606;1875.1842948317526;1959.2848610257154;2461.716902556211;12442.253464792142;12473.875261247453;12697.619071427873;12992.870071299356;13275.800862987064;1620.3437607768872;1699.8640108791267;1727.6890159771235;1767.2489192093308;1800.9639807203914;65333.673331633516;66764.3323566763;67671.323286767;68974.65512672404;69576;9565;9612.231021518262;9768.07203315684;9954.517211383125;10070.439081942312;13576.660583485493;13599.320033998261;13604.727905441836;13606.38771255296;13626.046176767532;7013.333733295329;7177.6770045348085;7208.207097219301;7277.345038946414;7308.086489188851;6844.076049733222;6948.895766563505;7001.579905205602;7138.214796372395;7183.964080179566;4157.563455837154;4241.936370954438;4258.318669012943;4276.700630955803;4408.470983482002;1751.2644689230553;1793.3454289184615;1793.4709260768104;1812.1392338639305;1829.5609053826986;689.6930865764787;814.311906439058;825.5748289630845;834.3783881008566;875.0330884372804;15957.920210399107;16389.83610163883;16912.661746764996;17168.39910603148;17305.826941730422;824.2499325613662;853.7097386888488;854.457419538585;872.0799556467987;874.0603850860224;8843.60203790831;8923.196912277926;9372.437653740797;9375.249980001583;9470.57382417779;363989.12184928625;368440;372192;383456;391642;77863;81245;82162;82249.17750822534;82957.58521207355;879.4064006795387;881.5283823154582;919.1543779722671;927.2118699105706;929.5120061967522;15197.696046079238;15206.695866082837;15951.68096638084;16086.597835054217;16230.756538651693;35786.64213357833;35966.640333597374;36376.907232987935;36756.632433676394;36875.26249474942;45455.772721136185;48883;49386.753066234436;49608.50391496039;49621.25568116409;6500.187476565429;6693;6779.525433219627;7044;7720.7683769487;10856.882907832896;11136.554537818396;11152.16358773079;11293.830592541282;11713.355765432983;9694.418334899929;9893.65372211969;9896.15882649954;9911.553980071058;10553.63062292816;5180.637355385087;5449.64577302474;9693.41839489633;9711.708648740549;10611.2041596879;9169.490009836249;9648.71053868385;9954.950225248827;9969.950150249202;10191.082802547806;6597.307282735435;6767.661616919036;6774.491913106438;6777.728890844311;6956.513044086865;7784.143744188248;9334.2999275056;9816.705498835046;10069.345492542961;10208.438535880598 04:26:44 INFO - PROCESS | 2213 | |3;mootools.html;1344.489094144225;1362.4958765256854;1432.1693417817667;1658.7760652311933;1664.109701309798;6098.603590766597;6292.496600271978;6489.578177418471;6880.655967201645;6936.861262774748;6490.480761539077;6730.49521285903;6747.224069232027;6901.344372284638;6911.101556797622;2008.2770202727042;2040.479677682189;2042.4077017664858;2042.4893776555862;2051.1795281887216;1750.2473936207425;1819.672458957387;1966.2135145941595;1987.0859404673868;1997.8501612379057;1954.5211423201335;2016.67733162694;2021.4643119573325;2041.4896275931017;2048.150017742635;2007.9196832126697;2025.422754514956;2045.3659365596639;2047.3141497598322;2051.138521820839;1973.1219607274768;2017.778044415113;2020.1515363547198;2020.8383329333617;2026.4224695961727;6851.623160726208;6886.862262754767;6907;6936.514443988923;6949.89575156373;3943.3887747398912;4117.341225403921;4122.113745544722;4127.318992366256;4129.091599848029;2470.3330100872845;2742.766864816493;2744.382513934369;2752.1881045091545;2753.917382478529;778.532880271838;815.7185770909027;846.3736834742308;847.2163248994656;847.267113946438;8775.47347159166;8834.249088827457;8855.981562120438;8876.245519130882;8888.777780555472;3526.994806480141;3700.3339398908456;3739.1491211850307;3789.2610940866266;3799.696024318048;7912.920870791334;7919.960400197962;7934.20657934202;7938.166492518318;7946.801329966797;4058.0057885818164;4085.7957102144774;4093.7543747375253;4117.835286588503;4121.258173528794;3699.0567405312013;3775.679067279257;3786.3941769316775;3788.109794198361;3790.6209379062425;3170.571972783691;3228.4511633022444;3234.8059116453087;3286.622038465607;3293.604767427876;932.3240650528448;970.088117169858;1031.4636389077637;1038.6209033702796;1058.264506168221;746.3730466408243;747.4805010517747;820.2699597358355;822.617482870468;877.7059685005466;4806.975965120152;4807.807687692523;4876.853939324256;4990;5026.924596131061;819.9467034642848;841.293313616565;841.7769291137853;870.5821205821242;875.2604049578097;3403.1832360233366;3430.2624935638955;3430.3139372125675;3432.7768695034742;3524.7708898921487;7841.137474877759;8271;8281.585920703941;8291.08798032216;8302.418830681794;8255.463394879314;8286.129956354616;8288.295494883003;8298.958505207434;8309.45988510757;6423.614583125028;6492;6524.543281970216;6552.115464412243;6557.606543607399;4737.336772851734;4739.881502962316;4784.976075119602;4789.640776941813;4898.804047838046;7475.925240747523;7573.772786816405;7574.848503030019;7587.544747314958;7597.2022937592965;7224.024756657994;7529.698812047457;7549.282818132268;7672.232776722283;7680.308772210305;6003.489703375088;6059.72731227087;6060.303065147565;6076.240469941257;6089.665068421279;6359.109724638462;6375.203099612549;6389.744410223539;6421.454176395058;6428.228612566522;5080.237964305384;5828.154917536848;5951.791687290924;6016.488598469179;6034.24571928509;5948.078047902582;5961.105834124916;6031.849203769941;6045.637261764308;6089.847753806191;5518.724063796874;5576.163575463551;5652.971735141298;5653.915191272052;5667.20659107717;4049.8177582008293;4050.311447053949;4117.300058989919;4140.60664236897;4258.680598955153;4032.516098068251;4098.176311541335;4137.110521237948;4216.45186125814;4243.596858298457 04:26:44 INFO - PROCESS | 2213 | |4;prototype.html;292.47792690048254;297.8600057972753;302.3258134360376;307.21046909442714;307.26256983240233;4796.328514008042;4842.2252439609665;4847.684900481467;4847.927281090787;4874.390701162355;4777.331173635694;4784.16277151498;4802.279658051285;4808.759562021903;4816.662833601649;3822.140018495837;3825.9426108608395;3829.5978922213185;3834.482344883447;3847.2882516734494;3706.2031663192406;3839.117003089277;3856.9228615427674;3862.575116737157;3871.3805791073432;3746.438034294864;3785.5457345118625;3794.981025094871;3801.6999715172337;3804.448354988525;3781.3949768036982;3783.016415731902;3784.8675296364495;3799.4490798834154;3800.2969450651717;3085.891993780207;3141.7172454479205;3224.6130464344196;3385.4752513360468;3392.9830350848333;4624.260118381043;4630.467496237942;4634.83778067766;4644.535546445362;4652.325412815123;4286.421333120051;4294.227039132955;4298.570142985708;4298.699091063627;4303.0421158372865;4621;4749.881252968704;5002.7498625068965;5014.24786282057;5027.572656324217;3605.94591081134;3619;3621.5110960020324;3622.728295377857;3630.9273814523826;5202.791888324463;5206.817761378372;5217.8173763918085;5231.921521177185;5234.659747116425;3595.5146055282203;3660.4875317455576;3700.9814950925074;3729.1236559408517;3737.7757334560015;3686.612905644922;3712.8514859405864;3720.534933133358;3726.6087060858763;3727.5713292971113;4187.027210680451;4188.350805625133;4190.580941905785;4227.704060715781;4235.576442355739;4960.677555958923;4968.850934471971;4973.278874563168;5025.221090730943;5028.396592408862;1198.6523908066738;1221.1940119521073;1222.8471441069867;1222.9299363057326;1234.2039384596885;832.3840358134937;879.5821984557284;891.595736714664;897.1342654338464;899.3479727197729;4223.894402639959;4251.6386107180615;4289.91420171601;4316.395704601358;4332.393464914914;4966.577840883565;4970.2793095001025;4971.602271818246;4982.252662100714;5002.424721157041;4241.533431322552;4256.659152366995;4273.914521709548;4280.828766849353;4289.442372491556;2525.8863351149243;2619.4630100829286;2637.3011152044724;2645.708972013077;2646.523625747384;4596.977015114903;4636.675432719745;4666;4708.705106095851;4849.563539281482;5266.92099618506;5273.86611878448;5277.234800953917;5281.894362112813;5294.655847369909;4838.056578967067;4838.685485443435;4842.58837998774;4845;4852.466228714909;5021.573166280907;5145.639805213599;5170.1727723564045;5177.326947496801;5191.402988656202;5094.828189516358;5096.986690257401;5124.769385377593;5130.896857175725;5130.97434512825;4848.3454733610515;4863.927041094457;4864.416270047475;4869.951300487091;4879.316895634685;3380.239446124602;3585;3607.837647305825;3622.673959343672;3627.528421305213;5123.257127716534;5134.922976155286;5142.665726727751;5146.485351464824;5150.381954165524;5014.7994080236385;5017.874553136201;5023.57299629521;5044.899102018013;5046.444891061907;4882.804687812448;4942.357493525818;4956.851294461172;4993.15116430215;4997.450280469218;4875.366202393666;4880.19388851419;4880.243562247857;4881.755912204305;4884.291777692286;5005.274235235943;5008.57427118699;5011.473795251446;5027.838029647287;5037.949620503748;4801.4958429365815;4888.213718180603;4903.877403064952;4919.483454237254;4929.630277729257 04:26:44 INFO - PROCESS | 2213 | |5;yui.html;615.4399496458224;623.3454872383995;629.3046183966717;721.2111579114679;743.5538676793923;11680.649580512598;11725.355105469196;11736.589219377323;11762.353070581124;11781.528738850446;12120.757584848297;12327.815082773766;12334.074944379163;12357.691057723561;12369.319687417188;621.4934828115095;638.4445532386829;753.2279413601075;762.3063012658482;762.321533834886;765.5291995422831;766.8274638206386;767.3209209849268;768.0131031624364;768.06679883941;821.1296026212204;821.8520666280067;822.3585603229491;822.5106061893194;823.0247157118804;656.8095252376805;674.912261406019;675.0818886314609;678.1590827374021;822;494.332650921257;582.5456144207525;596.0195478437988;597.3309892919914;599.4245524296681;12070.396480176043;12072.336021518813;12137.514499420013;12140.210886292363;12185.695357616041;11417.771644567145;11586.304821710724;11609;11910.225835320764;12277.447514861853;10778.892211077868;10875.78248435027;10896.346219226793;11458.94270528642;11908.58319958806;4041.171559830257;4063.471748672683;4075.7758323292205;4079.347304431277;4188.643965262956;48798.756006220094;49032.50967490315;49272;49296.75351623219;49602;10025.949870250603;10123;10170.593176272867;10173.135283500986;10363.481825908826;17651.205695743723;17679.116044197737;17683.469495915142;17721.379751708886;17837.28650853977;6329.113924050636;6380.585261957958;6397.264314603787;6416.262129855033;6676.599404035774;3404.8467818948207;3423.726101911841;3462.0306314232057;3483.5819701635965;3486.7198600940014;2674.211107723226;2732.8360298382163;2755.3662657588866;2755.4902343066597;2767.5986981887513;451.57551901212753;455.12388651845066;460.0316334116703;465.2555910543104;471.08139128699173;461.79911738393906;482.22602722630376;501.8795489082594;520.5159201942155;539.0001547130096;6782.966085169543;6797.796066118024;6804.55770374924;7051.471139664545;7125.42996560274;469.45543169922723;491.2459374859573;508.0347340053927;515.0754395859441;553.0487561394395;3044.1932887784756;3094.3965926644087;3098.380323935177;3137.6862313768443;3389.406853800575;67873.66063169652;69976;70512.64743676351;71034.64482677553;72263.63868180626;38593.807030964665;42997.57002429998;63863.68068159629;63920.36079639144;66292.33707662861;58913.41086589165;59444.70277648671;59601.40398595959;59603.701981489816;59709;6238.625682459067;6439.903401449075;6493.512986525935;6554.410103090745;6708.127943367331;31611.525827112153;39611;39675.80162099171;40463.797681011405;41330;31075.844620776752;36339.45490817587;52386.73806630942;52815.73592132015;54048.45951540434;8644.265237454636;8754.124587541195;8844.248238899509;9136.08639136081;9330.066993300616;9166;9227.861582076408;9468.905310946802;9593.904060959301;10033.046860548237;8591.355648326275;8790.95604521999;8798.47209167452;9015.909840901508;9028.277737781093;8946.68686595966;9305;9344.486053267136;9724.659636912675;9725.513724313614;8580.184882436159;8593.269572086443;8677.045524992373;8864.42381245217;9079.591418386057;7473.780369096457;7476.792998002608;7796.961015194887;7802.219778022152;7991.219536531172;7557.395408367427;8255.812209764297;8650.524221167896;9361.906380936103;9537.236524657023 04:26:44 INFO - PROCESS | 2213 | __end_tp_report 04:26:44 INFO - PROCESS | 2213 | __start_cc_report 04:26:44 INFO - PROCESS | 2213 | _x_x_mozilla_cycle_collect,1619 04:26:44 INFO - PROCESS | 2213 | __end_cc_report 04:26:44 INFO - PROCESS | 2213 | __startTimestamp1479299204595__endTimestamp 04:26:44 INFO - PROCESS | 2213 | 04:26:44 INFO - PROCESS | 2213 | ------- Summary: start ------- 04:26:44 INFO - PROCESS | 2213 | Number of tests: 6 04:26:44 INFO - PROCESS | 2213 | 04:26:44 INFO - PROCESS | 2213 | [#0] dojo.html Cycles:165 Average:4665.31 Median:4764.07 stddev:480.03 (10.1%) stddev-sans-first:453.64 04:26:44 INFO - PROCESS | 2213 | Values: 2610.6 2632.4 2651.0 2664.5 2676.1 4631.3 4672.2 4719.0 4764.4 4768.6 4702.6 4734.3 4738.9 4765.7 4816.4 4288.6 4303.9 4340.3 4389.1 4392.5 4003.3 4390.7 4409.7 4435.6 4466.3 4249.3 4396.8 4399.4 4404.5 4484.9 4281.1 4297.2 4331.2 4352.7 4355.3 4353.9 4354.1 4359.0 4391.5 4413.2 4728.0 4738.4 4760.8 4764.1 4764.2 4855.5 4900.3 4900.8 4989.2 5072.3 5028.2 5096.9 5099.7 5147.5 5151.5 4740.0 4740.3 4742.1 4745.0 4786.8 4965.3 5010.4 5186.1 5190.5 5242.6 4852.6 4936.7 5057.4 5073.3 5074.3 5080.7 5093.8 5096.9 5097.2 5142.5 5002.8 5036.5 5063.5 5073.6 5073.9 4874.1 4915.3 4917.9 5001.2 5004.0 4330.6 4339.2 4345.2 4369.5 4401.6 3778.6 3792.0 3797.3 3828.5 3832.7 4238.7 4379.5 4383.7 4386.4 4431.5 4931.5 4958.2 4990.3 4995.3 5026.0 4331.4 4332.3 4339.7 4368.5 4373.6 4554.9 4557.4 4559.3 4567.9 4571.8 4582.9 4618.4 4620.8 4648.7 4658.5 4999.8 5083.9 5092.5 5128.2 5141.5 4733.7 4740.5 4741.1 4742.7 4793.7 4774.9 4802.4 4984.0 4985.0 5036.1 5032.8 5073.4 5080.3 5131.5 5179.3 4963.6 4973.7 4974.1 4975.6 5021.6 4699.9 4717.9 4980.4 4992.9 4994.0 4772.9 4784.7 4790.6 4849.8 4898.6 4935.6 4948.0 4950.5 4953.7 4998.9 4684.6 4733.1 4739.1 4862.7 4873.0 04:26:44 INFO - PROCESS | 2213 | 04:26:44 INFO - PROCESS | 2213 | [#1] ext.html Cycles:180 Average:43795.04 Median:19104.05 stddev:75862.49 (397.1%) stddev-sans-first:76005.83 04:26:44 INFO - PROCESS | 2213 | Values: 554.9 568.4 583.5 584.5 595.8 27775.7 30274.1 30276.4 30316.1 30358.4 38742.8 40369.6 40431.0 43848.3 44251.3 7382.9 7437.0 7496.1 7514.2 7518.5 7524.3 7592.1 7592.1 7593.5 7598.9 7598.2 7630.2 7633.5 7639.5 7646.8 7546.2 7574.5 7582.6 7593.4 7599.8 7478.8 7492.6 7540.5 7541.1 7543.7 35194.6 35654.3 35674.8 35701.6 35704.1 2892.6 3117.9 3228.4 3472.1 3528.3 27645.4 28042.3 28162.6 28190.6 28370.1 3405.9 3487.3 3520.4 3553.3 3585.8 229607.0 230277.0 231598.0 232280.0 232283.0 50896.2 51114.5 51147.5 51193.2 51218.2 53842.7 54018.5 54035.2 54055.5 54149.5 14515.8 14780.3 14785.9 14790.9 14798.0 10941.4 10951.7 10954.3 10999.5 11002.1 15721.4 16166.7 16203.9 16212.4 16220.4 5549.4 5563.6 5598.4 5640.3 5682.3 667.7 759.7 832.5 836.8 916.5 25185.0 27178.0 27232.7 27312.7 27369.9 785.9 921.8 1003.2 1005.2 1021.9 14580.2 15606.0 15705.9 16280.9 16464.6 341957.0 344312.0 345722.0 345770.0 351694.0 49585.8 49586.5 49633.0 49664.0 49835.0 1047.7 1104.4 1143.0 1189.9 1230.0 26306.7 28093.9 28805.9 28834.3 28861.7 40500.8 40966.8 40990.4 41056.8 41113.8 275221.0 278312.0 279160.0 279502.0 280168.0 23869.6 23960.3 24865.5 24903.5 26192.7 39513.7 39530.4 39860.6 40195.8 40708.4 34271.7 34552.7 34702.7 34736.0 34748.0 34172.7 34609.3 34852.3 34983.7 35716.6 33610.2 33856.8 33918.8 34031.5 34952.5 29941.0 31545.4 31714.2 31936.5 31947.4 23889.9 24371.8 24383.9 24769.3 24908.4 04:26:44 INFO - PROCESS | 2213 | 04:26:44 INFO - PROCESS | 2213 | [#2] jquery.html Cycles:180 Average:23678.72 Median:27319.99 stddev:62279.33 (228.0%) stddev-sans-first:62429.40 04:26:44 INFO - PROCESS | 2213 | Values: 349.2 351.9 364.8 371.7 376.8 12536.2 13157.8 13392.6 16096.3 16121.7 14870.3 14886.5 14891.1 14927.5 15259.6 4805.3 5018.7 5022.0 5024.0 5029.6 3698.4 3912.4 5557.2 5748.5 5784.3 5595.1 5858.1 5861.5 5863.3 5867.1 5731.3 5760.4 5819.1 5858.3 5864.0 4877.3 4940.8 5177.3 5179.3 5187.7 19423.0 19594.9 19713.4 19730.2 19909.4 1799.5 1814.7 1875.2 1959.3 2461.7 12442.3 12473.9 12697.6 12992.9 13275.8 1620.3 1699.9 1727.7 1767.2 1801.0 65333.7 66764.3 67671.3 68974.7 69576.0 9565.0 9612.2 9768.1 9954.5 10070.4 13576.7 13599.3 13604.7 13606.4 13626.0 7013.3 7177.7 7208.2 7277.3 7308.1 6844.1 6948.9 7001.6 7138.2 7184.0 4157.6 4241.9 4258.3 4276.7 4408.5 1751.3 1793.3 1793.5 1812.1 1829.6 689.7 814.3 825.6 834.4 875.0 15957.9 16389.8 16912.7 17168.4 17305.8 824.2 853.7 854.5 872.1 874.1 8843.6 8923.2 9372.4 9375.2 9470.6 363989.1 368440.0 372192.0 383456.0 391642.0 77863.0 81245.0 82162.0 82249.2 82957.6 879.4 881.5 919.2 927.2 929.5 15197.7 15206.7 15951.7 16086.6 16230.8 35786.6 35966.6 36376.9 36756.6 36875.3 45455.8 48883.0 49386.8 49608.5 49621.3 6500.2 6693.0 6779.5 7044.0 7720.8 10856.9 11136.6 11152.2 11293.8 11713.4 9694.4 9893.7 9896.2 9911.6 10553.6 5180.6 5449.6 9693.4 9711.7 10611.2 9169.5 9648.7 9955.0 9970.0 10191.1 6597.3 6767.7 6774.5 6777.7 6956.5 7784.1 9334.3 9816.7 10069.3 10208.4 04:26:44 INFO - PROCESS | 2213 | 04:26:44 INFO - PROCESS | 2213 | [#3] mootools.html Cycles:180 Average:4525.46 Median:5614.57 stddev:2415.38 (43.0%) stddev-sans-first:2410.33 04:26:44 INFO - PROCESS | 2213 | Values: 1344.5 1362.5 1432.2 1658.8 1664.1 6098.6 6292.5 6489.6 6880.7 6936.9 6490.5 6730.5 6747.2 6901.3 6911.1 2008.3 2040.5 2042.4 2042.5 2051.2 1750.2 1819.7 1966.2 1987.1 1997.9 1954.5 2016.7 2021.5 2041.5 2048.2 2007.9 2025.4 2045.4 2047.3 2051.1 1973.1 2017.8 2020.2 2020.8 2026.4 6851.6 6886.9 6907.0 6936.5 6949.9 3943.4 4117.3 4122.1 4127.3 4129.1 2470.3 2742.8 2744.4 2752.2 2753.9 778.5 815.7 846.4 847.2 847.3 8775.5 8834.2 8856.0 8876.2 8888.8 3527.0 3700.3 3739.1 3789.3 3799.7 7912.9 7920.0 7934.2 7938.2 7946.8 4058.0 4085.8 4093.8 4117.8 4121.3 3699.1 3775.7 3786.4 3788.1 3790.6 3170.6 3228.5 3234.8 3286.6 3293.6 932.3 970.1 1031.5 1038.6 1058.3 746.4 747.5 820.3 822.6 877.7 4807.0 4807.8 4876.9 4990.0 5026.9 819.9 841.3 841.8 870.6 875.3 3403.2 3430.3 3430.3 3432.8 3524.8 7841.1 8271.0 8281.6 8291.1 8302.4 8255.5 8286.1 8288.3 8299.0 8309.5 6423.6 6492.0 6524.5 6552.1 6557.6 4737.3 4739.9 4785.0 4789.6 4898.8 7475.9 7573.8 7574.8 7587.5 7597.2 7224.0 7529.7 7549.3 7672.2 7680.3 6003.5 6059.7 6060.3 6076.2 6089.7 6359.1 6375.2 6389.7 6421.5 6428.2 5080.2 5828.2 5951.8 6016.5 6034.2 5948.1 5961.1 6031.8 6045.6 6089.8 5518.7 5576.2 5653.0 5653.9 5667.2 4049.8 4050.3 4117.3 4140.6 4258.7 4032.5 4098.2 4137.1 4216.5 4243.6 04:26:44 INFO - PROCESS | 2213 | 04:26:44 INFO - PROCESS | 2213 | [#4] prototype.html Cycles:180 Average:4148.08 Median:4763.61 stddev:1203.07 (25.3%) stddev-sans-first:1171.12 04:26:44 INFO - PROCESS | 2213 | Values: 292.5 297.9 302.3 307.2 307.3 4796.3 4842.2 4847.7 4847.9 4874.4 4777.3 4784.2 4802.3 4808.8 4816.7 3822.1 3825.9 3829.6 3834.5 3847.3 3706.2 3839.1 3856.9 3862.6 3871.4 3746.4 3785.5 3795.0 3801.7 3804.4 3781.4 3783.0 3784.9 3799.4 3800.3 3085.9 3141.7 3224.6 3385.5 3393.0 4624.3 4630.5 4634.8 4644.5 4652.3 4286.4 4294.2 4298.6 4298.7 4303.0 4621.0 4749.9 5002.7 5014.2 5027.6 3605.9 3619.0 3621.5 3622.7 3630.9 5202.8 5206.8 5217.8 5231.9 5234.7 3595.5 3660.5 3701.0 3729.1 3737.8 3686.6 3712.9 3720.5 3726.6 3727.6 4187.0 4188.4 4190.6 4227.7 4235.6 4960.7 4968.9 4973.3 5025.2 5028.4 1198.7 1221.2 1222.8 1222.9 1234.2 832.4 879.6 891.6 897.1 899.3 4223.9 4251.6 4289.9 4316.4 4332.4 4966.6 4970.3 4971.6 4982.3 5002.4 4241.5 4256.7 4273.9 4280.8 4289.4 2525.9 2619.5 2637.3 2645.7 2646.5 4597.0 4636.7 4666.0 4708.7 4849.6 5266.9 5273.9 5277.2 5281.9 5294.7 4838.1 4838.7 4842.6 4845.0 4852.5 5021.6 5145.6 5170.2 5177.3 5191.4 5094.8 5097.0 5124.8 5130.9 5131.0 4848.3 4863.9 4864.4 4870.0 4879.3 3380.2 3585.0 3607.8 3622.7 3627.5 5123.3 5134.9 5142.7 5146.5 5150.4 5014.8 5017.9 5023.6 5044.9 5046.4 4882.8 4942.4 4956.9 4993.2 4997.5 4875.4 4880.2 4880.2 4881.8 4884.3 5005.3 5008.6 5011.5 5027.8 5037.9 4801.5 4888.2 4903.9 4919.5 4929.6 04:26:44 INFO - PROCESS | 2213 | 04:26:44 INFO - PROCESS | 2213 | [#5] yui.html Cycles:180 Average:14049.86 Median:59179.06 stddev:18663.99 (31.5%) stddev-sans-first:18689.08 04:26:44 INFO - PROCESS | 2213 | Values: 615.4 623.3 629.3 721.2 743.6 11680.6 11725.4 11736.6 11762.4 11781.5 12120.8 12327.8 12334.1 12357.7 12369.3 621.5 638.4 753.2 762.3 762.3 765.5 766.8 767.3 768.0 768.1 821.1 821.9 822.4 822.5 823.0 656.8 674.9 675.1 678.2 822.0 494.3 582.5 596.0 597.3 599.4 12070.4 12072.3 12137.5 12140.2 12185.7 11417.8 11586.3 11609.0 11910.2 12277.4 10778.9 10875.8 10896.3 11458.9 11908.6 4041.2 4063.5 4075.8 4079.3 4188.6 48798.8 49032.5 49272.0 49296.8 49602.0 10025.9 10123.0 10170.6 10173.1 10363.5 17651.2 17679.1 17683.5 17721.4 17837.3 6329.1 6380.6 6397.3 6416.3 6676.6 3404.8 3423.7 3462.0 3483.6 3486.7 2674.2 2732.8 2755.4 2755.5 2767.6 451.6 455.1 460.0 465.3 471.1 461.8 482.2 501.9 520.5 539.0 6783.0 6797.8 6804.6 7051.5 7125.4 469.5 491.2 508.0 515.1 553.0 3044.2 3094.4 3098.4 3137.7 3389.4 67873.7 69976.0 70512.6 71034.6 72263.6 38593.8 42997.6 63863.7 63920.4 66292.3 58913.4 59444.7 59601.4 59603.7 59709.0 6238.6 6439.9 6493.5 6554.4 6708.1 31611.5 39611.0 39675.8 40463.8 41330.0 31075.8 36339.5 52386.7 52815.7 54048.5 8644.3 8754.1 8844.2 9136.1 9330.1 9166.0 9227.9 9468.9 9593.9 10033.0 8591.4 8791.0 8798.5 9015.9 9028.3 8946.7 9305.0 9344.5 9724.7 9725.5 8580.2 8593.3 8677.0 8864.4 9079.6 7473.8 7476.8 7797.0 7802.2 7991.2 7557.4 8255.8 8650.5 9361.9 9537.2 04:26:44 INFO - PROCESS | 2213 | -------- Summary: end -------- 04:26:44 INFO - PROCESS | 2213 | 04:26:45 INFO - TEST-INFO | 2213: exit 0 04:26:45 INFO - TEST-OK | dromaeo_css | took 1125247ms 04:26:45 INFO - TEST-START | kraken 04:26:45 INFO - operating with platform_type : linux_ 04:26:45 INFO - Initialising browser for kraken test... 04:26:45 INFO - TEST-INFO | started process 2605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5TFcp1/profile http://localhost:55999/getInfo.html) 04:26:50 INFO - PROCESS | 2605 | __metrics Screen width/height:1600/1200 04:26:50 INFO - PROCESS | 2605 | colorDepth:24 04:26:50 INFO - PROCESS | 2605 | Browser inner width/height: 1024/697 04:26:50 INFO - PROCESS | 2605 | __metrics 04:26:51 INFO - PROCESS | 2605 | 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:26:51 INFO - PROCESS | 2605 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:26:52 INFO - PROCESS | 2605 | console.error: PushService: 04:26:52 INFO - PROCESS | 2605 | stateChangeProcessEnqueue: Error transitioning state 04:26:52 INFO - PROCESS | 2605 | UnknownError 04:26:52 INFO - TEST-INFO | 2605: exit 0 04:26:52 INFO - Browser initialized. 04:26:52 INFO - Running cycle 1/1 for kraken test... 04:26:52 INFO - TEST-INFO | started process 2687 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5TFcp1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:27:05 INFO - PROCESS | 2687 | RSS: Main: 175005696 04:27:05 INFO - PROCESS | 2687 | 04:27:07 INFO - PROCESS | 2687 | Cycle 1(1): loaded http://localhost:55999/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55999/tests/kraken/driver.html?testName=audio-beat-detection) 04:27:08 INFO - PROCESS | 2687 | RSS: Main: 240353280 04:27:08 INFO - PROCESS | 2687 | 04:27:11 INFO - PROCESS | 2687 | Cycle 1(1): loaded http://localhost:55999/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55999/tests/kraken/driver.html?testName=audio-dft) 04:27:12 INFO - PROCESS | 2687 | RSS: Main: 217808896 04:27:12 INFO - PROCESS | 2687 | 04:27:15 INFO - PROCESS | 2687 | Cycle 1(1): loaded http://localhost:55999/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55999/tests/kraken/driver.html?testName=audio-fft) 04:27:16 INFO - PROCESS | 2687 | RSS: Main: 299687936 04:27:16 INFO - PROCESS | 2687 | 04:27:18 INFO - PROCESS | 2687 | Cycle 1(1): loaded http://localhost:55999/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55999/tests/kraken/driver.html?testName=audio-oscillator) 04:27:19 INFO - PROCESS | 2687 | RSS: Main: 211046400 04:27:19 INFO - PROCESS | 2687 | 04:27:21 INFO - PROCESS | 2687 | Cycle 1(1): loaded http://localhost:55999/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55999/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:27:21 INFO - PROCESS | 2687 | RSS: Main: 214364160 04:27:21 INFO - PROCESS | 2687 | 04:27:25 INFO - PROCESS | 2687 | Cycle 1(1): loaded http://localhost:55999/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55999/tests/kraken/driver.html?testName=imaging-darkroom) 04:27:25 INFO - PROCESS | 2687 | RSS: Main: 253100032 04:27:25 INFO - PROCESS | 2687 | 04:27:29 INFO - PROCESS | 2687 | Cycle 1(1): loaded http://localhost:55999/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55999/tests/kraken/driver.html?testName=imaging-desaturate) 04:27:29 INFO - PROCESS | 2687 | RSS: Main: 253489152 04:27:29 INFO - PROCESS | 2687 | 04:27:32 INFO - PROCESS | 2687 | Cycle 1(1): loaded http://localhost:55999/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55999/tests/kraken/driver.html?testName=json-parse-financial) 04:27:33 INFO - PROCESS | 2687 | RSS: Main: 252612608 04:27:33 INFO - PROCESS | 2687 | 04:27:34 INFO - PROCESS | 2687 | Cycle 1(1): loaded http://localhost:55999/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55999/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:27:35 INFO - PROCESS | 2687 | RSS: Main: 214855680 04:27:35 INFO - PROCESS | 2687 | 04:27:37 INFO - PROCESS | 2687 | Cycle 1(1): loaded http://localhost:55999/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55999/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:27:38 INFO - PROCESS | 2687 | RSS: Main: 222052352 04:27:38 INFO - PROCESS | 2687 | 04:27:40 INFO - PROCESS | 2687 | Cycle 1(1): loaded http://localhost:55999/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55999/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:27:40 INFO - PROCESS | 2687 | RSS: Main: 230510592 04:27:40 INFO - PROCESS | 2687 | 04:27:43 INFO - PROCESS | 2687 | Cycle 1(1): loaded http://localhost:55999/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55999/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:27:44 INFO - PROCESS | 2687 | RSS: Main: 234328064 04:27:44 INFO - PROCESS | 2687 | 04:27:47 INFO - PROCESS | 2687 | Cycle 1(1): loaded http://localhost:55999/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55999/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:27:48 INFO - PROCESS | 2687 | RSS: Main: 235810816 04:27:48 INFO - PROCESS | 2687 | 04:27:50 INFO - PROCESS | 2687 | Cycle 1(1): loaded http://localhost:55999/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55999/tests/kraken/driver.html?testName=ai-astar) 04:27:50 INFO - PROCESS | 2687 | RSS: Main: 287121408 04:27:50 INFO - PROCESS | 2687 | 04:27:50 INFO - PROCESS | 2687 | __start_tp_report 04:27:50 INFO - PROCESS | 2687 | _x_x_mozilla_page_load 04:27:50 INFO - PROCESS | 2687 | _x_x_mozilla_page_load_details 04:27:50 INFO - PROCESS | 2687 | |i|pagename|runs| 04:27:50 INFO - PROCESS | 2687 | |0;ai-astar;107;116;116;116;116;116;115;117;117;115 04:27:50 INFO - PROCESS | 2687 | |1;audio-beat-detection;159;131;131;176;129;129;129;130;181;136 04:27:50 INFO - PROCESS | 2687 | |2;audio-dft;160;161;161;161;163;163;163;162;162;161 04:27:50 INFO - PROCESS | 2687 | |3;audio-fft;76;76;76;115;77;77;77;77;110;76 04:27:50 INFO - PROCESS | 2687 | |4;audio-oscillator;85;84;130;83;83;83;105;83;83;118 04:27:50 INFO - PROCESS | 2687 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 04:27:50 INFO - PROCESS | 2687 | |6;imaging-darkroom;149;147;146;146;147;146;147;146;146;147 04:27:50 INFO - PROCESS | 2687 | |7;imaging-desaturate;95;95;96;95;96;95;95;95;95;95 04:27:50 INFO - PROCESS | 2687 | |8;json-parse-financial;63;62;63;62;62;63;63;63;63;64 04:27:50 INFO - PROCESS | 2687 | |9;json-stringify-tinderbox;66;65;66;66;67;66;66;67;67;66 04:27:50 INFO - PROCESS | 2687 | |10;stanford-crypto-aes;94;87;91;84;84;85;85;84;85;85 04:27:50 INFO - PROCESS | 2687 | |11;stanford-crypto-ccm;152;147;140;142;143;143;143;156;234;141 04:27:50 INFO - PROCESS | 2687 | |12;stanford-crypto-pbkdf2;180;178;184;180;179;180;178;180;181;183 04:27:50 INFO - PROCESS | 2687 | |13;stanford-crypto-sha256-iterative;68;71;71;69;71;70;69;69;72;69 04:27:50 INFO - PROCESS | 2687 | __end_tp_report 04:27:50 INFO - PROCESS | 2687 | __start_cc_report 04:27:50 INFO - PROCESS | 2687 | _x_x_mozilla_cycle_collect,1969 04:27:50 INFO - PROCESS | 2687 | __end_cc_report 04:27:50 INFO - PROCESS | 2687 | __startTimestamp1479299270345__endTimestamp 04:27:50 INFO - PROCESS | 2687 | 04:27:50 INFO - PROCESS | 2687 | ------- Summary: start ------- 04:27:50 INFO - PROCESS | 2687 | Number of tests: 14 04:27:50 INFO - PROCESS | 2687 | 04:27:50 INFO - PROCESS | 2687 | [#0] ai-astar Cycles:10 Average:115.10 Median:116.00 stddev:2.92 (2.5%) stddev-sans-first:0.71 04:27:50 INFO - PROCESS | 2687 | Values: 107.0 116.0 116.0 116.0 116.0 116.0 115.0 117.0 117.0 115.0 04:27:50 INFO - PROCESS | 2687 | 04:27:50 INFO - PROCESS | 2687 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:133.50 stddev:20.77 (15.6%) stddev-sans-first:21.22 04:27:50 INFO - PROCESS | 2687 | Values: 159.0 131.0 131.0 176.0 129.0 129.0 129.0 130.0 181.0 136.0 04:27:50 INFO - PROCESS | 2687 | 04:27:50 INFO - PROCESS | 2687 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:0.93 04:27:50 INFO - PROCESS | 2687 | Values: 160.0 161.0 161.0 161.0 163.0 163.0 163.0 162.0 162.0 161.0 04:27:50 INFO - PROCESS | 2687 | 04:27:50 INFO - PROCESS | 2687 | [#3] audio-fft Cycles:10 Average:83.70 Median:76.50 stddev:15.23 (19.9%) stddev-sans-first:15.90 04:27:50 INFO - PROCESS | 2687 | Values: 76.0 76.0 76.0 115.0 77.0 77.0 77.0 77.0 110.0 76.0 04:27:50 INFO - PROCESS | 2687 | 04:27:50 INFO - PROCESS | 2687 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:83.00 stddev:17.57 (21.2%) stddev-sans-first:18.35 04:27:50 INFO - PROCESS | 2687 | Values: 85.0 84.0 130.0 83.0 83.0 83.0 105.0 83.0 83.0 118.0 04:27:50 INFO - PROCESS | 2687 | 04:27:50 INFO - PROCESS | 2687 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:27:50 INFO - PROCESS | 2687 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 04:27:50 INFO - PROCESS | 2687 | 04:27:50 INFO - PROCESS | 2687 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.95 (0.6%) stddev-sans-first:0.53 04:27:50 INFO - PROCESS | 2687 | Values: 149.0 147.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 147.0 04:27:50 INFO - PROCESS | 2687 | 04:27:50 INFO - PROCESS | 2687 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:27:50 INFO - PROCESS | 2687 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 04:27:50 INFO - PROCESS | 2687 | 04:27:50 INFO - PROCESS | 2687 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 04:27:50 INFO - PROCESS | 2687 | Values: 63.0 62.0 63.0 62.0 62.0 63.0 63.0 63.0 63.0 64.0 04:27:50 INFO - PROCESS | 2687 | 04:27:50 INFO - PROCESS | 2687 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 04:27:50 INFO - PROCESS | 2687 | Values: 66.0 65.0 66.0 66.0 67.0 66.0 66.0 67.0 67.0 66.0 04:27:50 INFO - PROCESS | 2687 | 04:27:50 INFO - PROCESS | 2687 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:85.00 stddev:3.41 (4.0%) stddev-sans-first:2.24 04:27:50 INFO - PROCESS | 2687 | Values: 94.0 87.0 91.0 84.0 84.0 85.0 85.0 84.0 85.0 85.0 04:27:50 INFO - PROCESS | 2687 | 04:27:50 INFO - PROCESS | 2687 | [#11] stanford-crypto-ccm Cycles:10 Average:154.10 Median:145.00 stddev:28.54 (19.7%) stddev-sans-first:30.26 04:27:50 INFO - PROCESS | 2687 | Values: 152.0 147.0 140.0 142.0 143.0 143.0 143.0 156.0 234.0 141.0 04:27:50 INFO - PROCESS | 2687 | 04:27:50 INFO - PROCESS | 2687 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.30 Median:180.00 stddev:1.95 (1.1%) stddev-sans-first:2.06 04:27:50 INFO - PROCESS | 2687 | Values: 180.0 178.0 184.0 180.0 179.0 180.0 178.0 180.0 181.0 183.0 04:27:50 INFO - PROCESS | 2687 | 04:27:50 INFO - PROCESS | 2687 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.50 stddev:1.29 (1.8%) stddev-sans-first:1.17 04:27:50 INFO - PROCESS | 2687 | Values: 68.0 71.0 71.0 69.0 71.0 70.0 69.0 69.0 72.0 69.0 04:27:50 INFO - PROCESS | 2687 | -------- Summary: end -------- 04:27:50 INFO - PROCESS | 2687 | 04:27:51 INFO - TEST-INFO | 2687: exit 0 04:27:51 INFO - TEST-OK | kraken | took 66012ms 04:27:51 INFO - SUITE-END | took 1191s 04:27:52 INFO - Completed test suite (00:19:51) 04:27:52 INFO - javascript benchmark 04:27:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2610.621459888316, 2632.3813903732607, 2650.960235596466, 2664.547027005409, 2676.130257666258, 4631.282151266559, 4672.2057250267535, 4718.976405117974, 4764.356811830402, 4768.570828625423, 4702.647301452396, 4734.3135245389485, 4738.881527961803, 4765.666403351766, 4816.386510518972, 4288.6140247377725, 4303.892402689942, 4340.327249276367, 4389.122175564884, 4392.516823149451, 4003.3194356959243, 4390.67069969752, 4409.691321607489, 4435.645148388137, 4466.285394336906, 4249.3413520904305, 4396.802143903532, 4399.36209249657, 4404.537523560028, 4484.932726009096, 4281.12236991416, 4297.247981603238, 4331.242032644306, 4352.673549483769, 4355.281378572532, 4353.934690979638, 4354.107407981356, 4359.04101097758, 4391.451068616423, 4413.183561041185, 4727.976360118212, 4738.384010078702, 4760.809567617292, 4764.071006153801, 4764.237721964504, 4855.514448555152, 4900.289458028566, 4900.803967841282, 4989.151844186497, 5072.34059572257, 5028.170351891933, 5096.9490305097215, 5099.694018358948, 5147.510986456318, 5151.459096794858, 4739.95260047402, 4740.312654665123, 4742.146413645577, 4745.0, 4786.832460863922, 4965.280034395065, 5010.423801262901, 5186.118359878829, 5190.455002224788, 5242.606804489678, 4852.563269305709, 4936.703797772145, 5057.367829021372, 5073.340465739504, 5074.314967479343, 5080.720560369141, 5093.847184584469, 5096.9490305097215, 5097.1844504879045, 5142.537171654569, 5002.774875130628, 5036.521530454675, 5063.518965698253, 5073.644844860824, 5073.949260507421, 4874.147024270738, 4915.311856340115, 4917.926231106536, 5001.24981252815, 5004.024215277986, 4330.610245077895, 4339.175556644227, 4345.217860785026, 4369.541198174209, 4401.581849724271, 3778.5843557208686, 3791.976166435102, 3797.316483033025, 3828.502294701671, 3832.7125465590193, 4238.682098842599, 4379.540148284448, 4383.693141480066, 4386.407834942242, 4431.512533621299, 4931.50684931504, 4958.231474121445, 4990.251462280615, 4995.250712393097, 5026.0, 4331.4152589400655, 4332.263515202423, 4339.696221264544, 4368.5194628590825, 4373.562643735601, 4554.863354099382, 4557.361969324364, 4559.293309537027, 4567.908641827211, 4571.794269257892, 4582.908341833211, 4618.399608051066, 4620.792064357045, 4648.65135114861, 4658.487566367629, 4999.77501012448, 5083.949160508348, 5092.465291144376, 5128.153854614096, 5141.511556402136, 4733.715977041388, 4740.502247263988, 4741.146593613044, 4742.691725037862, 4793.664443488922, 4774.880627984328, 4802.399700037496, 4983.975080124576, 4984.975075124601, 5036.093503169464, 5032.84901452957, 5073.44192138857, 5080.339555857715, 5131.512506311894, 5179.300794392709, 4963.553280204799, 4973.726445045557, 4974.104661160881, 4975.577075948585, 5021.623378246573, 4699.906001880012, 4717.858464246078, 4980.402351717672, 4992.900141997067, 4993.950060499348, 4772.880677983078, 4784.736839473862, 4790.592799611933, 4849.830255941025, 4898.559129678346, 4935.605151587936, 4948.010397920359, 4950.504949505021, 4953.678010929278, 4998.850034498971, 4684.578387944965, 4733.124371991193, 4739.099571081483, 4862.732549709658, 4873.049755297683], "value": 4635.388365003641, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.8917960997605, 568.4088547910173, 583.47195787812, 584.4564554963885, 595.7706283081012, 27775.722242777567, 30274.091777246664, 30276.394472110544, 30316.09051728449, 30358.392832143345, 38742.8062859686, 40369.59630403695, 40431.0, 43848.3422748659, 44251.33622995658, 7382.926170738291, 7437.0, 7496.13794413644, 7514.2485751424965, 7518.548887066766, 7524.2851929066655, 7592.088949326061, 7592.126905405866, 7593.544387336749, 7598.886016709726, 7598.240175982412, 7630.198829122945, 7633.503822251536, 7639.503432276912, 7646.770596882103, 7546.245375462465, 7574.545527268381, 7582.5829579373385, 7593.430492713013, 7599.810004749926, 7478.775636730852, 7492.587907665076, 7540.547567145989, 7541.132769731496, 7543.7359692411055, 35194.64805351939, 35654.28691426157, 35674.8216258917, 35701.64298357035, 35704.10739731501, 2892.566115082733, 3117.9064628061196, 3228.402745492068, 3472.0972547137926, 3528.329617372691, 27645.447091058268, 28042.298942526395, 28162.577561336595, 28190.577141342896, 28370.148895533166, 3405.9318813623836, 3487.2676737885076, 3520.4015317396106, 3553.34263161316, 3585.8027808470524, 229607.0, 230277.0, 231598.0, 232280.0, 232283.0, 50896.23655645168, 51114.48885511172, 51147.48852511427, 51193.23210151851, 51218.23172652339, 53842.73078634582, 54018.45981540213, 54035.18947215795, 54055.45944540583, 54149.45850541444, 14515.782263266059, 14780.260986950609, 14785.852141478448, 14790.852091479162, 14798.0, 10941.398223097805, 10951.726206844893, 10954.342739435659, 10999.505022274017, 11002.119830413547, 15721.371145154066, 16166.676666466605, 16203.918980405022, 16212.432564860173, 16220.432284869972, 5549.361823390362, 5563.63836350644, 5598.412166722517, 5640.32316122068, 5682.261306030189, 667.6689944410401, 759.7151068349369, 832.5421018439833, 836.7740710008263, 916.5234078279258, 25185.0, 27178.0, 27232.727672723417, 27312.72687273102, 27369.863150684516, 785.8821176823408, 921.7787730944525, 1003.1623594298842, 1005.1606908231709, 1021.8671572695501, 14580.1980891052, 15606.0, 15705.921470392575, 16280.918595406947, 16464.586463538075, 341957.0, 344312.0, 345722.0, 345770.0, 351694.0, 49585.75207123941, 49586.50413495819, 49633.0, 49664.0, 49835.0, 1047.6961681112543, 1104.3870651788334, 1142.971425714347, 1189.851268591426, 1229.9938500307442, 26306.73693263043, 28093.859530702215, 28805.85597072001, 28834.27914302159, 28861.711382885904, 40500.79749601233, 40966.79516602517, 40990.38514422346, 41056.79471602623, 41113.79443102765, 275221.0, 278312.0, 279160.0, 279502.0, 280168.0, 23869.64195537103, 23960.28119156428, 24865.502689945737, 24903.501929960938, 26192.73807261979, 39513.674788662356, 39530.40704389379, 39860.601393985686, 40195.79902100588, 40708.389374160004, 34271.65728342784, 34552.654473454946, 34702.65297346994, 34736.0, 34748.0, 34172.65827341794, 34609.30781384408, 34852.30295394129, 34983.65016349804, 35716.64283357237, 33610.15974600557, 33856.83071584626, 33918.83040584781, 34031.48952765661, 34952.475712863816, 29941.0, 31545.36909261848, 31714.20714482064, 31936.52095218527, 31947.36105277835, 23889.880550597136, 24371.75628243695, 24383.878080609484, 24769.25692229236, 24908.37729056788], "value": 16761.27157164643, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.168977832758, 351.8698081709769, 364.7865998390941, 371.6803548947904, 376.8210100202404, 12536.185147965387, 13157.802632960513, 13392.59822205333, 16096.275667594957, 16121.677566448694, 14870.256487175651, 14886.543720286167, 14891.106533607992, 14927.477538286163, 15259.618509537268, 4805.279208118775, 5018.723970181639, 5022.04581129586, 5023.974880125595, 5029.647924645276, 3698.3712768829228, 3912.4326972588956, 5557.166425036256, 5748.511376532979, 5784.2769653793275, 5595.104783234683, 5858.062709966406, 5861.472467477926, 5863.2670916135485, 5867.090600956859, 5731.312242530881, 5760.423957604248, 5819.068948968187, 5858.326292476378, 5863.976927959847, 4877.34155888954, 4940.777665005084, 5177.326947496801, 5179.326687530597, 5187.688738675692, 19423.0, 19594.902025489922, 19713.40859774209, 19730.21079156832, 19909.402717918485, 1799.5231263715125, 1814.718718598606, 1875.1842948317526, 1959.2848610257154, 2461.716902556211, 12442.253464792142, 12473.875261247453, 12697.619071427873, 12992.870071299356, 13275.800862987064, 1620.3437607768872, 1699.8640108791267, 1727.6890159771235, 1767.2489192093308, 1800.9639807203914, 65333.673331633516, 66764.3323566763, 67671.323286767, 68974.65512672404, 69576.0, 9565.0, 9612.231021518262, 9768.07203315684, 9954.517211383125, 10070.439081942312, 13576.660583485493, 13599.320033998261, 13604.727905441836, 13606.38771255296, 13626.046176767532, 7013.333733295329, 7177.6770045348085, 7208.207097219301, 7277.345038946414, 7308.086489188851, 6844.076049733222, 6948.895766563505, 7001.579905205602, 7138.214796372395, 7183.964080179566, 4157.563455837154, 4241.936370954438, 4258.318669012943, 4276.700630955803, 4408.470983482002, 1751.2644689230553, 1793.3454289184615, 1793.4709260768104, 1812.1392338639305, 1829.5609053826986, 689.6930865764787, 814.311906439058, 825.5748289630845, 834.3783881008566, 875.0330884372804, 15957.920210399107, 16389.83610163883, 16912.661746764996, 17168.39910603148, 17305.826941730422, 824.2499325613662, 853.7097386888488, 854.457419538585, 872.0799556467987, 874.0603850860224, 8843.60203790831, 8923.196912277926, 9372.437653740797, 9375.249980001583, 9470.57382417779, 363989.12184928625, 368440.0, 372192.0, 383456.0, 391642.0, 77863.0, 81245.0, 82162.0, 82249.17750822534, 82957.58521207355, 879.4064006795387, 881.5283823154582, 919.1543779722671, 927.2118699105706, 929.5120061967522, 15197.696046079238, 15206.695866082837, 15951.68096638084, 16086.597835054217, 16230.756538651693, 35786.64213357833, 35966.640333597374, 36376.907232987935, 36756.632433676394, 36875.26249474942, 45455.772721136185, 48883.0, 49386.753066234436, 49608.50391496039, 49621.25568116409, 6500.187476565429, 6693.0, 6779.525433219627, 7044.0, 7720.7683769487, 10856.882907832896, 11136.554537818396, 11152.16358773079, 11293.830592541282, 11713.355765432983, 9694.418334899929, 9893.65372211969, 9896.15882649954, 9911.553980071058, 10553.63062292816, 5180.637355385087, 5449.64577302474, 9693.41839489633, 9711.708648740549, 10611.2041596879, 9169.490009836249, 9648.71053868385, 9954.950225248827, 9969.950150249202, 10191.082802547806, 6597.307282735435, 6767.661616919036, 6774.491913106438, 6777.728890844311, 6956.513044086865, 7784.143744188248, 9334.2999275056, 9816.705498835046, 10069.345492542961, 10208.438535880598], "value": 7997.121711676222, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.489094144225, 1362.4958765256854, 1432.1693417817667, 1658.7760652311933, 1664.109701309798, 6098.603590766597, 6292.496600271978, 6489.578177418471, 6880.655967201645, 6936.861262774748, 6490.480761539077, 6730.49521285903, 6747.224069232027, 6901.344372284638, 6911.101556797622, 2008.2770202727042, 2040.479677682189, 2042.4077017664858, 2042.4893776555862, 2051.1795281887216, 1750.2473936207425, 1819.672458957387, 1966.2135145941595, 1987.0859404673868, 1997.8501612379057, 1954.5211423201335, 2016.67733162694, 2021.4643119573325, 2041.4896275931017, 2048.150017742635, 2007.9196832126697, 2025.422754514956, 2045.3659365596639, 2047.3141497598322, 2051.138521820839, 1973.1219607274768, 2017.778044415113, 2020.1515363547198, 2020.8383329333617, 2026.4224695961727, 6851.623160726208, 6886.862262754767, 6907.0, 6936.514443988923, 6949.89575156373, 3943.3887747398912, 4117.341225403921, 4122.113745544722, 4127.318992366256, 4129.091599848029, 2470.3330100872845, 2742.766864816493, 2744.382513934369, 2752.1881045091545, 2753.917382478529, 778.532880271838, 815.7185770909027, 846.3736834742308, 847.2163248994656, 847.267113946438, 8775.47347159166, 8834.249088827457, 8855.981562120438, 8876.245519130882, 8888.777780555472, 3526.994806480141, 3700.3339398908456, 3739.1491211850307, 3789.2610940866266, 3799.696024318048, 7912.920870791334, 7919.960400197962, 7934.20657934202, 7938.166492518318, 7946.801329966797, 4058.0057885818164, 4085.7957102144774, 4093.7543747375253, 4117.835286588503, 4121.258173528794, 3699.0567405312013, 3775.679067279257, 3786.3941769316775, 3788.109794198361, 3790.6209379062425, 3170.571972783691, 3228.4511633022444, 3234.8059116453087, 3286.622038465607, 3293.604767427876, 932.3240650528448, 970.088117169858, 1031.4636389077637, 1038.6209033702796, 1058.264506168221, 746.3730466408243, 747.4805010517747, 820.2699597358355, 822.617482870468, 877.7059685005466, 4806.975965120152, 4807.807687692523, 4876.853939324256, 4990.0, 5026.924596131061, 819.9467034642848, 841.293313616565, 841.7769291137853, 870.5821205821242, 875.2604049578097, 3403.1832360233366, 3430.2624935638955, 3430.3139372125675, 3432.7768695034742, 3524.7708898921487, 7841.137474877759, 8271.0, 8281.585920703941, 8291.08798032216, 8302.418830681794, 8255.463394879314, 8286.129956354616, 8288.295494883003, 8298.958505207434, 8309.45988510757, 6423.614583125028, 6492.0, 6524.543281970216, 6552.115464412243, 6557.606543607399, 4737.336772851734, 4739.881502962316, 4784.976075119602, 4789.640776941813, 4898.804047838046, 7475.925240747523, 7573.772786816405, 7574.848503030019, 7587.544747314958, 7597.2022937592965, 7224.024756657994, 7529.698812047457, 7549.282818132268, 7672.232776722283, 7680.308772210305, 6003.489703375088, 6059.72731227087, 6060.303065147565, 6076.240469941257, 6089.665068421279, 6359.109724638462, 6375.203099612549, 6389.744410223539, 6421.454176395058, 6428.228612566522, 5080.237964305384, 5828.154917536848, 5951.791687290924, 6016.488598469179, 6034.24571928509, 5948.078047902582, 5961.105834124916, 6031.849203769941, 6045.637261764308, 6089.847753806191, 5518.724063796874, 5576.163575463551, 5652.971735141298, 5653.915191272052, 5667.20659107717, 4049.8177582008293, 4050.311447053949, 4117.300058989919, 4140.60664236897, 4258.680598955153, 4032.516098068251, 4098.176311541335, 4137.110521237948, 4216.45186125814, 4243.596858298457], "value": 3709.7747677584534, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.47792690048254, 297.8600057972753, 302.3258134360376, 307.21046909442714, 307.26256983240233, 4796.328514008042, 4842.2252439609665, 4847.684900481467, 4847.927281090787, 4874.390701162355, 4777.331173635694, 4784.16277151498, 4802.279658051285, 4808.759562021903, 4816.662833601649, 3822.140018495837, 3825.9426108608395, 3829.5978922213185, 3834.482344883447, 3847.2882516734494, 3706.2031663192406, 3839.117003089277, 3856.9228615427674, 3862.575116737157, 3871.3805791073432, 3746.438034294864, 3785.5457345118625, 3794.981025094871, 3801.6999715172337, 3804.448354988525, 3781.3949768036982, 3783.016415731902, 3784.8675296364495, 3799.4490798834154, 3800.2969450651717, 3085.891993780207, 3141.7172454479205, 3224.6130464344196, 3385.4752513360468, 3392.9830350848333, 4624.260118381043, 4630.467496237942, 4634.83778067766, 4644.535546445362, 4652.325412815123, 4286.421333120051, 4294.227039132955, 4298.570142985708, 4298.699091063627, 4303.0421158372865, 4621.0, 4749.881252968704, 5002.7498625068965, 5014.24786282057, 5027.572656324217, 3605.94591081134, 3619.0, 3621.5110960020324, 3622.728295377857, 3630.9273814523826, 5202.791888324463, 5206.817761378372, 5217.8173763918085, 5231.921521177185, 5234.659747116425, 3595.5146055282203, 3660.4875317455576, 3700.9814950925074, 3729.1236559408517, 3737.7757334560015, 3686.612905644922, 3712.8514859405864, 3720.534933133358, 3726.6087060858763, 3727.5713292971113, 4187.027210680451, 4188.350805625133, 4190.580941905785, 4227.704060715781, 4235.576442355739, 4960.677555958923, 4968.850934471971, 4973.278874563168, 5025.221090730943, 5028.396592408862, 1198.6523908066738, 1221.1940119521073, 1222.8471441069867, 1222.9299363057326, 1234.2039384596885, 832.3840358134937, 879.5821984557284, 891.595736714664, 897.1342654338464, 899.3479727197729, 4223.894402639959, 4251.6386107180615, 4289.91420171601, 4316.395704601358, 4332.393464914914, 4966.577840883565, 4970.2793095001025, 4971.602271818246, 4982.252662100714, 5002.424721157041, 4241.533431322552, 4256.659152366995, 4273.914521709548, 4280.828766849353, 4289.442372491556, 2525.8863351149243, 2619.4630100829286, 2637.3011152044724, 2645.708972013077, 2646.523625747384, 4596.977015114903, 4636.675432719745, 4666.0, 4708.705106095851, 4849.563539281482, 5266.92099618506, 5273.86611878448, 5277.234800953917, 5281.894362112813, 5294.655847369909, 4838.056578967067, 4838.685485443435, 4842.58837998774, 4845.0, 4852.466228714909, 5021.573166280907, 5145.639805213599, 5170.1727723564045, 5177.326947496801, 5191.402988656202, 5094.828189516358, 5096.986690257401, 5124.769385377593, 5130.896857175725, 5130.97434512825, 4848.3454733610515, 4863.927041094457, 4864.416270047475, 4869.951300487091, 4879.316895634685, 3380.239446124602, 3585.0, 3607.837647305825, 3622.673959343672, 3627.528421305213, 5123.257127716534, 5134.922976155286, 5142.665726727751, 5146.485351464824, 5150.381954165524, 5014.7994080236385, 5017.874553136201, 5023.57299629521, 5044.899102018013, 5046.444891061907, 4882.804687812448, 4942.357493525818, 4956.851294461172, 4993.15116430215, 4997.450280469218, 4875.366202393666, 4880.19388851419, 4880.243562247857, 4881.755912204305, 4884.291777692286, 5005.274235235943, 5008.57427118699, 5011.473795251446, 5027.838029647287, 5037.949620503748, 4801.4958429365815, 4888.213718180603, 4903.877403064952, 4919.483454237254, 4929.630277729257], "value": 3766.8204377536663, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.4399496458224, 623.3454872383995, 629.3046183966717, 721.2111579114679, 743.5538676793923, 11680.649580512598, 11725.355105469196, 11736.589219377323, 11762.353070581124, 11781.528738850446, 12120.757584848297, 12327.815082773766, 12334.074944379163, 12357.691057723561, 12369.319687417188, 621.4934828115095, 638.4445532386829, 753.2279413601075, 762.3063012658482, 762.321533834886, 765.5291995422831, 766.8274638206386, 767.3209209849268, 768.0131031624364, 768.06679883941, 821.1296026212204, 821.8520666280067, 822.3585603229491, 822.5106061893194, 823.0247157118804, 656.8095252376805, 674.912261406019, 675.0818886314609, 678.1590827374021, 822.0, 494.332650921257, 582.5456144207525, 596.0195478437988, 597.3309892919914, 599.4245524296681, 12070.396480176043, 12072.336021518813, 12137.514499420013, 12140.210886292363, 12185.695357616041, 11417.771644567145, 11586.304821710724, 11609.0, 11910.225835320764, 12277.447514861853, 10778.892211077868, 10875.78248435027, 10896.346219226793, 11458.94270528642, 11908.58319958806, 4041.171559830257, 4063.471748672683, 4075.7758323292205, 4079.347304431277, 4188.643965262956, 48798.756006220094, 49032.50967490315, 49272.0, 49296.75351623219, 49602.0, 10025.949870250603, 10123.0, 10170.593176272867, 10173.135283500986, 10363.481825908826, 17651.205695743723, 17679.116044197737, 17683.469495915142, 17721.379751708886, 17837.28650853977, 6329.113924050636, 6380.585261957958, 6397.264314603787, 6416.262129855033, 6676.599404035774, 3404.8467818948207, 3423.726101911841, 3462.0306314232057, 3483.5819701635965, 3486.7198600940014, 2674.211107723226, 2732.8360298382163, 2755.3662657588866, 2755.4902343066597, 2767.5986981887513, 451.57551901212753, 455.12388651845066, 460.0316334116703, 465.2555910543104, 471.08139128699173, 461.79911738393906, 482.22602722630376, 501.8795489082594, 520.5159201942155, 539.0001547130096, 6782.966085169543, 6797.796066118024, 6804.55770374924, 7051.471139664545, 7125.42996560274, 469.45543169922723, 491.2459374859573, 508.0347340053927, 515.0754395859441, 553.0487561394395, 3044.1932887784756, 3094.3965926644087, 3098.380323935177, 3137.6862313768443, 3389.406853800575, 67873.66063169652, 69976.0, 70512.64743676351, 71034.64482677553, 72263.63868180626, 38593.807030964665, 42997.57002429998, 63863.68068159629, 63920.36079639144, 66292.33707662861, 58913.41086589165, 59444.70277648671, 59601.40398595959, 59603.701981489816, 59709.0, 6238.625682459067, 6439.903401449075, 6493.512986525935, 6554.410103090745, 6708.127943367331, 31611.525827112153, 39611.0, 39675.80162099171, 40463.797681011405, 41330.0, 31075.844620776752, 36339.45490817587, 52386.73806630942, 52815.73592132015, 54048.45951540434, 8644.265237454636, 8754.124587541195, 8844.248238899509, 9136.08639136081, 9330.066993300616, 9166.0, 9227.861582076408, 9468.905310946802, 9593.904060959301, 10033.046860548237, 8591.355648326275, 8790.95604521999, 8798.47209167452, 9015.909840901508, 9028.277737781093, 8946.68686595966, 9305.0, 9344.486053267136, 9724.659636912675, 9725.513724313614, 8580.184882436159, 8593.269572086443, 8677.045524992373, 8864.42381245217, 9079.591418386057, 7473.780369096457, 7476.792998002608, 7796.961015194887, 7802.219778022152, 7991.219536531172, 7557.395408367427, 8255.812209764297, 8650.524221167896, 9361.906380936103, 9537.236524657023], "value": 5706.70773056363, "unit": "score"}], "name": "dromaeo_css", "value": 6060.585023778451, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 116.0, 116.0, 116.0, 116.0, 115.0, 117.0, 117.0, 115.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 131.0, 131.0, 176.0, 129.0, 129.0, 129.0, 130.0, 181.0, 136.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 163.0, 163.0, 163.0, 162.0, 162.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 115.0, 77.0, 77.0, 77.0, 77.0, 110.0, 76.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 130.0, 83.0, 83.0, 83.0, 105.0, 83.0, 83.0, 118.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 62.0, 63.0, 63.0, 63.0, 63.0, 64.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0, 67.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 87.0, 91.0, 84.0, 84.0, 85.0, 85.0, 84.0, 85.0, 85.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 147.0, 140.0, 142.0, 143.0, 143.0, 143.0, 156.0, 234.0, 141.0], "value": 154.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 178.0, 184.0, 180.0, 179.0, 180.0, 178.0, 180.0, 181.0, 183.0], "value": 180.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 71.0, 69.0, 71.0, 70.0, 69.0, 69.0, 72.0, 69.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1575.8, "alertThreshold": 2.0}]} 04:27:52 INFO - Return code: 0 04:27:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:27:52 INFO - # TBPL SUCCESS # 04:27:52 INFO - Running post-action listener: _resource_record_post_action 04:27:52 INFO - [mozharness: 2016-11-16 12:27:52.158123Z] Finished run-tests step (success) 04:27:52 INFO - Running post-run listener: _resource_record_post_run 04:27:52 INFO - Total resource usage - Wall time: 1208s; CPU: 13.0%; Read bytes: 4096; Write bytes: 405524480; Read time: 12; Write time: 523760 04:27:52 INFO - TinderboxPrint: CPU usage
13.1% 04:27:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:27:52 INFO - TinderboxPrint: I/O write bytes / time
405,524,480 / 523,760 04:27:52 INFO - TinderboxPrint: CPU idle
8,377.8 (86.9%) 04:27:52 INFO - TinderboxPrint: CPU user
1,207.3 (12.5%) 04:27:52 INFO - TinderboxPrint: Swap in / out
0 / 0 04:27:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 99921920; Read time: 0; Write time: 181152 04:27:52 INFO - run-tests - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 288854016; Read time: 0; Write time: 337464 04:27:52 INFO - Running post-run listener: _upload_blobber_files 04:27:52 INFO - Blob upload gear active. 04:27:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:27:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:27:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:27:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:27:53 INFO - (blobuploader) - INFO - Open directory for files ... 04:27:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:27:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:27:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:56 INFO - (blobuploader) - INFO - Done attempting. 04:27:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:27:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:27:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:57 INFO - (blobuploader) - INFO - Done attempting. 04:27:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:27:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:27:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:57 INFO - (blobuploader) - INFO - Done attempting. 04:27:57 INFO - (blobuploader) - INFO - Iteration through files over. 04:27:57 INFO - Return code: 0 04:27:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:27:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:27:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/47ce5c05e2f0409d87731d280bf83ea362275d0ffd2302bad21ce436d94184aad06fad80b04f78daccb8654e3848c36e073140a5ab3242aa1347d1fae5c476a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e873feb46868e832326bd827f4ad3993ee5315c5a6f31d004c48a1f03bbaff903dc1d788a6e9907011edab4e549764f0d0f213d3812044aa3e86ccf1422fcef4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/22220bf9f4efb20dedc36e312daa8611b2820e057c771b8bf95f9f8143b29c9481b97a619c58c3543dffa9c9d119d97971976a136d2ea2f669e513ecf6df2813"} 04:27:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:27:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:27:57 INFO - Contents: 04:27:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/47ce5c05e2f0409d87731d280bf83ea362275d0ffd2302bad21ce436d94184aad06fad80b04f78daccb8654e3848c36e073140a5ab3242aa1347d1fae5c476a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e873feb46868e832326bd827f4ad3993ee5315c5a6f31d004c48a1f03bbaff903dc1d788a6e9907011edab4e549764f0d0f213d3812044aa3e86ccf1422fcef4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/22220bf9f4efb20dedc36e312daa8611b2820e057c771b8bf95f9f8143b29c9481b97a619c58c3543dffa9c9d119d97971976a136d2ea2f669e513ecf6df2813"} 04:27:57 INFO - Running post-run listener: copy_logs_to_upload_dir 04:27:57 INFO - Copying logs to upload dir... 04:27:57 INFO - mkdir: /builds/slave/test/build/upload/logs 04:27:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.061767 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-11-16 04:27:57.649558) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 04:27:57.652855) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1479297784.427762-2080687394 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/47ce5c05e2f0409d87731d280bf83ea362275d0ffd2302bad21ce436d94184aad06fad80b04f78daccb8654e3848c36e073140a5ab3242aa1347d1fae5c476a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e873feb46868e832326bd827f4ad3993ee5315c5a6f31d004c48a1f03bbaff903dc1d788a6e9907011edab4e549764f0d0f213d3812044aa3e86ccf1422fcef4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/22220bf9f4efb20dedc36e312daa8611b2820e057c771b8bf95f9f8143b29c9481b97a619c58c3543dffa9c9d119d97971976a136d2ea2f669e513ecf6df2813"} build_url:https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011453 build_url: 'https://queue.taskcluster.net/v1/task/ToxiDx5cRcqe1GUaXm4DMg/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/Cedar/sha512/47ce5c05e2f0409d87731d280bf83ea362275d0ffd2302bad21ce436d94184aad06fad80b04f78daccb8654e3848c36e073140a5ab3242aa1347d1fae5c476a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e873feb46868e832326bd827f4ad3993ee5315c5a6f31d004c48a1f03bbaff903dc1d788a6e9907011edab4e549764f0d0f213d3812044aa3e86ccf1422fcef4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/22220bf9f4efb20dedc36e312daa8611b2820e057c771b8bf95f9f8143b29c9481b97a619c58c3543dffa9c9d119d97971976a136d2ea2f669e513ecf6df2813"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 04:27:57.685936) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 04:27:57.686507) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1479297784.427762-2080687394 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004685 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 04:27:57.742937) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 04:27:57.743738) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 04:27:57.744304) ========= ========= Total master_lag: 0.15 =========