builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1479153304.12 results: success (0) buildid: 20161114081542 builduid: c0b4dd1356ae41cf97e49288305ed2d3 revision: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:04.121637) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:04.122105) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:04.122397) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:04.137867) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:04.138224) ========= 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=6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-14 11:55: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.9M=0s 2016-11-14 11:55:04 (24.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132069 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:04.302486) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:04.302929) ========= 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=6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018316 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:04.352455) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:04.352914) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d --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=6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-14 11:55:04,406 truncating revision to first 12 chars 2016-11-14 11:55:04,406 Setting DEBUG logging. 2016-11-14 11:55:04,406 attempt 1/10 2016-11-14 11:55:04,406 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f11ca24b2382?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 11:55:04,720 unpacking tar archive at: mozilla-aurora-f11ca24b2382/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642515 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:05.009282) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:05.009635) ========= script_repo_revision: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:05.010081) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:05.010362) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:05.019585) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-11-14 11:55:05.020001) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:55:05 INFO - MultiFileLogger online at 20161114 11:55:05 in /builds/slave/test 11:55:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:55:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:55:05 INFO - {'append_to_log': False, 11:55:05 INFO - 'base_work_dir': '/builds/slave/test', 11:55:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:55:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:55:05 INFO - 'branch': 'Mozilla-Aurora', 11:55:05 INFO - 'buildbot_json_path': 'buildprops.json', 11:55:05 INFO - 'config_files': ('talos/linux_config.py',), 11:55:05 INFO - 'default_actions': ('clobber', 11:55:05 INFO - 'read-buildbot-config', 11:55:05 INFO - 'download-and-extract', 11:55:05 INFO - 'populate-webroot', 11:55:05 INFO - 'create-virtualenv', 11:55:05 INFO - 'install', 11:55:05 INFO - 'run-tests'), 11:55:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:55:05 INFO - 'download_minidump_stackwalk': True, 11:55:05 INFO - 'download_symbols': 'ondemand', 11:55:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:55:05 INFO - 'tooltool.py': '/tools/tooltool.py', 11:55:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:55:05 INFO - '/tools/misc-python/virtualenv.py')}, 11:55:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:55:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:55:05 INFO - 'installer_path': 'installer.exe', 11:55:05 INFO - 'log_level': 'info', 11:55:05 INFO - 'log_name': 'talos', 11:55:05 INFO - 'log_to_console': True, 11:55:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:55:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:55:05 INFO - 'opt_config_files': (), 11:55:05 INFO - 'pip_index': False, 11:55:05 INFO - 'sps_profile': False, 11:55:05 INFO - 'sps_profile_interval': 0, 11:55:05 INFO - 'suite': 'dromaeojs', 11:55:05 INFO - 'system_bits': '32', 11:55:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:55:05 INFO - 'title': 'talos-linux64-ix-050', 11:55:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:55:05 INFO - 'use_talos_json': True, 11:55:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:55:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:55:05 INFO - 'work_dir': 'build'} 11:55:05 INFO - [mozharness: 2016-11-14 19:55:05.273095Z] Running clobber step. 11:55:05 INFO - Running pre-action listener: _resource_record_pre_action 11:55:05 INFO - Running main action method: clobber 11:55:05 INFO - rmtree: /builds/slave/test/build 11:55:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:55:05 INFO - Running post-action listener: _resource_record_post_action 11:55:05 INFO - [mozharness: 2016-11-14 19:55:05.681278Z] Finished clobber step (success) 11:55:05 INFO - [mozharness: 2016-11-14 19:55:05.681377Z] Running read-buildbot-config step. 11:55:05 INFO - Running pre-action listener: _resource_record_pre_action 11:55:05 INFO - Running main action method: read_buildbot_config 11:55:05 INFO - Using buildbot properties: 11:55:05 INFO - { 11:55:05 INFO - "project": "", 11:55:05 INFO - "product": "firefox", 11:55:05 INFO - "script_repo_revision": "production", 11:55:05 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:55:05 INFO - "repository": "", 11:55:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:55:05 INFO - "buildid": "20161114081542", 11:55:05 INFO - "pgo_build": "True", 11:55:05 INFO - "basedir": "/builds/slave/test", 11:55:05 INFO - "buildnumber": 596, 11:55:05 INFO - "slavename": "talos-linux64-ix-050", 11:55:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:55:05 INFO - "platform": "ubuntu64_hw", 11:55:05 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:55:05 INFO - "branch": "mozilla-aurora", 11:55:05 INFO - "repo_path": "releases/mozilla-aurora", 11:55:05 INFO - "revision": "f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d", 11:55:05 INFO - "stage_platform": "linux64-pgo", 11:55:05 INFO - "builduid": "c0b4dd1356ae41cf97e49288305ed2d3", 11:55:05 INFO - "slavebuilddir": "test" 11:55:05 INFO - } 11:55:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 11:55:05 INFO - Running post-action listener: _resource_record_post_action 11:55:05 INFO - [mozharness: 2016-11-14 19:55:05.683813Z] Finished read-buildbot-config step (success) 11:55:05 INFO - [mozharness: 2016-11-14 19:55:05.683902Z] Running download-and-extract step. 11:55:05 INFO - Running pre-action listener: _resource_record_pre_action 11:55:05 INFO - Running main action method: download_and_extract 11:55:05 INFO - mkdir: /builds/slave/test/build/tests 11:55: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')]} 11:55:05 INFO - trying https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:55:05 INFO - Downloading https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:55:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:55:06 INFO - Downloaded 1361 bytes. 11:55:06 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:55:06 INFO - Using the following test package requirements: 11:55:06 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 11:55:06 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:55:06 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:55:06 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:06 INFO - u'jsshell-linux-x86_64.zip'], 11:55:06 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:55:06 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 11:55:06 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:55:06 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:55:06 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:55:06 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:55:06 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:55:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 11:55:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:55:06 INFO - Fetch https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:55:06 INFO - Http code: 200 11:55:06 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 11:55:06 INFO - x-amz-cf-id: l5z_FlqbpMWNr9UzdL84LCAGJPDP9NFB_8-upPoVXhJKQicZt3ohfg== 11:55:06 INFO - x-amz-version-id: EYgBEJGJQc1rBPPP1T5gwCWVofHDXC5C 11:55:07 INFO - Expected file size: 21998930 11:55:07 INFO - Obtained file size: 21998930 11:55:11 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:55:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 11:55:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:55:11 INFO - Fetch https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:55:11 INFO - Http code: 200 11:55:11 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 11:55:11 INFO - x-amz-cf-id: oA8ZDe5dnw5FfWh9nhebKA1SvDF4X7VRrnd2cLmjpToF9SfpEZgflQ== 11:55:11 INFO - x-amz-version-id: EYgBEJGJQc1rBPPP1T5gwCWVofHDXC5C 11:55:12 INFO - Expected file size: 21998930 11:55:12 INFO - Obtained file size: 21998930 11:55:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 11:55:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:55:16 INFO - Fetch https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 11:55:17 INFO - Http code: 200 11:55:17 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 11:55:17 INFO - x-amz-cf-id: tqE5X5ziX5elVrjYkBgyQ7NlFWmdOnf2gJ_m4oflOUVyC5WrGY3BKA== 11:55:17 INFO - x-amz-version-id: TSlfhXB2os_hWn6_vAXqk2ibQDA0EcOh 11:55:17 INFO - Expected file size: 14409038 11:55:17 INFO - Obtained file size: 14409038 11:55:17 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')]} 11:55:17 INFO - trying https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:55:17 INFO - Downloading https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:55:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:55:19 INFO - Downloaded 63942402 bytes. 11:55:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:55:19 INFO - mkdir: /builds/slave/test/properties 11:55:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:55:19 INFO - Writing to file /builds/slave/test/properties/build_url 11:55:19 INFO - Contents: 11:55:19 INFO - build_url:https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:55:19 INFO - Running post-action listener: _resource_record_post_action 11:55:19 INFO - Running post-action listener: set_extra_try_arguments 11:55:19 INFO - [mozharness: 2016-11-14 19:55:19.738241Z] Finished download-and-extract step (success) 11:55:19 INFO - [mozharness: 2016-11-14 19:55:19.738466Z] Running populate-webroot step. 11:55:19 INFO - Running pre-action listener: _resource_record_pre_action 11:55:19 INFO - Running main action method: populate_webroot 11:55:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:55:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:55:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:55:19 INFO - '--tppagecycles', 11:55:19 INFO - '7'], 11:55:19 INFO - 'tests': ['tsvgm']}}, 11:55:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:55:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:55:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:55:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:55:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:55:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:55:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:19 INFO - 'talos_options': ['--disable-e10s'], 11:55:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:55:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:55:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:19 INFO - 'talos_options': ['--disable-e10s'], 11:55:19 INFO - 'tests': ['damp', 'tps']}, 11:55:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:19 INFO - 'tests': ['damp', 'tps']}, 11:55:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:55:19 INFO - 'tests': ['dromaeo_dom']}, 11:55:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:55:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:55:19 INFO - 'tests': ['basic_compositor_video']}, 11:55:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:55:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:55:19 INFO - 'tests': ['a11yr', 11:55:19 INFO - 'ts_paint', 11:55:19 INFO - 'tpaint', 11:55:19 INFO - 'sessionrestore', 11:55:19 INFO - 'sessionrestore_no_auto_restore', 11:55:19 INFO - 'tabpaint']}, 11:55:19 INFO - 'other-e10s': {'tests': ['a11yr', 11:55:19 INFO - 'ts_paint', 11:55:19 INFO - 'tpaint', 11:55:19 INFO - 'sessionrestore', 11:55:19 INFO - 'sessionrestore_no_auto_restore', 11:55:19 INFO - 'tabpaint']}, 11:55:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:55:19 INFO - 'ts_paint', 11:55:19 INFO - 'tpaint', 11:55:19 INFO - 'sessionrestore', 11:55:19 INFO - 'sessionrestore_no_auto_restore', 11:55:19 INFO - 'tabpaint']}, 11:55:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:55:19 INFO - 'ts_paint', 11:55:19 INFO - 'tpaint', 11:55:19 INFO - 'sessionrestore', 11:55:19 INFO - 'sessionrestore_no_auto_restore', 11:55:19 INFO - 'tabpaint']}, 11:55:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:55:19 INFO - 'tests': ['a11yr', 11:55:19 INFO - 'ts_paint', 11:55:19 INFO - 'tpaint', 11:55:19 INFO - 'sessionrestore', 11:55:19 INFO - 'sessionrestore_no_auto_restore', 11:55:19 INFO - 'tabpaint']}, 11:55:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:55:19 INFO - 'tests': ['a11yr', 11:55:19 INFO - 'ts_paint', 11:55:19 INFO - 'tpaint', 11:55:19 INFO - 'sessionrestore', 11:55:19 INFO - 'sessionrestore_no_auto_restore', 11:55:19 INFO - 'tabpaint']}, 11:55:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:55:19 INFO - 'tests': ['tsvgx', 11:55:19 INFO - 'tsvgr_opacity', 11:55:19 INFO - 'tart', 11:55:19 INFO - 'tscrollx', 11:55:19 INFO - 'cart']}, 11:55:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:55:19 INFO - 'tsvgr_opacity', 11:55:19 INFO - 'tart', 11:55:19 INFO - 'tscrollx', 11:55:19 INFO - 'cart']}, 11:55:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:19 INFO - 'talos_options': ['--disable-e10s'], 11:55:19 INFO - 'tests': ['tp5o']}, 11:55:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:19 INFO - 'tests': ['tp5o']}, 11:55:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:19 INFO - 'talos_options': ['--disable-e10s', 11:55:19 INFO - '--xperf_path', 11:55:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:55:19 INFO - 'tests': ['tp5n']}, 11:55:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:19 INFO - 'talos_options': ['--xperf_path', 11:55:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:55:19 INFO - 'tests': ['tp5n']}}, 11:55:19 INFO - 'talos.zip': {'path': '', 11:55:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:55:19 INFO - Running post-action listener: _resource_record_post_action 11:55:19 INFO - [mozharness: 2016-11-14 19:55:19.763771Z] Finished populate-webroot step (success) 11:55:19 INFO - [mozharness: 2016-11-14 19:55:19.763866Z] Running create-virtualenv step. 11:55:19 INFO - Running pre-action listener: _resource_record_pre_action 11:55:19 INFO - Running main action method: create_virtualenv 11:55:19 INFO - Creating virtualenv /builds/slave/test/build/venv 11:55:19 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 11:55:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:55:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:55:21 INFO - Using real prefix '/usr' 11:55:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:55:21 INFO - Installing distribute.............................................................................................................................................................................................done. 11:55:23 INFO - Installing pip.................done. 11:55:23 INFO - Return code: 0 11:55:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:55:24 INFO - Reading from file tmpfile_stdout 11:55:24 INFO - Output received: 11:55:24 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) 11:55:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:55: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')]} 11:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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')]} 11:55:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6852d8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1f60>, '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 0x2aa2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa31d0>, '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': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', '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 11:55: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', 'pip>=1.5'] in /builds/slave/test/build 11:55: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 pip>=1.5 11:55:24 INFO - Using env: {'DISPLAY': ':0', 11:55:24 INFO - 'HOME': '/home/cltbld', 11:55:24 INFO - 'LANG': 'en_US.UTF-8', 11:55:24 INFO - 'LANGUAGE': 'en_US:en', 11:55:24 INFO - 'LOGNAME': 'cltbld', 11:55:24 INFO - 'MAIL': '/var/mail/cltbld', 11:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:24 INFO - 'MOZ_NO_REMOTE': '1', 11:55:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:24 INFO - 'NO_EM_RESTART': '1', 11:55:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:24 INFO - 'PWD': '/builds/slave/test', 11:55:24 INFO - 'SHELL': '/bin/bash', 11:55:24 INFO - 'SHLVL': '1', 11:55:24 INFO - 'TERM': 'linux', 11:55:24 INFO - 'TMOUT': '86400', 11:55:24 INFO - 'USER': 'cltbld', 11:55:24 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', 11:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:24 INFO - '_': '/tools/buildbot/bin/python'} 11:55:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:25 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 11:55:25 INFO - Cleaning up... 11:55:25 INFO - Return code: 0 11:55:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:55:25 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')]} 11:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:25 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')]} 11:55:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:25 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 0x7f6852d8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1f60>, '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 0x2aa2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa31d0>, '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': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', '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 11:55:25 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 11:55:25 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 11:55:25 INFO - Using env: {'DISPLAY': ':0', 11:55:25 INFO - 'HOME': '/home/cltbld', 11:55:25 INFO - 'LANG': 'en_US.UTF-8', 11:55:25 INFO - 'LANGUAGE': 'en_US:en', 11:55:25 INFO - 'LOGNAME': 'cltbld', 11:55:25 INFO - 'MAIL': '/var/mail/cltbld', 11:55:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:25 INFO - 'MOZ_NO_REMOTE': '1', 11:55:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:25 INFO - 'NO_EM_RESTART': '1', 11:55:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:25 INFO - 'PWD': '/builds/slave/test', 11:55:25 INFO - 'SHELL': '/bin/bash', 11:55:25 INFO - 'SHLVL': '1', 11:55:25 INFO - 'TERM': 'linux', 11:55:25 INFO - 'TMOUT': '86400', 11:55:25 INFO - 'USER': 'cltbld', 11:55:25 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', 11:55:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:25 INFO - '_': '/tools/buildbot/bin/python'} 11:55:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:25 INFO - Downloading/unpacking psutil>=3.1.1 11:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:55:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:55:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:55:28 INFO - Installing collected packages: psutil 11:55:28 INFO - Running setup.py install for psutil 11:55:28 INFO - building 'psutil._psutil_linux' extension 11:55:28 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 11:55:29 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 11:55:30 INFO - building 'psutil._psutil_posix' extension 11:55:30 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 11:55:30 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 11:55:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:55:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:55:30 INFO - Successfully installed psutil 11:55:30 INFO - Cleaning up... 11:55:30 INFO - Return code: 0 11:55:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:55:30 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')]} 11:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:30 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')]} 11:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:30 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 0x7f6852d8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1f60>, '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 0x2aa2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa31d0>, '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': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', '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 11:55:30 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 11:55:30 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 11:55:30 INFO - Using env: {'DISPLAY': ':0', 11:55:30 INFO - 'HOME': '/home/cltbld', 11:55:30 INFO - 'LANG': 'en_US.UTF-8', 11:55:30 INFO - 'LANGUAGE': 'en_US:en', 11:55:30 INFO - 'LOGNAME': 'cltbld', 11:55:30 INFO - 'MAIL': '/var/mail/cltbld', 11:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:30 INFO - 'MOZ_NO_REMOTE': '1', 11:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:30 INFO - 'NO_EM_RESTART': '1', 11:55:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:30 INFO - 'PWD': '/builds/slave/test', 11:55:30 INFO - 'SHELL': '/bin/bash', 11:55:30 INFO - 'SHLVL': '1', 11:55:30 INFO - 'TERM': 'linux', 11:55:30 INFO - 'TMOUT': '86400', 11:55:30 INFO - 'USER': 'cltbld', 11:55:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', 11:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:30 INFO - '_': '/tools/buildbot/bin/python'} 11:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:55:30 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 11:55:30 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 11:55:30 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 11:55:30 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 11:55:30 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 11:55:30 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 11:55:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:55:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:55:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:55:32 INFO - Installing collected packages: mozsystemmonitor 11:55:32 INFO - Running setup.py install for mozsystemmonitor 11:55:32 INFO - Successfully installed mozsystemmonitor 11:55:32 INFO - Cleaning up... 11:55:32 INFO - Return code: 0 11:55:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:55: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')]} 11:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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')]} 11:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6852d8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1f60>, '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 0x2aa2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa31d0>, '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': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', '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 11:55:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:55:32 INFO - Using env: {'DISPLAY': ':0', 11:55:32 INFO - 'HOME': '/home/cltbld', 11:55:32 INFO - 'LANG': 'en_US.UTF-8', 11:55:32 INFO - 'LANGUAGE': 'en_US:en', 11:55:32 INFO - 'LOGNAME': 'cltbld', 11:55:32 INFO - 'MAIL': '/var/mail/cltbld', 11:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:32 INFO - 'MOZ_NO_REMOTE': '1', 11:55:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:32 INFO - 'NO_EM_RESTART': '1', 11:55:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:32 INFO - 'PWD': '/builds/slave/test', 11:55:32 INFO - 'SHELL': '/bin/bash', 11:55:32 INFO - 'SHLVL': '1', 11:55:32 INFO - 'TERM': 'linux', 11:55:32 INFO - 'TMOUT': '86400', 11:55:32 INFO - 'USER': 'cltbld', 11:55:32 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', 11:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:32 INFO - '_': '/tools/buildbot/bin/python'} 11:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:32 INFO - Downloading/unpacking jsonschema==2.5.1 11:55: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 11:55: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 11:55: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 11:55: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 11:55: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 11:55: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 11:55:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:55:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:55: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 11:55: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 11:55: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 11:55: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 11:55: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 11:55: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 11:55:35 INFO - Downloading functools32-3.2.3-2.tar.gz 11:55:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:55:35 INFO - warning: no files found matching '*.txt' 11:55:35 INFO - no previously-included directories found matching 'build' 11:55:35 INFO - no previously-included directories found matching 'dist' 11:55:35 INFO - no previously-included directories found matching '.git*' 11:55:35 INFO - Installing collected packages: jsonschema, functools32 11:55:35 INFO - Running setup.py install for functools32 11:55:35 INFO - warning: no files found matching '*.txt' 11:55:35 INFO - no previously-included directories found matching 'build' 11:55:35 INFO - no previously-included directories found matching 'dist' 11:55:35 INFO - no previously-included directories found matching '.git*' 11:55:35 INFO - Successfully installed jsonschema functools32 11:55:35 INFO - Cleaning up... 11:55:35 INFO - Return code: 0 11:55:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:55: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')]} 11:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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')]} 11:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:35 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 0x7f6852d8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1f60>, '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 0x2aa2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa31d0>, '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': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', '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 11:55:35 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 11:55:35 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 11:55:35 INFO - Using env: {'DISPLAY': ':0', 11:55:35 INFO - 'HOME': '/home/cltbld', 11:55:35 INFO - 'LANG': 'en_US.UTF-8', 11:55:35 INFO - 'LANGUAGE': 'en_US:en', 11:55:35 INFO - 'LOGNAME': 'cltbld', 11:55:35 INFO - 'MAIL': '/var/mail/cltbld', 11:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:35 INFO - 'MOZ_NO_REMOTE': '1', 11:55:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:35 INFO - 'NO_EM_RESTART': '1', 11:55:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:35 INFO - 'PWD': '/builds/slave/test', 11:55:35 INFO - 'SHELL': '/bin/bash', 11:55:35 INFO - 'SHLVL': '1', 11:55:35 INFO - 'TERM': 'linux', 11:55:35 INFO - 'TMOUT': '86400', 11:55:35 INFO - 'USER': 'cltbld', 11:55:35 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', 11:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:35 INFO - '_': '/tools/buildbot/bin/python'} 11:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:55:35 INFO - Cleaning up... 11:55:35 INFO - Return code: 0 11:55:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:55: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')]} 11:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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')]} 11:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:35 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 0x7f6852d8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1f60>, '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 0x2aa2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa31d0>, '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': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', '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 11:55:35 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 11:55:35 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 11:55:35 INFO - Using env: {'DISPLAY': ':0', 11:55:35 INFO - 'HOME': '/home/cltbld', 11:55:35 INFO - 'LANG': 'en_US.UTF-8', 11:55:35 INFO - 'LANGUAGE': 'en_US:en', 11:55:35 INFO - 'LOGNAME': 'cltbld', 11:55:35 INFO - 'MAIL': '/var/mail/cltbld', 11:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:35 INFO - 'MOZ_NO_REMOTE': '1', 11:55:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:35 INFO - 'NO_EM_RESTART': '1', 11:55:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:35 INFO - 'PWD': '/builds/slave/test', 11:55:35 INFO - 'SHELL': '/bin/bash', 11:55:35 INFO - 'SHLVL': '1', 11:55:35 INFO - 'TERM': 'linux', 11:55:35 INFO - 'TMOUT': '86400', 11:55:35 INFO - 'USER': 'cltbld', 11:55:35 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', 11:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:35 INFO - '_': '/tools/buildbot/bin/python'} 11:55:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:36 INFO - Downloading/unpacking blobuploader==1.2.4 11:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:37 INFO - Downloading blobuploader-1.2.4.tar.gz 11:55:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:55:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:55:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:38 INFO - Downloading docopt-0.6.1.tar.gz 11:55:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:55:38 INFO - Installing collected packages: blobuploader, requests, docopt 11:55:38 INFO - Running setup.py install for blobuploader 11:55:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:55:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:55:38 INFO - Running setup.py install for requests 11:55:39 INFO - Running setup.py install for docopt 11:55:39 INFO - Successfully installed blobuploader requests docopt 11:55:39 INFO - Cleaning up... 11:55:39 INFO - Return code: 0 11:55:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55: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')]} 11:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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')]} 11:55:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6852d8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1f60>, '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 0x2aa2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa31d0>, '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': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', '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 11:55:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:55:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:55:39 INFO - Using env: {'DISPLAY': ':0', 11:55:39 INFO - 'HOME': '/home/cltbld', 11:55:39 INFO - 'LANG': 'en_US.UTF-8', 11:55:39 INFO - 'LANGUAGE': 'en_US:en', 11:55:39 INFO - 'LOGNAME': 'cltbld', 11:55:39 INFO - 'MAIL': '/var/mail/cltbld', 11:55:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:39 INFO - 'MOZ_NO_REMOTE': '1', 11:55:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:39 INFO - 'NO_EM_RESTART': '1', 11:55:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:39 INFO - 'PWD': '/builds/slave/test', 11:55:39 INFO - 'SHELL': '/bin/bash', 11:55:39 INFO - 'SHLVL': '1', 11:55:39 INFO - 'TERM': 'linux', 11:55:39 INFO - 'TMOUT': '86400', 11:55:39 INFO - 'USER': 'cltbld', 11:55:39 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', 11:55:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:39 INFO - '_': '/tools/buildbot/bin/python'} 11:55:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:39 INFO - Running setup.py (path:/tmp/pip-0soycr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:39 INFO - Running setup.py (path:/tmp/pip-4c0W7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:39 INFO - Running setup.py (path:/tmp/pip-Mtdgff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:39 INFO - Running setup.py (path:/tmp/pip-uCeIi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:39 INFO - Running setup.py (path:/tmp/pip-9TeO8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:39 INFO - Running setup.py (path:/tmp/pip-vSmy0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:40 INFO - Running setup.py (path:/tmp/pip-6GrX5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:40 INFO - Running setup.py (path:/tmp/pip-KH5We6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:40 INFO - Running setup.py (path:/tmp/pip-yYEy4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:40 INFO - Running setup.py (path:/tmp/pip-pld1dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:40 INFO - Running setup.py (path:/tmp/pip-S4ZMN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:40 INFO - Running setup.py (path:/tmp/pip-uKAnwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:40 INFO - Running setup.py (path:/tmp/pip-iBzlJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:40 INFO - Running setup.py (path:/tmp/pip-DBXFTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:40 INFO - Running setup.py (path:/tmp/pip-yFnAMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:40 INFO - Running setup.py (path:/tmp/pip-CWQjtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:40 INFO - Running setup.py (path:/tmp/pip-dnbyZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:55:40 INFO - Running setup.py install for manifestparser 11:55:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:55:40 INFO - Running setup.py install for mozcrash 11:55:41 INFO - Running setup.py install for mozdebug 11:55:41 INFO - Running setup.py install for mozdevice 11:55:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Running setup.py install for mozfile 11:55:41 INFO - Running setup.py install for mozhttpd 11:55:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Running setup.py install for mozinfo 11:55:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Running setup.py install for mozInstall 11:55:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Running setup.py install for mozleak 11:55:41 INFO - Running setup.py install for mozlog 11:55:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Running setup.py install for moznetwork 11:55:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Running setup.py install for mozprocess 11:55:42 INFO - Running setup.py install for mozprofile 11:55:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:55:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:55:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:55:42 INFO - Running setup.py install for mozrunner 11:55:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:55:42 INFO - Running setup.py install for mozscreenshot 11:55:42 INFO - Running setup.py install for moztest 11:55:42 INFO - Running setup.py install for mozversion 11:55:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:55:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:55:42 INFO - Cleaning up... 11:55:42 INFO - Return code: 0 11:55:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:42 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')]} 11:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:42 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')]} 11:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:42 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 0x7f6852d8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1f60>, '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 0x2aa2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa31d0>, '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': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', '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 11:55:42 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 11:55:42 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 11:55:42 INFO - Using env: {'DISPLAY': ':0', 11:55:42 INFO - 'HOME': '/home/cltbld', 11:55:42 INFO - 'LANG': 'en_US.UTF-8', 11:55:42 INFO - 'LANGUAGE': 'en_US:en', 11:55:42 INFO - 'LOGNAME': 'cltbld', 11:55:42 INFO - 'MAIL': '/var/mail/cltbld', 11:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:42 INFO - 'MOZ_NO_REMOTE': '1', 11:55:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:42 INFO - 'NO_EM_RESTART': '1', 11:55:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:42 INFO - 'PWD': '/builds/slave/test', 11:55:42 INFO - 'SHELL': '/bin/bash', 11:55:42 INFO - 'SHLVL': '1', 11:55:42 INFO - 'TERM': 'linux', 11:55:42 INFO - 'TMOUT': '86400', 11:55:42 INFO - 'USER': 'cltbld', 11:55:42 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', 11:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:42 INFO - '_': '/tools/buildbot/bin/python'} 11:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:42 INFO - Running setup.py (path:/tmp/pip-3DRy9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:42 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)) 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:42 INFO - Running setup.py (path:/tmp/pip-CPQo9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:42 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)) 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:42 INFO - Running setup.py (path:/tmp/pip-09zIsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:43 INFO - Running setup.py (path:/tmp/pip-C4VExH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:43 INFO - Running setup.py (path:/tmp/pip-krtlAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:43 INFO - Running setup.py (path:/tmp/pip-8ANqZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:43 INFO - Running setup.py (path:/tmp/pip-K61Kh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:43 INFO - Running setup.py (path:/tmp/pip-2qzkpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:43 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)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:43 INFO - Running setup.py (path:/tmp/pip-_NVUqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:43 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)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:43 INFO - Running setup.py (path:/tmp/pip-SI9tAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:43 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)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:43 INFO - Running setup.py (path:/tmp/pip-TxccQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:43 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)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:43 INFO - Running setup.py (path:/tmp/pip-HIO2DI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:43 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)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:43 INFO - Running setup.py (path:/tmp/pip-F9SkTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:43 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)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:43 INFO - Running setup.py (path:/tmp/pip-Zabj3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:43 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)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:43 INFO - Running setup.py (path:/tmp/pip-uepgVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:43 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)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:43 INFO - Running setup.py (path:/tmp/pip-cfwfPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:43 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)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:43 INFO - Running setup.py (path:/tmp/pip-Lmaw9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:55:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:45 INFO - Downloading blessings-1.6.tar.gz 11:55:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:55:46 INFO - Installing collected packages: blessings 11:55:46 INFO - Running setup.py install for blessings 11:55:46 INFO - Successfully installed blessings 11:55:46 INFO - Cleaning up... 11:55:46 INFO - Return code: 0 11:55:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:55:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:55:46 INFO - Reading from file tmpfile_stdout 11:55:46 INFO - Current package versions: 11:55:46 INFO - argparse == 1.2.1 11:55:46 INFO - blessings == 1.6 11:55:46 INFO - blobuploader == 1.2.4 11:55:46 INFO - docopt == 0.6.1 11:55:46 INFO - functools32 == 3.2.3-2 11:55:46 INFO - jsonschema == 2.5.1 11:55:46 INFO - manifestparser == 1.1 11:55:46 INFO - mozInstall == 1.12 11:55:46 INFO - mozcrash == 1.0 11:55:46 INFO - mozdebug == 0.1 11:55:46 INFO - mozdevice == 0.48 11:55:46 INFO - mozfile == 1.2 11:55:46 INFO - mozhttpd == 0.7 11:55:46 INFO - mozinfo == 0.9 11:55:46 INFO - mozleak == 0.1 11:55:46 INFO - mozlog == 3.4 11:55:46 INFO - moznetwork == 0.27 11:55:46 INFO - mozprocess == 0.23 11:55:46 INFO - mozprofile == 0.28 11:55:46 INFO - mozrunner == 6.13 11:55:46 INFO - mozscreenshot == 0.1 11:55:46 INFO - mozsystemmonitor == 0.3 11:55:46 INFO - moztest == 0.7 11:55:46 INFO - mozversion == 1.4 11:55:46 INFO - psutil == 3.1.1 11:55:46 INFO - requests == 1.2.3 11:55:46 INFO - wsgiref == 0.1.2 11:55:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:46 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')]} 11:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:46 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')]} 11:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:46 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 0x7f6852d8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1f60>, '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 0x2aa2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa31d0>, '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': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', '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 11:55:46 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 11:55:46 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 11:55:46 INFO - Using env: {'DISPLAY': ':0', 11:55:46 INFO - 'HOME': '/home/cltbld', 11:55:46 INFO - 'LANG': 'en_US.UTF-8', 11:55:46 INFO - 'LANGUAGE': 'en_US:en', 11:55:46 INFO - 'LOGNAME': 'cltbld', 11:55:46 INFO - 'MAIL': '/var/mail/cltbld', 11:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:46 INFO - 'MOZ_NO_REMOTE': '1', 11:55:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:46 INFO - 'NO_EM_RESTART': '1', 11:55:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:46 INFO - 'PWD': '/builds/slave/test', 11:55:46 INFO - 'SHELL': '/bin/bash', 11:55:46 INFO - 'SHLVL': '1', 11:55:46 INFO - 'TERM': 'linux', 11:55:46 INFO - 'TMOUT': '86400', 11:55:46 INFO - 'USER': 'cltbld', 11:55:46 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', 11:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:46 INFO - '_': '/tools/buildbot/bin/python'} 11:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:46 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)) 11:55:46 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)) 11:55:46 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)) 11:55:46 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)) 11:55:46 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)) 11:55:46 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)) 11:55:46 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)) 11:55:46 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)) 11:55:46 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)) 11:55:46 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)) 11:55:46 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)) 11:55:46 INFO - Cleaning up... 11:55:46 INFO - Return code: 0 11:55:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:55:46 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')]} 11:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:46 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')]} 11:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:46 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 0x7f6852d8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1f60>, '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 0x2aa2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa31d0>, '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': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', '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 11:55:46 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 11:55:46 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 11:55:46 INFO - Using env: {'DISPLAY': ':0', 11:55:46 INFO - 'HOME': '/home/cltbld', 11:55:46 INFO - 'LANG': 'en_US.UTF-8', 11:55:46 INFO - 'LANGUAGE': 'en_US:en', 11:55:46 INFO - 'LOGNAME': 'cltbld', 11:55:46 INFO - 'MAIL': '/var/mail/cltbld', 11:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:46 INFO - 'MOZ_NO_REMOTE': '1', 11:55:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:46 INFO - 'NO_EM_RESTART': '1', 11:55:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:46 INFO - 'PWD': '/builds/slave/test', 11:55:46 INFO - 'SHELL': '/bin/bash', 11:55:46 INFO - 'SHLVL': '1', 11:55:46 INFO - 'TERM': 'linux', 11:55:46 INFO - 'TMOUT': '86400', 11:55:46 INFO - 'USER': 'cltbld', 11:55:46 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', 11:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:46 INFO - '_': '/tools/buildbot/bin/python'} 11:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:55:46 INFO - Cleaning up... 11:55:46 INFO - Return code: 0 11:55:46 INFO - Running post-action listener: _resource_record_post_action 11:55:46 INFO - Running post-action listener: _start_resource_monitoring 11:55:46 INFO - Starting resource monitoring. 11:55:47 INFO - [mozharness: 2016-11-14 19:55:47.000292Z] Finished create-virtualenv step (success) 11:55:47 INFO - [mozharness: 2016-11-14 19:55:47.001206Z] Running install step. 11:55:47 INFO - Running pre-action listener: _resource_record_pre_action 11:55:47 INFO - Running main action method: install 11:55:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:55:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:55:47 INFO - Reading from file tmpfile_stdout 11:55:47 INFO - Detecting whether we're running mozinstall >=1.0... 11:55:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:55:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:55:47 INFO - Reading from file tmpfile_stdout 11:55:47 INFO - Output received: 11:55:47 INFO - Usage: mozinstall [options] installer 11:55:47 INFO - Options: 11:55:47 INFO - -h, --help show this help message and exit 11:55:47 INFO - -d DEST, --destination=DEST 11:55:47 INFO - Directory to install application into. [default: 11:55:47 INFO - "/builds/slave/test"] 11:55:47 INFO - --app=APP Application being installed. [default: firefox] 11:55:47 INFO - mkdir: /builds/slave/test/build/application 11:55:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:55:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:56:03 INFO - Reading from file tmpfile_stdout 11:56:03 INFO - Output received: 11:56:03 INFO - /builds/slave/test/build/application/firefox/firefox 11:56:03 INFO - Running post-action listener: _resource_record_post_action 11:56:03 INFO - [mozharness: 2016-11-14 19:56:03.196048Z] Finished install step (success) 11:56:03 INFO - [mozharness: 2016-11-14 19:56:03.196292Z] Running run-tests step. 11:56:03 INFO - Running pre-action listener: _resource_record_pre_action 11:56:03 INFO - Running main action method: run_tests 11:56:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:56:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:56:03 INFO - Python 2.7.3 11:56:03 INFO - Return code: 0 11:56:03 INFO - grabbing minidump binary from tooltool 11:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:03 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1f60>, '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 0x2aa2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa31d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:56:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:56:03 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 11:56:03 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 11:56:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:56:03 INFO - Return code: 0 11:56:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:56:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:56:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:56:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:56:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:56:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 11:56:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 11:56:03 INFO - Using env: {'DISPLAY': ':0', 11:56:03 INFO - 'HOME': '/home/cltbld', 11:56:03 INFO - 'LANG': 'en_US.UTF-8', 11:56:03 INFO - 'LANGUAGE': 'en_US:en', 11:56:03 INFO - 'LOGNAME': 'cltbld', 11:56:03 INFO - 'MAIL': '/var/mail/cltbld', 11:56:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:56:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:03 INFO - 'MOZ_NO_REMOTE': '1', 11:56:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:56:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:03 INFO - 'NO_EM_RESTART': '1', 11:56:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:03 INFO - 'PWD': '/builds/slave/test', 11:56:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:56:03 INFO - 'SHELL': '/bin/bash', 11:56:03 INFO - 'SHLVL': '1', 11:56:03 INFO - 'TERM': 'linux', 11:56:03 INFO - 'TMOUT': '86400', 11:56:03 INFO - 'USER': 'cltbld', 11:56:03 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230', 11:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:03 INFO - '_': '/tools/buildbot/bin/python'} 11:56:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 11:56:03 INFO - mozversion application_buildid: 20161114081542 11:56:03 INFO - mozversion application_changeset: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d 11:56:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:56:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:56:03 INFO - mozversion application_name: Firefox 11:56:03 INFO - mozversion application_remotingname: firefox-dev 11:56:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:56:03 INFO - mozversion application_vendor: Mozilla 11:56:03 INFO - mozversion application_version: 52.0a2 11:56:03 INFO - mozversion platform_buildid: 20161114081542 11:56:03 INFO - mozversion platform_changeset: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d 11:56:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:56:03 INFO - mozversion platform_version: 52.0a2 11:56:03 INFO - using testdate: 1479153363 11:56:03 INFO - actual date: 1479153363 11:56:03 INFO - starting webserver on 'localhost:44281' 11:56:03 INFO - SUITE-START | Running 2 tests 11:56:03 INFO - TEST-START | dromaeo_css 11:56:03 INFO - operating with platform_type : linux_ 11:56:03 INFO - Initialising browser for dromaeo_css test... 11:56:03 INFO - TEST-INFO | started process 3340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplFGqRb/profile http://localhost:44281/getInfo.html) 11:56:07 ERROR - PROCESS | 3340 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 11:56:08 INFO - PROCESS | 3340 | __metrics Screen width/height:1600/1200 11:56:08 INFO - PROCESS | 3340 | colorDepth:24 11:56:08 INFO - PROCESS | 3340 | Browser inner width/height: 1024/697 11:56:08 INFO - PROCESS | 3340 | __metrics 11:56:09 INFO - PROCESS | 3340 | 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" 11:56:09 INFO - PROCESS | 3340 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:56:09 INFO - PROCESS | 3340 | console.error: PushService: 11:56:09 INFO - PROCESS | 3340 | stateChangeProcessEnqueue: Error transitioning state 11:56:09 INFO - PROCESS | 3340 | UnknownError 11:56:10 INFO - TEST-INFO | 3340: exit 0 11:56:10 INFO - Browser initialized. 11:56:10 INFO - Running cycle 1/1 for dromaeo_css test... 11:56:10 INFO - TEST-INFO | started process 3433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplFGqRb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:56:22 INFO - PROCESS | 3433 | RSS: Main: 144183296 11:56:22 INFO - PROCESS | 3433 | 11:57:14 INFO - PROCESS | 3433 | 1479153434435 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] 11:59:25 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:44281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44281/tests/dromaeo/cssquery-ext.html) 11:59:26 INFO - PROCESS | 3433 | RSS: Main: 245084160 11:59:26 INFO - PROCESS | 3433 | 12:02:28 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:44281/tests/dromaeo/cssquery-ext.html (next: http://localhost:44281/tests/dromaeo/cssquery-jquery.html) 12:02:29 INFO - PROCESS | 3433 | RSS: Main: 228630528 12:02:29 INFO - PROCESS | 3433 | 12:05:31 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:44281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44281/tests/dromaeo/cssquery-mootools.html) 12:05:31 INFO - PROCESS | 3433 | RSS: Main: 206352384 12:05:31 INFO - PROCESS | 3433 | 12:08:33 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:44281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44281/tests/dromaeo/cssquery-prototype.html) 12:08:34 INFO - PROCESS | 3433 | RSS: Main: 217034752 12:08:34 INFO - PROCESS | 3433 | 12:11:37 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:44281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44281/tests/dromaeo/cssquery-yui.html) 12:11:37 INFO - PROCESS | 3433 | RSS: Main: 172916736 12:11:37 INFO - PROCESS | 3433 | 12:14:40 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:44281/tests/dromaeo/cssquery-yui.html (next: http://localhost:44281/tests/dromaeo/cssquery-dojo.html) 12:14:40 INFO - PROCESS | 3433 | RSS: Main: 267517952 12:14:40 INFO - PROCESS | 3433 | 12:14:40 INFO - PROCESS | 3433 | __start_tp_report 12:14:40 INFO - PROCESS | 3433 | _x_x_mozilla_page_load 12:14:40 INFO - PROCESS | 3433 | _x_x_mozilla_page_load_details 12:14:40 INFO - PROCESS | 3433 | |i|pagename|runs| 12:14:40 INFO - PROCESS | 3433 | |0;dojo.html;3191.170295723112;3232.8221947792863;3244.935101297973;3268.460703983843;3279.8360081995893;5530.308711411074;5588.524975377088;5589.413111623282;5610.831675049745;5624.550035997116;5513.641613295143;5550.056490396632;5550.16747487877;5563.582731295149;5600.383957764642;5020.0712868119335;5037.017781532602;5068.062408454448;5113.258577506259;5116.079105760961;5000.124978128831;5023.271625614284;5094.337736094302;5131.538161565459;5137.280780690707;5073.771680274396;5085.135526960407;5111.872203194913;5140.1518749406305;5152.278680984665;5150.3047088642925;5217.034848553029;5220.112580861262;5228.8692782680355;5247.527722504955;4884.755762211875;5086.46592107827;5114.335136432277;5142.537171654569;5181.766820493087;5465.344158700942;5471.042567550663;5489.478499542537;5500.862478438031;5519.613627046108;5899.882002359929;5951.4941229995065;6016.518678505709;6017.879642407172;6031.788887388921;5832.1834943108;6081.391860813927;6092.786752463687;6113.419225173601;6117.021276595768;5447.754851031753;5494.945050549523;5496.725163741797;5519.834404967857;5537.667739935617;6053.636781793019;6062.120992456069;6062.42406971337;6070.878582428327;6076.939230607637;5745.626534275259;5802.970985145132;5803.158542011384;5807.767689292466;5809.82570522885;5871.089981052944;5904.321003084614;5930.199423077829;5945.078512830518;6037.245344331958;5986.102084687332;5990.041593345044;5994.940050599438;5996.610220335664;6030.517558595302;5955.434233747787;5988.6706231157705;5993.190919225936;5994.3705910878725;6014.939850601438;4438.356438316426;4463;4586.449626044896;4606.193916064675;4616.838410655611;4105.507339119325;4119;4131.97934010328;4156.771377574262;4183.769892655933;5739.8565035874435;5749.425057494217;5752.856178595485;5756.395578464285;5758.3665796762325;5820.156077368758;5885.911711324334;5962.910556341659;6022.18700475439;6048.123022161762;5739.655620662774;5743.827685169452;5745.195672605839;5752.798652047159;5783.103618939072;5195.610329225323;5207.7916883325;5211.973940130275;5219.347581552306;5247.10799164143;5945.851353716192;6006.729697163551;6080.452759251689;6256.155419018465;6268.122462855204;5892.175095486721;5988.910166347421;5998.3401825798255;6031.065184896348;6031.306399764083;6177.042558403455;6184;6191.288001879661;6195.349488303663;6200.286966998672;5755.539556835527;5756.798512052058;5875.559333050124;5876.412358764261;5878.2358293421585;5866.354700982974;5907.9704601476715;5908.409159084057;5957.463828255304;6016.458518733335;5802.738876750641;5837.912431313619;5839.795607153729;5841.795537156179;5843.7370318336625;5676.943230567642;5804.883902322014;5825.912611310749;5830;5830.53355731549;5613.46672066153;5628.943710562842;5656.151577263443;5657.971710141423;5723.3418156912485;5774.711264436677;5776.046952252831;5777.8555536111935;5786.334571524329;5787.56593255516;5509.972450137724;5563.304586926634;5572.60991730575;5609.691466969192;5610.635308704921 12:14:40 INFO - PROCESS | 3433 | |1;ext.html;575.5108158065644;612.2163630552892;647.4464332995288;658.8484648530838;670.1087553553774;34728;44749.32876006862;45853.31220031694;45862.541374586246;45872.77063614686;45818;46300.379486717975;46492;46538;46586.30120548195;8713.085126061767;8851.911480885205;8862.689805856797;8868.822623547525;8874.245689116433;8767.298616110696;8816.206541411271;8841.690540831072;8854.158854908806;8862.734117976439;8885.333599979995;8899.110088991114;8915.1976322131;8930;8946.150115738994;8807.823843523125;8837.646494140226;8850.867236991451;8858.557072146432;8861.556922153899;8725.650973961034;8835.425697329652;8837.337199709984;8845.778855528662;8854.203121719076;36426.817865910765;36998.63001369979;37104.81447592745;37122;37152.81423592865;3592.5868525119686;3783.2433513297174;3854.1713531590563;4036.858709945138;4056.898577535556;33372.33255334904;33390.165245868804;33484.162895927555;33846.32307353864;34963;4530.932036019462;4566.429196350457;4575.290829921334;4665.160271151191;4688.249880019181;343246;345790;345885;347504.2624786885;350251;38022.42966355507;60352.39647603468;60741.39258607446;60866.391336086956;60890.08664870031;38806.41790373147;40930;41102.58897410987;41143.38284925729;41149.38275925864;17063.061531615633;17221.7416738749;17234.913825431042;17244.655106897793;17263.309467621406;14363.56909292723;14365.78451323231;14405.351759170862;14407.855921440652;14412.207328596818;9485.33602647808;9487.857682134774;9519.714408567754;9567.808643827084;9586.520673966274;3511.736619753529;3597.5143355647174;3598.7480876338927;3604.3151801157696;3618.8914332570066;982.2682101834037;1025.8820235672993;1046.2362475393006;1083.4528563075596;1092.6066616018227;32929.34141317208;33456.832715836754;33838;33957.151071223416;33973;925.9120383563551;971.606499367743;975.1418751498777;985.1232403161192;1076.6554702495127;16710;17839.095052244753;17880;17935.632850338203;18519.72220416695;557644;559475;560479;560956;563185;61827.6908615454;62404.68797656074;62411.68794156091;62423.375766242665;62435;1322.5833862333334;1322.8809407153403;1371.149887070003;1421.3532842556613;1444.0902231594027;30980.53529197109;35014.82492587521;35069;35158.472622910165;35199.64800352066;53081;53816;53828.730856345464;53848;53863.73068134791;421003;422142;424779;425437;427957;27798;28589.28526786847;29637.110886673436;31169.68830311668;31539.211519711273;45592;47375;47534.762326188145;48109;48439;41152.58847411488;41835.372469412374;42159.36760948649;42451;43309.75176861685;41751.58248417477;41842.16315673609;41858.790706046275;42550.14899702051;43419.782901085295;41582.79208603938;43256.13487730165;44790;45298;46478.302825456965;35538.82230588831;37693.81153094217;38085.23829523449;38765.806170968965;39038.219235615696;27943.72056279411;27950.3012424691;27983.720162798112;28074;28171.295717607223 12:14:40 INFO - PROCESS | 3433 | |2;jquery.html;416.5959019750841;423.93640953856897;429.14171656686625;434.876060322808;442.4822957140146;18392.632147357046;19313.903430482846;19438.319658811943;19733.309334173307;20105.39683809486;17291.39480118196;18195.45413637593;19601.50996225095;19682.91743954082;19822.207111715514;5640.210370548116;5830.941690583103;5861.413858614147;5867.090600956859;5870.88258234835;4177.248095342837;4474.8881277967985;5741.971290143543;5838.357780644125;5842.094475356326;6477.287498375175;6589.736410543573;6597.47220222381;6605.70274337656;6612.933870661304;6365.395287447708;6499.967500162516;6529.738810447577;6535.313792051861;6599.868002639944;5607.186957891124;5798.246227990334;5813.476787089182;5820.534357251409;5821.941780582225;23214.883925580434;23431.179908703285;23575.7642423577;23657.171998979953;23991.88004059986;2486.788622967032;2500.212433083591;2502.449461118569;2580.342012786746;2582.9095981640553;14585.708285834224;15002.399904003827;15109.47116850905;15402.922985385114;15764.605884852856;1967.8228959393723;1993.9700904486444;2029.3607513633306;2038.6024725178597;2055.5580550181635;79117;79419.6029019857;80517.59741201316;81165;82909.58545207296;9555.952220238854;10775;11105.888941110647;11285.943570282096;11389.487473063731;15666.295016724274;15702.842971570366;15704.60738481547;15721.213939302988;15724.842751572338;8031.718889838944;8156.918430815735;8225.753227403187;8359.58202089893;8404.747857564284;7996.160403157584;8093.109757926623;8205.350629891831;8237.052738934979;8525.44584601999;6816.909294512854;6880.928501215028;6905;6967.895481567781;6998.75504357345;1809.312461264711;1853.3883818339916;1903.45751460833;1934.177974360891;1975.7969863602268;889.2974550105473;972.844344904826;999.1956475037664;1003.508280942333;1011.8532812742111;18297.542561435803;19593.902030489757;19748.012599369973;19948.60102797936;20359.796402036085;949.8670186173941;989.1394486796389;1000.4397537379091;1031.4842578710645;1044.4621020174616;10551.630692925864;11150.714103608741;11244.212905096729;11318.377489238006;11440.141989350832;431848;434499;451730;453874;459995;81428.59285703534;81622.59188704018;81789;82495;85212.57393713116;1014.8376259798397;1027.1679939249082;1044.8902865199045;1046.1892033673812;1047.5390828035793;16751.664966700842;16767.245473953946;17152.313907443564;17528.035958022432;17858.285668573113;39310;40363.394549082375;40522.39216411697;40848;40875.18249634931;51455;52316;52425.47574524206;52511.21233181582;53211.46788532065;8485;8747.91252087471;8789.428687135316;8880.73357799267;9001.549922503718;12715.80926286088;12910.160839545399;13327.66680832948;13421;13559.389827457591;7785.610719464117;11038.227324087236;11183.832242516532;11370.602028928948;11635;11098.722531936442;11444.370559619301;11651.242669226473;11771.882281177079;11953.163278570417;11328.773424531628;11602.6519204424;11663.125265604944;11743.295402275891;11862.762744744885;7817.218278172138;8279.37904657141;8298.834023319621;8708.738737837875;8783.472991620523;8822.470651760916;11128.721781955515;11449.370284634426;11515.712107197387;11519.596814111466 12:14:40 INFO - PROCESS | 3433 | |3;mootools.html;1438.3239877257688;1482.5107714454232;1599.736043552814;1716.622343084521;1764.7970483394413;8049.396295277856;8529.445586036903;8537.231649151576;8578.74263772087;8587.355948303879;7501.5874126923;7686.5003774754605;7687.538747675143;7859.764207073783;8410.032846222686;2268.104098880941;2451.9019239230497;2542.0467324753217;2548.566743653583;2549.3244290263096;2520.596704527276;2551.9744802551922;2559.7184309725917;2560.9231723048247;2611.7388261173824;2480.9875950620312;2498.600223964166;2521.5839386501207;2523.74762523748;2528.342630915966;2441.7314095449487;2463.8275320727557;2469.320936742401;2469.790067844235;2473.0973194783955;2495.7878580320694;2543.7964962803117;2548.745125487455;2549.783268422186;2550.5664037113734;8481.321494280442;8554.358423118229;8560.01559820616;8570.27152692022;8809.779755506099;5566.415526369713;5677.914831277534;5716.57125715573;5719.399463056402;5726.026575482178;3411.727061835047;3483.2162763378037;3658.2317713280245;3680;3698.0754811297174;1259.1563652352945;1278.284160869916;1308.3523655790445;1357.6673714939902;2230.587341341857;11903.285802851857;12674.619761407173;12686.238825670489;12706.745865082647;12708.555200568027;5100.5409513143995;5125.948740512547;5156.252343410185;5189;5198.532132108053;10248.48757562119;10257.58969641221;10268.537915793808;10281.485925703684;10284.485775711184;5734.799282025109;5738;5740.368559458456;5740.741666625012;5756.56825738063;4563.498015218323;5050.595952323805;5134.486551344836;5155.226715992556;5230.215467679878;3795.1650636859845;3954.446377507094;4075;4101.97949010259;4123.463949686581;1271.790154624495;1283.0954177305164;1291.4511332683571;1297.9156354836905;1305.7323248733987;649.217692680319;690.8031211104911;814.5194335342177;827.470418931872;867.4578388507183;5901.616394934315;6006.699665016819;6022.759089636365;6153.4154255345675;6198.845028874314;836.9623366948501;854.431802851097;926.7080869526078;930.4882314726873;974.4786539201635;3901.308097412833;3979.2837289287627;4071.531773845986;4116.608922152391;4132.586741325904;10681.893181068246;11216.943915280535;11251.268667536584;11300.886991130148;11321.660350189508;10910.509027093642;10921.235513514137;11108.16688748347;11128;11155.219134660496;8347.457415267989;8404;8600.913990860012;8611;8692.478451292942;5862.4791339724325;5955.970220148872;5965.612235204698;6073.514118870568;6101.237345331833;10259.487025648838;10263.127634150882;10334.689959300933;10340.37957722539;10381.532831022772;10121.544530495998;10171.440570768678;10298.639547615798;10336.276460647983;10457.68626941193;7567.9243207569425;7730.497517661334;7741.651625676971;7763.92236077632;7768.728094516665;7412.221716719667;7718.498297610638;8101.513909165469;8395.622197001028;8412.62143203545;7747.496412733154;7801.29788319054;7810.258025487569;7935.0874649416055;7945.0863150736095;7270.600116993616;7492.363149132385;7507.812304692427;7509.66206520697;7686.57723825195;6885.724571017103;7022.1924478685605;7029.472789540702;7034.718611255493;7039.120109986252;5021.598272138293;5065.721385323843;5080.771365288497;5159.922601161061;5228.895422091613;5020.748962551931;5043.344365232496;5134.10153223177;5183.300254465599;5229.294045303987 12:14:40 INFO - PROCESS | 3433 | |4;prototype.html;339.089544572822;348.2130385329156;350.9806960617165;351.493848857645;357.73885063903367;5161.483851614837;5283.947160528393;5323.65396249244;5350.919736203955;5355.598330125242;5130.2817605535165;5228.92156617651;5272.789088436458;5276;5290.788368465266;4168.854090106847;4170;4174.394712766654;4191.140816132701;4202.138561594866;4060.553339132693;4147.543770185277;4204.2432362174795;4207.873763787076;4215.957840421603;4135.42104105424;4138.524069731974;4139.917201655965;4140.337545992642;4161.542230354658;4111.979440102796;4126.876193714178;4137.8551750688885;4153.836925660819;4160.355144952538;3672.6143754905615;3675.779453232788;3679.816009199529;3680.0615842959874;3688.133288677159;5104.744762761847;5189.3772747270195;5191.5846732261325;5192.636515443921;5210.895782084337;4732.645051621108;4732.787024583902;4737.336772851803;4739.19433696269;4751.7624118794265;5524.171374293848;5537.723113844291;5548.195511650828;5551.944480555224;5555.694436805974;3812.8474861005525;3969.2458432897656;3989.40158976153;4006.4791577094793;4012.134357523736;5692.8861422771315;5721.742521586539;5727.455891690282;5746.971265143689;5763.4812866842185;4074.9796251018556;4102.50769907613;4103.158852435244;4112.527059388209;4115.97942010288;3972.0338432475532;4043.534993475788;4131.29767939451;4133.297339452301;4178.540360560336;4718.8584342469785;4720.645951553579;4720.693154944917;4721.5750582447745;4758.214894542431;5499.835004949858;5525.585581081435;5582.49757521825;5612.214289999321;5637.802676906289;1292.849364065982;1299.7270573179549;1299.958786638924;1358.2054498118514;1382.5783136143373;927.2363476648259;951.6669165791917;954.9856752148723;958.1807554540767;959.8673565193;5179.197224430144;5186.792528298825;5187;5197.7401129943355;5202.4277329493725;5431.2396264522995;5436.537894278951;5451.974154344298;5462;5477.645272008763;4934.3338649282605;5120.820771272987;5173.689578625294;5178.482151784867;5210.843674689765;2892.3679451698854;2893.9276518086795;2895.6669982951807;2900.8984685535906;2903.5209190483333;5620.791529821108;5624.353199382042;5634.915476267859;5635.718214089279;5638.210650508932;5268.9736551317765;5475.397706252309;5520.23988005997;5569.972150139223;5571;5537.640053396516;5661.188419705654;5662.320521537442;5673.546116310686;5678.829635110953;5228.424873263862;5404.621676482609;5408.405075441619;5436.510714035598;5462.508374246337;5330.361471071844;5354.303940487712;5364.839054828361;5372;5377.919331210113;5567.468946039709;5598.636088654224;5601.759296281357;5619.049998750688;5655.179998900218;3841.788701621326;3930.2510382880487;3955.6835453163103;3976.5426975896985;3985.123272879962;5412.810551630674;5413.83758487246;5422.8373148805595;5460.863478413072;5484.396716361277;5447;5496.945030549643;5581.330240371019;5586;5592.245046918777;5567.3040869891265;5583.8172241823395;5590.161475778666;5602.467765562265;5610.214569960291;5294.205869119663;5523.8066667668045;5532.557395408438;5544.780148367353;5564.582656300875;5568.997580435398;5611.719414029364;5638.23883775685;5648.85877853057;5658.236138121301;5478.863028424321;5518.751656175402;5521.365043019943;5524.944750552443;5530.391656917655 12:14:40 INFO - PROCESS | 3433 | |5;yui.html;763.5685837501808;789.7670187294748;790.5098838719995;834.2325060943931;876.5923845411883;13622.386992585332;14396.49612263571;14903.105813651175;15841.762373564392;15862.68274634508;13503.459861605548;13708;13715.588532344022;13718.51985180519;13728;704.696980298474;721.1094298541298;818.991810081899;826.6817275348974;830.7092517618845;812.0417906869891;828.7638023163399;836.9245519507434;837.7528629054443;839.6977088248226;869.6130222051158;874.0953113527501;874.2175752701329;874.5802015032756;874.8119154381807;736.3372964332091;748.6443939128925;869.0266901070778;869.4001139213954;869.6217145541679;624.1386886097202;630.3412933484474;638.6710843915388;640.9615423074583;641.3874749614107;14917;14925.701485970329;14973.1016139032;14974.101553906801;14981.550553483414;12650.81023784644;12651.367431628381;12901.2904290264;12991.350432478434;13000.739985200244;12730;12869.678258043623;12945.935270323587;13064.281464519448;13262.734745305137;4280.636145927569;4303.569643035703;4342.826286948518;4359.760213188273;4433.6009759121835;54681.72659136679;61234;63011.684941575455;64071.67964160196;64601.353986460475;10909.618163364245;11477.368744718953;11564.453580809533;11713.062954963752;11766.823497647541;19579.216831326874;20342.694859577117;20517.89741051285;20540;20650.483737906674;8555;8606.31149508038;8708.651653933772;8764.8685269721;9000.23498002664;4446.177457170434;4724.291356296583;4724.787384567703;4765.5949244314625;4818.68678535901;3378.7803792753393;3502.754807163474;3504.369213541536;3506.0708912138302;3513.9648603513638;635.4503354598331;645.5061877663591;655.3119224813927;658.1739916404881;658.4896705053621;585.3765739487433;639.2041907824788;670.902719105727;695.8121307247117;704.7779949315949;9390.984177530021;9661.372010819274;9699.418034917928;9721.756956076155;9861.457619830979;673.474689742002;677.47495690839;702.5222848463094;707.989380159298;725.9165196002527;4478.39541661878;4523.457185137804;4687.10944920464;4705.882352941204;4750.904981900343;51628.74185629123;58766.70616646975;77322.6133869327;83535;89674;44754.55245447569;46833.29750053752;47019.5298047022;73634.63182684052;75804;59424.40575594275;59811.40188598058;60119;68756.6562167196;72575;9898.75253118649;10016.549255283675;10186.847197291898;10239.641612543524;10308.793824123626;44327.33508997432;44892.326615101454;45019.32471013003;46656;46761.76619116883;54608.72695636496;54786.45213547813;56922.43077569337;58166.4183358161;62299.688501559016;12793.104482686123;12984.091113621957;12993.025523085995;13077.215367078006;13080.75732805382;13446.327683615977;14197;14239.288035597972;14255.572332830032;14408.567742967727;13042.413091410719;13371.866281337452;13472;14207.147571145764;14937.178455184634;12997.870021299666;13142.211467311992;13810.240436776074;13994.930025349808;14728.189949552878;12664.810027849406;12934.547290845152;13290.800637990245;14115.858841411455;14293.57119286423;11481.425928703364;11542.841299547315;11686.298822070703;11724.296542207494;12001.699957500783;11659.242149260272;11859.288442693465;11905.166638335233;11941.52233910634;11999.280043197436 12:14:40 INFO - PROCESS | 3433 | __end_tp_report 12:14:40 INFO - PROCESS | 3433 | __start_cc_report 12:14:40 INFO - PROCESS | 3433 | _x_x_mozilla_cycle_collect,979 12:14:40 INFO - PROCESS | 3433 | __end_cc_report 12:14:40 INFO - PROCESS | 3433 | __startTimestamp1479154480381__endTimestamp 12:14:40 INFO - PROCESS | 3433 | 12:14:40 INFO - PROCESS | 3433 | ------- Summary: start ------- 12:14:40 INFO - PROCESS | 3433 | Number of tests: 6 12:14:40 INFO - PROCESS | 3433 | 12:14:40 INFO - PROCESS | 3433 | [#0] dojo.html Cycles:165 Average:5538.92 Median:5752.80 stddev:614.71 (10.7%) stddev-sans-first:588.36 12:14:40 INFO - PROCESS | 3433 | Values: 3191.2 3232.8 3244.9 3268.5 3279.8 5530.3 5588.5 5589.4 5610.8 5624.6 5513.6 5550.1 5550.2 5563.6 5600.4 5020.1 5037.0 5068.1 5113.3 5116.1 5000.1 5023.3 5094.3 5131.5 5137.3 5073.8 5085.1 5111.9 5140.2 5152.3 5150.3 5217.0 5220.1 5228.9 5247.5 4884.8 5086.5 5114.3 5142.5 5181.8 5465.3 5471.0 5489.5 5500.9 5519.6 5899.9 5951.5 6016.5 6017.9 6031.8 5832.2 6081.4 6092.8 6113.4 6117.0 5447.8 5494.9 5496.7 5519.8 5537.7 6053.6 6062.1 6062.4 6070.9 6076.9 5745.6 5803.0 5803.2 5807.8 5809.8 5871.1 5904.3 5930.2 5945.1 6037.2 5986.1 5990.0 5994.9 5996.6 6030.5 5955.4 5988.7 5993.2 5994.4 6014.9 4438.4 4463.0 4586.4 4606.2 4616.8 4105.5 4119.0 4132.0 4156.8 4183.8 5739.9 5749.4 5752.9 5756.4 5758.4 5820.2 5885.9 5962.9 6022.2 6048.1 5739.7 5743.8 5745.2 5752.8 5783.1 5195.6 5207.8 5212.0 5219.3 5247.1 5945.9 6006.7 6080.5 6256.2 6268.1 5892.2 5988.9 5998.3 6031.1 6031.3 6177.0 6184.0 6191.3 6195.3 6200.3 5755.5 5756.8 5875.6 5876.4 5878.2 5866.4 5908.0 5908.4 5957.5 6016.5 5802.7 5837.9 5839.8 5841.8 5843.7 5676.9 5804.9 5825.9 5830.0 5830.5 5613.5 5628.9 5656.2 5658.0 5723.3 5774.7 5776.0 5777.9 5786.3 5787.6 5510.0 5563.3 5572.6 5609.7 5610.6 12:14:40 INFO - PROCESS | 3433 | 12:14:40 INFO - PROCESS | 3433 | [#1] ext.html Cycles:180 Average:60093.83 Median:232296.50 stddev:120154.62 (51.7%) stddev-sans-first:120408.59 12:14:40 INFO - PROCESS | 3433 | Values: 575.5 612.2 647.4 658.8 670.1 34728.0 44749.3 45853.3 45862.5 45872.8 45818.0 46300.4 46492.0 46538.0 46586.3 8713.1 8851.9 8862.7 8868.8 8874.2 8767.3 8816.2 8841.7 8854.2 8862.7 8885.3 8899.1 8915.2 8930.0 8946.2 8807.8 8837.6 8850.9 8858.6 8861.6 8725.7 8835.4 8837.3 8845.8 8854.2 36426.8 36998.6 37104.8 37122.0 37152.8 3592.6 3783.2 3854.2 4036.9 4056.9 33372.3 33390.2 33484.2 33846.3 34963.0 4530.9 4566.4 4575.3 4665.2 4688.2 343246.0 345790.0 345885.0 347504.3 350251.0 38022.4 60352.4 60741.4 60866.4 60890.1 38806.4 40930.0 41102.6 41143.4 41149.4 17063.1 17221.7 17234.9 17244.7 17263.3 14363.6 14365.8 14405.4 14407.9 14412.2 9485.3 9487.9 9519.7 9567.8 9586.5 3511.7 3597.5 3598.7 3604.3 3618.9 982.3 1025.9 1046.2 1083.5 1092.6 32929.3 33456.8 33838.0 33957.2 33973.0 925.9 971.6 975.1 985.1 1076.7 16710.0 17839.1 17880.0 17935.6 18519.7 557644.0 559475.0 560479.0 560956.0 563185.0 61827.7 62404.7 62411.7 62423.4 62435.0 1322.6 1322.9 1371.1 1421.4 1444.1 30980.5 35014.8 35069.0 35158.5 35199.6 53081.0 53816.0 53828.7 53848.0 53863.7 421003.0 422142.0 424779.0 425437.0 427957.0 27798.0 28589.3 29637.1 31169.7 31539.2 45592.0 47375.0 47534.8 48109.0 48439.0 41152.6 41835.4 42159.4 42451.0 43309.8 41751.6 41842.2 41858.8 42550.1 43419.8 41582.8 43256.1 44790.0 45298.0 46478.3 35538.8 37693.8 38085.2 38765.8 39038.2 27943.7 27950.3 27983.7 28074.0 28171.3 12:14:40 INFO - PROCESS | 3433 | 12:14:40 INFO - PROCESS | 3433 | [#2] jquery.html Cycles:180 Average:27555.95 Median:2581.63 stddev:73544.82 (2848.8%) stddev-sans-first:73722.90 12:14:40 INFO - PROCESS | 3433 | Values: 416.6 423.9 429.1 434.9 442.5 18392.6 19313.9 19438.3 19733.3 20105.4 17291.4 18195.5 19601.5 19682.9 19822.2 5640.2 5830.9 5861.4 5867.1 5870.9 4177.2 4474.9 5742.0 5838.4 5842.1 6477.3 6589.7 6597.5 6605.7 6612.9 6365.4 6500.0 6529.7 6535.3 6599.9 5607.2 5798.2 5813.5 5820.5 5821.9 23214.9 23431.2 23575.8 23657.2 23991.9 2486.8 2500.2 2502.4 2580.3 2582.9 14585.7 15002.4 15109.5 15402.9 15764.6 1967.8 1994.0 2029.4 2038.6 2055.6 79117.0 79419.6 80517.6 81165.0 82909.6 9556.0 10775.0 11105.9 11285.9 11389.5 15666.3 15702.8 15704.6 15721.2 15724.8 8031.7 8156.9 8225.8 8359.6 8404.7 7996.2 8093.1 8205.4 8237.1 8525.4 6816.9 6880.9 6905.0 6967.9 6998.8 1809.3 1853.4 1903.5 1934.2 1975.8 889.3 972.8 999.2 1003.5 1011.9 18297.5 19593.9 19748.0 19948.6 20359.8 949.9 989.1 1000.4 1031.5 1044.5 10551.6 11150.7 11244.2 11318.4 11440.1 431848.0 434499.0 451730.0 453874.0 459995.0 81428.6 81622.6 81789.0 82495.0 85212.6 1014.8 1027.2 1044.9 1046.2 1047.5 16751.7 16767.2 17152.3 17528.0 17858.3 39310.0 40363.4 40522.4 40848.0 40875.2 51455.0 52316.0 52425.5 52511.2 53211.5 8485.0 8747.9 8789.4 8880.7 9001.5 12715.8 12910.2 13327.7 13421.0 13559.4 7785.6 11038.2 11183.8 11370.6 11635.0 11098.7 11444.4 11651.2 11771.9 11953.2 11328.8 11602.7 11663.1 11743.3 11862.8 7817.2 8279.4 8298.8 8708.7 8783.5 8822.5 11128.7 11449.4 11515.7 11519.6 12:14:40 INFO - PROCESS | 3433 | 12:14:40 INFO - PROCESS | 3433 | [#3] mootools.html Cycles:180 Average:5866.48 Median:5073.25 stddev:3255.47 (64.2%) stddev-sans-first:3247.59 12:14:40 INFO - PROCESS | 3433 | Values: 1438.3 1482.5 1599.7 1716.6 1764.8 8049.4 8529.4 8537.2 8578.7 8587.4 7501.6 7686.5 7687.5 7859.8 8410.0 2268.1 2451.9 2542.0 2548.6 2549.3 2520.6 2552.0 2559.7 2560.9 2611.7 2481.0 2498.6 2521.6 2523.7 2528.3 2441.7 2463.8 2469.3 2469.8 2473.1 2495.8 2543.8 2548.7 2549.8 2550.6 8481.3 8554.4 8560.0 8570.3 8809.8 5566.4 5677.9 5716.6 5719.4 5726.0 3411.7 3483.2 3658.2 3680.0 3698.1 1259.2 1278.3 1308.4 1357.7 2230.6 11903.3 12674.6 12686.2 12706.7 12708.6 5100.5 5125.9 5156.3 5189.0 5198.5 10248.5 10257.6 10268.5 10281.5 10284.5 5734.8 5738.0 5740.4 5740.7 5756.6 4563.5 5050.6 5134.5 5155.2 5230.2 3795.2 3954.4 4075.0 4102.0 4123.5 1271.8 1283.1 1291.5 1297.9 1305.7 649.2 690.8 814.5 827.5 867.5 5901.6 6006.7 6022.8 6153.4 6198.8 837.0 854.4 926.7 930.5 974.5 3901.3 3979.3 4071.5 4116.6 4132.6 10681.9 11216.9 11251.3 11300.9 11321.7 10910.5 10921.2 11108.2 11128.0 11155.2 8347.5 8404.0 8600.9 8611.0 8692.5 5862.5 5956.0 5965.6 6073.5 6101.2 10259.5 10263.1 10334.7 10340.4 10381.5 10121.5 10171.4 10298.6 10336.3 10457.7 7567.9 7730.5 7741.7 7763.9 7768.7 7412.2 7718.5 8101.5 8395.6 8412.6 7747.5 7801.3 7810.3 7935.1 7945.1 7270.6 7492.4 7507.8 7509.7 7686.6 6885.7 7022.2 7029.5 7034.7 7039.1 5021.6 5065.7 5080.8 5159.9 5228.9 5020.7 5043.3 5134.1 5183.3 5229.3 12:14:40 INFO - PROCESS | 3433 | 12:14:40 INFO - PROCESS | 3433 | [#4] prototype.html Cycles:180 Average:4611.87 Median:5274.39 stddev:1338.99 (25.4%) stddev-sans-first:1303.78 12:14:40 INFO - PROCESS | 3433 | Values: 339.1 348.2 351.0 351.5 357.7 5161.5 5283.9 5323.7 5350.9 5355.6 5130.3 5228.9 5272.8 5276.0 5290.8 4168.9 4170.0 4174.4 4191.1 4202.1 4060.6 4147.5 4204.2 4207.9 4216.0 4135.4 4138.5 4139.9 4140.3 4161.5 4112.0 4126.9 4137.9 4153.8 4160.4 3672.6 3675.8 3679.8 3680.1 3688.1 5104.7 5189.4 5191.6 5192.6 5210.9 4732.6 4732.8 4737.3 4739.2 4751.8 5524.2 5537.7 5548.2 5551.9 5555.7 3812.8 3969.2 3989.4 4006.5 4012.1 5692.9 5721.7 5727.5 5747.0 5763.5 4075.0 4102.5 4103.2 4112.5 4116.0 3972.0 4043.5 4131.3 4133.3 4178.5 4718.9 4720.6 4720.7 4721.6 4758.2 5499.8 5525.6 5582.5 5612.2 5637.8 1292.8 1299.7 1300.0 1358.2 1382.6 927.2 951.7 955.0 958.2 959.9 5179.2 5186.8 5187.0 5197.7 5202.4 5431.2 5436.5 5452.0 5462.0 5477.6 4934.3 5120.8 5173.7 5178.5 5210.8 2892.4 2893.9 2895.7 2900.9 2903.5 5620.8 5624.4 5634.9 5635.7 5638.2 5269.0 5475.4 5520.2 5570.0 5571.0 5537.6 5661.2 5662.3 5673.5 5678.8 5228.4 5404.6 5408.4 5436.5 5462.5 5330.4 5354.3 5364.8 5372.0 5377.9 5567.5 5598.6 5601.8 5619.0 5655.2 3841.8 3930.3 3955.7 3976.5 3985.1 5412.8 5413.8 5422.8 5460.9 5484.4 5447.0 5496.9 5581.3 5586.0 5592.2 5567.3 5583.8 5590.2 5602.5 5610.2 5294.2 5523.8 5532.6 5544.8 5564.6 5569.0 5611.7 5638.2 5648.9 5658.2 5478.9 5518.8 5521.4 5524.9 5530.4 12:14:40 INFO - PROCESS | 3433 | 12:14:40 INFO - PROCESS | 3433 | [#5] yui.html Cycles:180 Average:16766.88 Median:25589.73 stddev:20607.23 (80.5%) stddev-sans-first:20629.99 12:14:40 INFO - PROCESS | 3433 | Values: 763.6 789.8 790.5 834.2 876.6 13622.4 14396.5 14903.1 15841.8 15862.7 13503.5 13708.0 13715.6 13718.5 13728.0 704.7 721.1 819.0 826.7 830.7 812.0 828.8 836.9 837.8 839.7 869.6 874.1 874.2 874.6 874.8 736.3 748.6 869.0 869.4 869.6 624.1 630.3 638.7 641.0 641.4 14917.0 14925.7 14973.1 14974.1 14981.6 12650.8 12651.4 12901.3 12991.4 13000.7 12730.0 12869.7 12945.9 13064.3 13262.7 4280.6 4303.6 4342.8 4359.8 4433.6 54681.7 61234.0 63011.7 64071.7 64601.4 10909.6 11477.4 11564.5 11713.1 11766.8 19579.2 20342.7 20517.9 20540.0 20650.5 8555.0 8606.3 8708.7 8764.9 9000.2 4446.2 4724.3 4724.8 4765.6 4818.7 3378.8 3502.8 3504.4 3506.1 3514.0 635.5 645.5 655.3 658.2 658.5 585.4 639.2 670.9 695.8 704.8 9391.0 9661.4 9699.4 9721.8 9861.5 673.5 677.5 702.5 708.0 725.9 4478.4 4523.5 4687.1 4705.9 4750.9 51628.7 58766.7 77322.6 83535.0 89674.0 44754.6 46833.3 47019.5 73634.6 75804.0 59424.4 59811.4 60119.0 68756.7 72575.0 9898.8 10016.5 10186.8 10239.6 10308.8 44327.3 44892.3 45019.3 46656.0 46761.8 54608.7 54786.5 56922.4 58166.4 62299.7 12793.1 12984.1 12993.0 13077.2 13080.8 13446.3 14197.0 14239.3 14255.6 14408.6 13042.4 13371.9 13472.0 14207.1 14937.2 12997.9 13142.2 13810.2 13994.9 14728.2 12664.8 12934.5 13290.8 14115.9 14293.6 11481.4 11542.8 11686.3 11724.3 12001.7 11659.2 11859.3 11905.2 11941.5 11999.3 12:14:40 INFO - PROCESS | 3433 | -------- Summary: end -------- 12:14:40 INFO - PROCESS | 3433 | 12:14:41 INFO - TEST-INFO | 3433: exit 0 12:14:41 INFO - TEST-OK | dromaeo_css | took 1117539ms 12:14:41 INFO - TEST-START | kraken 12:14:41 INFO - operating with platform_type : linux_ 12:14:41 INFO - Initialising browser for kraken test... 12:14:41 INFO - TEST-INFO | started process 3748 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYXidgP/profile http://localhost:44281/getInfo.html) 12:14:44 ERROR - PROCESS | 3748 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 12:14:45 INFO - PROCESS | 3748 | __metrics Screen width/height:1600/1200 12:14:45 INFO - PROCESS | 3748 | colorDepth:24 12:14:45 INFO - PROCESS | 3748 | Browser inner width/height: 1024/697 12:14:45 INFO - PROCESS | 3748 | __metrics 12:14:45 INFO - PROCESS | 3748 | 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" 12:14:45 INFO - PROCESS | 3748 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:14:46 INFO - PROCESS | 3748 | console.error: PushService: 12:14:46 INFO - PROCESS | 3748 | stateChangeProcessEnqueue: Error transitioning state 12:14:46 INFO - PROCESS | 3748 | UnknownError 12:14:46 INFO - TEST-INFO | 3748: exit 0 12:14:46 INFO - Browser initialized. 12:14:46 INFO - Running cycle 1/1 for kraken test... 12:14:46 INFO - TEST-INFO | started process 3840 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYXidgP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:14:58 INFO - PROCESS | 3840 | RSS: Main: 144355328 12:14:58 INFO - PROCESS | 3840 | 12:15:01 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:44281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44281/tests/kraken/driver.html?testName=audio-beat-detection) 12:15:02 INFO - PROCESS | 3840 | RSS: Main: 185892864 12:15:02 INFO - PROCESS | 3840 | 12:15:04 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:44281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44281/tests/kraken/driver.html?testName=audio-dft) 12:15:05 INFO - PROCESS | 3840 | RSS: Main: 175439872 12:15:05 INFO - PROCESS | 3840 | 12:15:08 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:44281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44281/tests/kraken/driver.html?testName=audio-fft) 12:15:08 INFO - PROCESS | 3840 | RSS: Main: 266809344 12:15:08 INFO - PROCESS | 3840 | 12:15:10 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:44281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44281/tests/kraken/driver.html?testName=audio-oscillator) 12:15:11 INFO - PROCESS | 3840 | RSS: Main: 173375488 12:15:11 INFO - PROCESS | 3840 | 12:15:13 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:44281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:15:14 INFO - PROCESS | 3840 | RSS: Main: 176152576 12:15:14 INFO - PROCESS | 3840 | 12:15:17 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:44281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44281/tests/kraken/driver.html?testName=imaging-darkroom) 12:15:17 INFO - PROCESS | 3840 | RSS: Main: 214409216 12:15:17 INFO - PROCESS | 3840 | 12:15:20 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:44281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44281/tests/kraken/driver.html?testName=imaging-desaturate) 12:15:21 INFO - PROCESS | 3840 | RSS: Main: 213274624 12:15:21 INFO - PROCESS | 3840 | 12:15:24 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:44281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44281/tests/kraken/driver.html?testName=json-parse-financial) 12:15:24 INFO - PROCESS | 3840 | RSS: Main: 211423232 12:15:24 INFO - PROCESS | 3840 | 12:15:26 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:44281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:15:26 INFO - PROCESS | 3840 | RSS: Main: 173289472 12:15:26 INFO - PROCESS | 3840 | 12:15:28 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:44281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44281/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:15:29 INFO - PROCESS | 3840 | RSS: Main: 181129216 12:15:29 INFO - PROCESS | 3840 | 12:15:31 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:44281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:15:31 INFO - PROCESS | 3840 | RSS: Main: 190660608 12:15:31 INFO - PROCESS | 3840 | 12:15:34 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:44281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:15:34 INFO - PROCESS | 3840 | RSS: Main: 198160384 12:15:34 INFO - PROCESS | 3840 | 12:15:37 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:44281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:15:38 INFO - PROCESS | 3840 | RSS: Main: 195813376 12:15:38 INFO - PROCESS | 3840 | 12:15:39 INFO - PROCESS | 3840 | Cycle 1(1): loaded http://localhost:44281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44281/tests/kraken/driver.html?testName=ai-astar) 12:15:40 INFO - PROCESS | 3840 | RSS: Main: 246771712 12:15:40 INFO - PROCESS | 3840 | 12:15:40 INFO - PROCESS | 3840 | __start_tp_report 12:15:40 INFO - PROCESS | 3840 | _x_x_mozilla_page_load 12:15:40 INFO - PROCESS | 3840 | _x_x_mozilla_page_load_details 12:15:40 INFO - PROCESS | 3840 | |i|pagename|runs| 12:15:40 INFO - PROCESS | 3840 | |0;ai-astar;109;112;112;111;112;111;112;113;111;112 12:15:40 INFO - PROCESS | 3840 | |1;audio-beat-detection;144;123;121;166;124;121;125;123;156;125 12:15:40 INFO - PROCESS | 3840 | |2;audio-dft;159;159;162;159;161;161;160;160;159;159 12:15:40 INFO - PROCESS | 3840 | |3;audio-fft;75;75;75;115;77;75;76;76;99;75 12:15:40 INFO - PROCESS | 3840 | |4;audio-oscillator;81;81;120;81;82;81;97;81;81;114 12:15:40 INFO - PROCESS | 3840 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 12:15:40 INFO - PROCESS | 3840 | |6;imaging-darkroom;145;146;146;146;146;145;147;146;146;145 12:15:40 INFO - PROCESS | 3840 | |7;imaging-desaturate;84;84;84;84;84;85;84;85;84;84 12:15:40 INFO - PROCESS | 3840 | |8;json-parse-financial;53;50;49;49;49;51;51;50;50;50 12:15:40 INFO - PROCESS | 3840 | |9;json-stringify-tinderbox;59;59;59;60;59;59;58;57;58;59 12:15:40 INFO - PROCESS | 3840 | |10;stanford-crypto-aes;75;75;74;76;84;74;74;74;75;81 12:15:40 INFO - PROCESS | 3840 | |11;stanford-crypto-ccm;130;125;140;123;126;128;124;137;165;147 12:15:40 INFO - PROCESS | 3840 | |12;stanford-crypto-pbkdf2;158;155;156;162;160;156;153;154;153;154 12:15:40 INFO - PROCESS | 3840 | |13;stanford-crypto-sha256-iterative;64;62;69;63;64;64;62;63;63;61 12:15:40 INFO - PROCESS | 3840 | __end_tp_report 12:15:40 INFO - PROCESS | 3840 | __start_cc_report 12:15:40 INFO - PROCESS | 3840 | _x_x_mozilla_cycle_collect,1613 12:15:40 INFO - PROCESS | 3840 | __end_cc_report 12:15:40 INFO - PROCESS | 3840 | __startTimestamp1479154540123__endTimestamp 12:15:40 INFO - PROCESS | 3840 | 12:15:40 INFO - PROCESS | 3840 | ------- Summary: start ------- 12:15:40 INFO - PROCESS | 3840 | Number of tests: 14 12:15:40 INFO - PROCESS | 3840 | 12:15:40 INFO - PROCESS | 3840 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:1.08 (1.0%) stddev-sans-first:0.67 12:15:40 INFO - PROCESS | 3840 | Values: 109.0 112.0 112.0 111.0 112.0 111.0 112.0 113.0 111.0 112.0 12:15:40 INFO - PROCESS | 3840 | 12:15:40 INFO - PROCESS | 3840 | [#1] audio-beat-detection Cycles:10 Average:132.80 Median:125.00 stddev:16.45 (13.2%) stddev-sans-first:16.94 12:15:40 INFO - PROCESS | 3840 | Values: 144.0 123.0 121.0 166.0 124.0 121.0 125.0 123.0 156.0 125.0 12:15:40 INFO - PROCESS | 3840 | 12:15:40 INFO - PROCESS | 3840 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 12:15:40 INFO - PROCESS | 3840 | Values: 159.0 159.0 162.0 159.0 161.0 161.0 160.0 160.0 159.0 159.0 12:15:40 INFO - PROCESS | 3840 | 12:15:40 INFO - PROCESS | 3840 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.50 stddev:13.82 (18.3%) stddev-sans-first:14.44 12:15:40 INFO - PROCESS | 3840 | Values: 75.0 75.0 75.0 115.0 77.0 75.0 76.0 76.0 99.0 75.0 12:15:40 INFO - PROCESS | 3840 | 12:15:40 INFO - PROCESS | 3840 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:81.00 stddev:15.18 (18.7%) stddev-sans-first:15.76 12:15:40 INFO - PROCESS | 3840 | Values: 81.0 81.0 120.0 81.0 82.0 81.0 97.0 81.0 81.0 114.0 12:15:40 INFO - PROCESS | 3840 | 12:15:40 INFO - PROCESS | 3840 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 12:15:40 INFO - PROCESS | 3840 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 12:15:40 INFO - PROCESS | 3840 | 12:15:40 INFO - PROCESS | 3840 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 12:15:40 INFO - PROCESS | 3840 | Values: 145.0 146.0 146.0 146.0 146.0 145.0 147.0 146.0 146.0 145.0 12:15:40 INFO - PROCESS | 3840 | 12:15:40 INFO - PROCESS | 3840 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 12:15:40 INFO - PROCESS | 3840 | Values: 84.0 84.0 84.0 84.0 84.0 85.0 84.0 85.0 84.0 84.0 12:15:40 INFO - PROCESS | 3840 | 12:15:40 INFO - PROCESS | 3840 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:50.00 stddev:1.23 (2.5%) stddev-sans-first:0.78 12:15:40 INFO - PROCESS | 3840 | Values: 53.0 50.0 49.0 49.0 49.0 51.0 51.0 50.0 50.0 50.0 12:15:40 INFO - PROCESS | 3840 | 12:15:40 INFO - PROCESS | 3840 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 12:15:40 INFO - PROCESS | 3840 | Values: 59.0 59.0 59.0 60.0 59.0 59.0 58.0 57.0 58.0 59.0 12:15:40 INFO - PROCESS | 3840 | 12:15:40 INFO - PROCESS | 3840 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:75.00 stddev:3.46 (4.6%) stddev-sans-first:3.64 12:15:40 INFO - PROCESS | 3840 | Values: 75.0 75.0 74.0 76.0 84.0 74.0 74.0 74.0 75.0 81.0 12:15:40 INFO - PROCESS | 3840 | 12:15:40 INFO - PROCESS | 3840 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:133.50 stddev:13.29 (10.0%) stddev-sans-first:14.00 12:15:40 INFO - PROCESS | 3840 | Values: 130.0 125.0 140.0 123.0 126.0 128.0 124.0 137.0 165.0 147.0 12:15:40 INFO - PROCESS | 3840 | 12:15:40 INFO - PROCESS | 3840 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.10 Median:156.00 stddev:3.03 (1.9%) stddev-sans-first:3.14 12:15:40 INFO - PROCESS | 3840 | Values: 158.0 155.0 156.0 162.0 160.0 156.0 153.0 154.0 153.0 154.0 12:15:40 INFO - PROCESS | 3840 | 12:15:40 INFO - PROCESS | 3840 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.50 stddev:2.17 (3.4%) stddev-sans-first:2.30 12:15:40 INFO - PROCESS | 3840 | Values: 64.0 62.0 69.0 63.0 64.0 64.0 62.0 63.0 63.0 61.0 12:15:40 INFO - PROCESS | 3840 | -------- Summary: end -------- 12:15:40 INFO - PROCESS | 3840 | 12:15:41 INFO - TEST-INFO | 3840: exit 0 12:15:41 INFO - TEST-OK | kraken | took 60030ms 12:15:41 INFO - SUITE-END | took 1177s 12:15:41 INFO - Completed test suite (00:19:37) 12:15:41 INFO - javascript benchmark 12:15:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3191.170295723112, 3232.8221947792863, 3244.935101297973, 3268.460703983843, 3279.8360081995893, 5530.308711411074, 5588.524975377088, 5589.413111623282, 5610.831675049745, 5624.550035997116, 5513.641613295143, 5550.056490396632, 5550.16747487877, 5563.582731295149, 5600.383957764642, 5020.0712868119335, 5037.017781532602, 5068.062408454448, 5113.258577506259, 5116.079105760961, 5000.124978128831, 5023.271625614284, 5094.337736094302, 5131.538161565459, 5137.280780690707, 5073.771680274396, 5085.135526960407, 5111.872203194913, 5140.1518749406305, 5152.278680984665, 5150.3047088642925, 5217.034848553029, 5220.112580861262, 5228.8692782680355, 5247.527722504955, 4884.755762211875, 5086.46592107827, 5114.335136432277, 5142.537171654569, 5181.766820493087, 5465.344158700942, 5471.042567550663, 5489.478499542537, 5500.862478438031, 5519.613627046108, 5899.882002359929, 5951.4941229995065, 6016.518678505709, 6017.879642407172, 6031.788887388921, 5832.1834943108, 6081.391860813927, 6092.786752463687, 6113.419225173601, 6117.021276595768, 5447.754851031753, 5494.945050549523, 5496.725163741797, 5519.834404967857, 5537.667739935617, 6053.636781793019, 6062.120992456069, 6062.42406971337, 6070.878582428327, 6076.939230607637, 5745.626534275259, 5802.970985145132, 5803.158542011384, 5807.767689292466, 5809.82570522885, 5871.089981052944, 5904.321003084614, 5930.199423077829, 5945.078512830518, 6037.245344331958, 5986.102084687332, 5990.041593345044, 5994.940050599438, 5996.610220335664, 6030.517558595302, 5955.434233747787, 5988.6706231157705, 5993.190919225936, 5994.3705910878725, 6014.939850601438, 4438.356438316426, 4463.0, 4586.449626044896, 4606.193916064675, 4616.838410655611, 4105.507339119325, 4119.0, 4131.97934010328, 4156.771377574262, 4183.769892655933, 5739.8565035874435, 5749.425057494217, 5752.856178595485, 5756.395578464285, 5758.3665796762325, 5820.156077368758, 5885.911711324334, 5962.910556341659, 6022.18700475439, 6048.123022161762, 5739.655620662774, 5743.827685169452, 5745.195672605839, 5752.798652047159, 5783.103618939072, 5195.610329225323, 5207.7916883325, 5211.973940130275, 5219.347581552306, 5247.10799164143, 5945.851353716192, 6006.729697163551, 6080.452759251689, 6256.155419018465, 6268.122462855204, 5892.175095486721, 5988.910166347421, 5998.3401825798255, 6031.065184896348, 6031.306399764083, 6177.042558403455, 6184.0, 6191.288001879661, 6195.349488303663, 6200.286966998672, 5755.539556835527, 5756.798512052058, 5875.559333050124, 5876.412358764261, 5878.2358293421585, 5866.354700982974, 5907.9704601476715, 5908.409159084057, 5957.463828255304, 6016.458518733335, 5802.738876750641, 5837.912431313619, 5839.795607153729, 5841.795537156179, 5843.7370318336625, 5676.943230567642, 5804.883902322014, 5825.912611310749, 5830.0, 5830.53355731549, 5613.46672066153, 5628.943710562842, 5656.151577263443, 5657.971710141423, 5723.3418156912485, 5774.711264436677, 5776.046952252831, 5777.8555536111935, 5786.334571524329, 5787.56593255516, 5509.972450137724, 5563.304586926634, 5572.60991730575, 5609.691466969192, 5610.635308704921], "value": 5498.350018368036, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.5108158065644, 612.2163630552892, 647.4464332995288, 658.8484648530838, 670.1087553553774, 34728.0, 44749.32876006862, 45853.31220031694, 45862.541374586246, 45872.77063614686, 45818.0, 46300.379486717975, 46492.0, 46538.0, 46586.30120548195, 8713.085126061767, 8851.911480885205, 8862.689805856797, 8868.822623547525, 8874.245689116433, 8767.298616110696, 8816.206541411271, 8841.690540831072, 8854.158854908806, 8862.734117976439, 8885.333599979995, 8899.110088991114, 8915.1976322131, 8930.0, 8946.150115738994, 8807.823843523125, 8837.646494140226, 8850.867236991451, 8858.557072146432, 8861.556922153899, 8725.650973961034, 8835.425697329652, 8837.337199709984, 8845.778855528662, 8854.203121719076, 36426.817865910765, 36998.63001369979, 37104.81447592745, 37122.0, 37152.81423592865, 3592.5868525119686, 3783.2433513297174, 3854.1713531590563, 4036.858709945138, 4056.898577535556, 33372.33255334904, 33390.165245868804, 33484.162895927555, 33846.32307353864, 34963.0, 4530.932036019462, 4566.429196350457, 4575.290829921334, 4665.160271151191, 4688.249880019181, 343246.0, 345790.0, 345885.0, 347504.2624786885, 350251.0, 38022.42966355507, 60352.39647603468, 60741.39258607446, 60866.391336086956, 60890.08664870031, 38806.41790373147, 40930.0, 41102.58897410987, 41143.38284925729, 41149.38275925864, 17063.061531615633, 17221.7416738749, 17234.913825431042, 17244.655106897793, 17263.309467621406, 14363.56909292723, 14365.78451323231, 14405.351759170862, 14407.855921440652, 14412.207328596818, 9485.33602647808, 9487.857682134774, 9519.714408567754, 9567.808643827084, 9586.520673966274, 3511.736619753529, 3597.5143355647174, 3598.7480876338927, 3604.3151801157696, 3618.8914332570066, 982.2682101834037, 1025.8820235672993, 1046.2362475393006, 1083.4528563075596, 1092.6066616018227, 32929.34141317208, 33456.832715836754, 33838.0, 33957.151071223416, 33973.0, 925.9120383563551, 971.606499367743, 975.1418751498777, 985.1232403161192, 1076.6554702495127, 16710.0, 17839.095052244753, 17880.0, 17935.632850338203, 18519.72220416695, 557644.0, 559475.0, 560479.0, 560956.0, 563185.0, 61827.6908615454, 62404.68797656074, 62411.68794156091, 62423.375766242665, 62435.0, 1322.5833862333334, 1322.8809407153403, 1371.149887070003, 1421.3532842556613, 1444.0902231594027, 30980.53529197109, 35014.82492587521, 35069.0, 35158.472622910165, 35199.64800352066, 53081.0, 53816.0, 53828.730856345464, 53848.0, 53863.73068134791, 421003.0, 422142.0, 424779.0, 425437.0, 427957.0, 27798.0, 28589.28526786847, 29637.110886673436, 31169.68830311668, 31539.211519711273, 45592.0, 47375.0, 47534.762326188145, 48109.0, 48439.0, 41152.58847411488, 41835.372469412374, 42159.36760948649, 42451.0, 43309.75176861685, 41751.58248417477, 41842.16315673609, 41858.790706046275, 42550.14899702051, 43419.782901085295, 41582.79208603938, 43256.13487730165, 44790.0, 45298.0, 46478.302825456965, 35538.82230588831, 37693.81153094217, 38085.23829523449, 38765.806170968965, 39038.219235615696, 27943.72056279411, 27950.3012424691, 27983.720162798112, 28074.0, 28171.295717607223], "value": 19511.822655833785, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.5959019750841, 423.93640953856897, 429.14171656686625, 434.876060322808, 442.4822957140146, 18392.632147357046, 19313.903430482846, 19438.319658811943, 19733.309334173307, 20105.39683809486, 17291.39480118196, 18195.45413637593, 19601.50996225095, 19682.91743954082, 19822.207111715514, 5640.210370548116, 5830.941690583103, 5861.413858614147, 5867.090600956859, 5870.88258234835, 4177.248095342837, 4474.8881277967985, 5741.971290143543, 5838.357780644125, 5842.094475356326, 6477.287498375175, 6589.736410543573, 6597.47220222381, 6605.70274337656, 6612.933870661304, 6365.395287447708, 6499.967500162516, 6529.738810447577, 6535.313792051861, 6599.868002639944, 5607.186957891124, 5798.246227990334, 5813.476787089182, 5820.534357251409, 5821.941780582225, 23214.883925580434, 23431.179908703285, 23575.7642423577, 23657.171998979953, 23991.88004059986, 2486.788622967032, 2500.212433083591, 2502.449461118569, 2580.342012786746, 2582.9095981640553, 14585.708285834224, 15002.399904003827, 15109.47116850905, 15402.922985385114, 15764.605884852856, 1967.8228959393723, 1993.9700904486444, 2029.3607513633306, 2038.6024725178597, 2055.5580550181635, 79117.0, 79419.6029019857, 80517.59741201316, 81165.0, 82909.58545207296, 9555.952220238854, 10775.0, 11105.888941110647, 11285.943570282096, 11389.487473063731, 15666.295016724274, 15702.842971570366, 15704.60738481547, 15721.213939302988, 15724.842751572338, 8031.718889838944, 8156.918430815735, 8225.753227403187, 8359.58202089893, 8404.747857564284, 7996.160403157584, 8093.109757926623, 8205.350629891831, 8237.052738934979, 8525.44584601999, 6816.909294512854, 6880.928501215028, 6905.0, 6967.895481567781, 6998.75504357345, 1809.312461264711, 1853.3883818339916, 1903.45751460833, 1934.177974360891, 1975.7969863602268, 889.2974550105473, 972.844344904826, 999.1956475037664, 1003.508280942333, 1011.8532812742111, 18297.542561435803, 19593.902030489757, 19748.012599369973, 19948.60102797936, 20359.796402036085, 949.8670186173941, 989.1394486796389, 1000.4397537379091, 1031.4842578710645, 1044.4621020174616, 10551.630692925864, 11150.714103608741, 11244.212905096729, 11318.377489238006, 11440.141989350832, 431848.0, 434499.0, 451730.0, 453874.0, 459995.0, 81428.59285703534, 81622.59188704018, 81789.0, 82495.0, 85212.57393713116, 1014.8376259798397, 1027.1679939249082, 1044.8902865199045, 1046.1892033673812, 1047.5390828035793, 16751.664966700842, 16767.245473953946, 17152.313907443564, 17528.035958022432, 17858.285668573113, 39310.0, 40363.394549082375, 40522.39216411697, 40848.0, 40875.18249634931, 51455.0, 52316.0, 52425.47574524206, 52511.21233181582, 53211.46788532065, 8485.0, 8747.91252087471, 8789.428687135316, 8880.73357799267, 9001.549922503718, 12715.80926286088, 12910.160839545399, 13327.66680832948, 13421.0, 13559.389827457591, 7785.610719464117, 11038.227324087236, 11183.832242516532, 11370.602028928948, 11635.0, 11098.722531936442, 11444.370559619301, 11651.242669226473, 11771.882281177079, 11953.163278570417, 11328.773424531628, 11602.6519204424, 11663.125265604944, 11743.295402275891, 11862.762744744885, 7817.218278172138, 8279.37904657141, 8298.834023319621, 8708.738737837875, 8783.472991620523, 8822.470651760916, 11128.721781955515, 11449.370284634426, 11515.712107197387, 11519.596814111466], "value": 9423.257364624364, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1438.3239877257688, 1482.5107714454232, 1599.736043552814, 1716.622343084521, 1764.7970483394413, 8049.396295277856, 8529.445586036903, 8537.231649151576, 8578.74263772087, 8587.355948303879, 7501.5874126923, 7686.5003774754605, 7687.538747675143, 7859.764207073783, 8410.032846222686, 2268.104098880941, 2451.9019239230497, 2542.0467324753217, 2548.566743653583, 2549.3244290263096, 2520.596704527276, 2551.9744802551922, 2559.7184309725917, 2560.9231723048247, 2611.7388261173824, 2480.9875950620312, 2498.600223964166, 2521.5839386501207, 2523.74762523748, 2528.342630915966, 2441.7314095449487, 2463.8275320727557, 2469.320936742401, 2469.790067844235, 2473.0973194783955, 2495.7878580320694, 2543.7964962803117, 2548.745125487455, 2549.783268422186, 2550.5664037113734, 8481.321494280442, 8554.358423118229, 8560.01559820616, 8570.27152692022, 8809.779755506099, 5566.415526369713, 5677.914831277534, 5716.57125715573, 5719.399463056402, 5726.026575482178, 3411.727061835047, 3483.2162763378037, 3658.2317713280245, 3680.0, 3698.0754811297174, 1259.1563652352945, 1278.284160869916, 1308.3523655790445, 1357.6673714939902, 2230.587341341857, 11903.285802851857, 12674.619761407173, 12686.238825670489, 12706.745865082647, 12708.555200568027, 5100.5409513143995, 5125.948740512547, 5156.252343410185, 5189.0, 5198.532132108053, 10248.48757562119, 10257.58969641221, 10268.537915793808, 10281.485925703684, 10284.485775711184, 5734.799282025109, 5738.0, 5740.368559458456, 5740.741666625012, 5756.56825738063, 4563.498015218323, 5050.595952323805, 5134.486551344836, 5155.226715992556, 5230.215467679878, 3795.1650636859845, 3954.446377507094, 4075.0, 4101.97949010259, 4123.463949686581, 1271.790154624495, 1283.0954177305164, 1291.4511332683571, 1297.9156354836905, 1305.7323248733987, 649.217692680319, 690.8031211104911, 814.5194335342177, 827.470418931872, 867.4578388507183, 5901.616394934315, 6006.699665016819, 6022.759089636365, 6153.4154255345675, 6198.845028874314, 836.9623366948501, 854.431802851097, 926.7080869526078, 930.4882314726873, 974.4786539201635, 3901.308097412833, 3979.2837289287627, 4071.531773845986, 4116.608922152391, 4132.586741325904, 10681.893181068246, 11216.943915280535, 11251.268667536584, 11300.886991130148, 11321.660350189508, 10910.509027093642, 10921.235513514137, 11108.16688748347, 11128.0, 11155.219134660496, 8347.457415267989, 8404.0, 8600.913990860012, 8611.0, 8692.478451292942, 5862.4791339724325, 5955.970220148872, 5965.612235204698, 6073.514118870568, 6101.237345331833, 10259.487025648838, 10263.127634150882, 10334.689959300933, 10340.37957722539, 10381.532831022772, 10121.544530495998, 10171.440570768678, 10298.639547615798, 10336.276460647983, 10457.68626941193, 7567.9243207569425, 7730.497517661334, 7741.651625676971, 7763.92236077632, 7768.728094516665, 7412.221716719667, 7718.498297610638, 8101.513909165469, 8395.622197001028, 8412.62143203545, 7747.496412733154, 7801.29788319054, 7810.258025487569, 7935.0874649416055, 7945.0863150736095, 7270.600116993616, 7492.363149132385, 7507.812304692427, 7509.66206520697, 7686.57723825195, 6885.724571017103, 7022.1924478685605, 7029.472789540702, 7034.718611255493, 7039.120109986252, 5021.598272138293, 5065.721385323843, 5080.771365288497, 5159.922601161061, 5228.895422091613, 5020.748962551931, 5043.344365232496, 5134.10153223177, 5183.300254465599, 5229.294045303987], "value": 4735.949274818553, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.089544572822, 348.2130385329156, 350.9806960617165, 351.493848857645, 357.73885063903367, 5161.483851614837, 5283.947160528393, 5323.65396249244, 5350.919736203955, 5355.598330125242, 5130.2817605535165, 5228.92156617651, 5272.789088436458, 5276.0, 5290.788368465266, 4168.854090106847, 4170.0, 4174.394712766654, 4191.140816132701, 4202.138561594866, 4060.553339132693, 4147.543770185277, 4204.2432362174795, 4207.873763787076, 4215.957840421603, 4135.42104105424, 4138.524069731974, 4139.917201655965, 4140.337545992642, 4161.542230354658, 4111.979440102796, 4126.876193714178, 4137.8551750688885, 4153.836925660819, 4160.355144952538, 3672.6143754905615, 3675.779453232788, 3679.816009199529, 3680.0615842959874, 3688.133288677159, 5104.744762761847, 5189.3772747270195, 5191.5846732261325, 5192.636515443921, 5210.895782084337, 4732.645051621108, 4732.787024583902, 4737.336772851803, 4739.19433696269, 4751.7624118794265, 5524.171374293848, 5537.723113844291, 5548.195511650828, 5551.944480555224, 5555.694436805974, 3812.8474861005525, 3969.2458432897656, 3989.40158976153, 4006.4791577094793, 4012.134357523736, 5692.8861422771315, 5721.742521586539, 5727.455891690282, 5746.971265143689, 5763.4812866842185, 4074.9796251018556, 4102.50769907613, 4103.158852435244, 4112.527059388209, 4115.97942010288, 3972.0338432475532, 4043.534993475788, 4131.29767939451, 4133.297339452301, 4178.540360560336, 4718.8584342469785, 4720.645951553579, 4720.693154944917, 4721.5750582447745, 4758.214894542431, 5499.835004949858, 5525.585581081435, 5582.49757521825, 5612.214289999321, 5637.802676906289, 1292.849364065982, 1299.7270573179549, 1299.958786638924, 1358.2054498118514, 1382.5783136143373, 927.2363476648259, 951.6669165791917, 954.9856752148723, 958.1807554540767, 959.8673565193, 5179.197224430144, 5186.792528298825, 5187.0, 5197.7401129943355, 5202.4277329493725, 5431.2396264522995, 5436.537894278951, 5451.974154344298, 5462.0, 5477.645272008763, 4934.3338649282605, 5120.820771272987, 5173.689578625294, 5178.482151784867, 5210.843674689765, 2892.3679451698854, 2893.9276518086795, 2895.6669982951807, 2900.8984685535906, 2903.5209190483333, 5620.791529821108, 5624.353199382042, 5634.915476267859, 5635.718214089279, 5638.210650508932, 5268.9736551317765, 5475.397706252309, 5520.23988005997, 5569.972150139223, 5571.0, 5537.640053396516, 5661.188419705654, 5662.320521537442, 5673.546116310686, 5678.829635110953, 5228.424873263862, 5404.621676482609, 5408.405075441619, 5436.510714035598, 5462.508374246337, 5330.361471071844, 5354.303940487712, 5364.839054828361, 5372.0, 5377.919331210113, 5567.468946039709, 5598.636088654224, 5601.759296281357, 5619.049998750688, 5655.179998900218, 3841.788701621326, 3930.2510382880487, 3955.6835453163103, 3976.5426975896985, 3985.123272879962, 5412.810551630674, 5413.83758487246, 5422.8373148805595, 5460.863478413072, 5484.396716361277, 5447.0, 5496.945030549643, 5581.330240371019, 5586.0, 5592.245046918777, 5567.3040869891265, 5583.8172241823395, 5590.161475778666, 5602.467765562265, 5610.214569960291, 5294.205869119663, 5523.8066667668045, 5532.557395408438, 5544.780148367353, 5564.582656300875, 5568.997580435398, 5611.719414029364, 5638.23883775685, 5648.85877853057, 5658.236138121301, 5478.863028424321, 5518.751656175402, 5521.365043019943, 5524.944750552443, 5530.391656917655], "value": 4187.761922575284, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.5685837501808, 789.7670187294748, 790.5098838719995, 834.2325060943931, 876.5923845411883, 13622.386992585332, 14396.49612263571, 14903.105813651175, 15841.762373564392, 15862.68274634508, 13503.459861605548, 13708.0, 13715.588532344022, 13718.51985180519, 13728.0, 704.696980298474, 721.1094298541298, 818.991810081899, 826.6817275348974, 830.7092517618845, 812.0417906869891, 828.7638023163399, 836.9245519507434, 837.7528629054443, 839.6977088248226, 869.6130222051158, 874.0953113527501, 874.2175752701329, 874.5802015032756, 874.8119154381807, 736.3372964332091, 748.6443939128925, 869.0266901070778, 869.4001139213954, 869.6217145541679, 624.1386886097202, 630.3412933484474, 638.6710843915388, 640.9615423074583, 641.3874749614107, 14917.0, 14925.701485970329, 14973.1016139032, 14974.101553906801, 14981.550553483414, 12650.81023784644, 12651.367431628381, 12901.2904290264, 12991.350432478434, 13000.739985200244, 12730.0, 12869.678258043623, 12945.935270323587, 13064.281464519448, 13262.734745305137, 4280.636145927569, 4303.569643035703, 4342.826286948518, 4359.760213188273, 4433.6009759121835, 54681.72659136679, 61234.0, 63011.684941575455, 64071.67964160196, 64601.353986460475, 10909.618163364245, 11477.368744718953, 11564.453580809533, 11713.062954963752, 11766.823497647541, 19579.216831326874, 20342.694859577117, 20517.89741051285, 20540.0, 20650.483737906674, 8555.0, 8606.31149508038, 8708.651653933772, 8764.8685269721, 9000.23498002664, 4446.177457170434, 4724.291356296583, 4724.787384567703, 4765.5949244314625, 4818.68678535901, 3378.7803792753393, 3502.754807163474, 3504.369213541536, 3506.0708912138302, 3513.9648603513638, 635.4503354598331, 645.5061877663591, 655.3119224813927, 658.1739916404881, 658.4896705053621, 585.3765739487433, 639.2041907824788, 670.902719105727, 695.8121307247117, 704.7779949315949, 9390.984177530021, 9661.372010819274, 9699.418034917928, 9721.756956076155, 9861.457619830979, 673.474689742002, 677.47495690839, 702.5222848463094, 707.989380159298, 725.9165196002527, 4478.39541661878, 4523.457185137804, 4687.10944920464, 4705.882352941204, 4750.904981900343, 51628.74185629123, 58766.70616646975, 77322.6133869327, 83535.0, 89674.0, 44754.55245447569, 46833.29750053752, 47019.5298047022, 73634.63182684052, 75804.0, 59424.40575594275, 59811.40188598058, 60119.0, 68756.6562167196, 72575.0, 9898.75253118649, 10016.549255283675, 10186.847197291898, 10239.641612543524, 10308.793824123626, 44327.33508997432, 44892.326615101454, 45019.32471013003, 46656.0, 46761.76619116883, 54608.72695636496, 54786.45213547813, 56922.43077569337, 58166.4183358161, 62299.688501559016, 12793.104482686123, 12984.091113621957, 12993.025523085995, 13077.215367078006, 13080.75732805382, 13446.327683615977, 14197.0, 14239.288035597972, 14255.572332830032, 14408.567742967727, 13042.413091410719, 13371.866281337452, 13472.0, 14207.147571145764, 14937.178455184634, 12997.870021299666, 13142.211467311992, 13810.240436776074, 13994.930025349808, 14728.189949552878, 12664.810027849406, 12934.547290845152, 13290.800637990245, 14115.858841411455, 14293.57119286423, 11481.425928703364, 11542.841299547315, 11686.298822070703, 11724.296542207494, 12001.699957500783, 11659.242149260272, 11859.288442693465, 11905.166638335233, 11941.52233910634, 11999.280043197436], "value": 7182.225659486526, "unit": "score"}], "name": "dromaeo_css", "value": 7239.975639240932, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 112.0, 111.0, 112.0, 111.0, 112.0, 113.0, 111.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 123.0, 121.0, 166.0, 124.0, 121.0, 125.0, 123.0, 156.0, 125.0], "value": 132.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 162.0, 159.0, 161.0, 161.0, 160.0, 160.0, 159.0, 159.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 115.0, 77.0, 75.0, 76.0, 76.0, 99.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 120.0, 81.0, 82.0, 81.0, 97.0, 81.0, 81.0, 114.0], "value": 89.9, "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, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 49.0, 49.0, 49.0, 51.0, 51.0, 50.0, 50.0, 50.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 58.0, 57.0, 58.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 76.0, 84.0, 74.0, 74.0, 74.0, 75.0, 81.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 125.0, 140.0, 123.0, 126.0, 128.0, 124.0, 137.0, 165.0, 147.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 155.0, 156.0, 162.0, 160.0, 156.0, 153.0, 154.0, 153.0, 154.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 69.0, 63.0, 64.0, 64.0, 62.0, 63.0, 63.0, 61.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1462.1000000000001, "alertThreshold": 2.0}]} 12:15:41 INFO - Return code: 0 12:15:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:15:41 ERROR - # TBPL SUCCESS # 12:15:41 INFO - Running post-action listener: _resource_record_post_action 12:15:41 INFO - [mozharness: 2016-11-14 20:15:41.445368Z] Finished run-tests step (success) 12:15:41 INFO - Running post-run listener: _resource_record_post_run 12:15:41 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8183808; Write bytes: 391086080; Read time: 2096; Write time: 283120 12:15:41 INFO - TinderboxPrint: CPU usage
13.0% 12:15:41 INFO - TinderboxPrint: I/O read bytes / time
8,183,808 / 2,096 12:15:41 INFO - TinderboxPrint: I/O write bytes / time
391,086,080 / 283,120 12:15:41 INFO - TinderboxPrint: CPU idle
8,291.2 (87.0%) 12:15:41 INFO - TinderboxPrint: CPU user
1,190.8 (12.5%) 12:15:41 INFO - TinderboxPrint: Swap in / out
0 / 0 12:15:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 16048128; Read time: 0; Write time: 12380 12:15:41 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 5795840; Write bytes: 375037952; Read time: 1544; Write time: 270740 12:15:42 INFO - Running post-run listener: _upload_blobber_files 12:15:42 INFO - Blob upload gear active. 12:15:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:15:42 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 12:15:42 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:15:42 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:15:42 INFO - (blobuploader) - INFO - Open directory for files ... 12:15:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:15:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:15:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:43 INFO - (blobuploader) - INFO - Done attempting. 12:15:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:15:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:15:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:47 INFO - (blobuploader) - INFO - Done attempting. 12:15:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:15:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:15:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:48 INFO - (blobuploader) - INFO - Done attempting. 12:15:48 INFO - (blobuploader) - INFO - Iteration through files over. 12:15:48 INFO - Return code: 0 12:15:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:15:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:15:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ee41e4b21396ff694d1df8bdd50e0c07e635fc94b97683a0422274319e1bab33cb3b4ecce107b9948c64fd0227c7d1cf92a24341d4de6df931375b7f725832a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df48b0bfb95a5e21ea5f07527ba592031941fd1fd26cd6d9c431ef8ef7c987d503bef1d0b93ea951930f556526c515d76fac07ca3f9a1d23f2484c323a599056", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a1d3d4ffe7a129c3ad1c70bb5f3e7be83463020c8f94e2a1cd7c8dcc4f241b9c7afa754bc85e7516305f0649c3ef6256392cfff5bfe9b95261c611dd5fee0ca4"} 12:15:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:15:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:15:48 INFO - Contents: 12:15:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ee41e4b21396ff694d1df8bdd50e0c07e635fc94b97683a0422274319e1bab33cb3b4ecce107b9948c64fd0227c7d1cf92a24341d4de6df931375b7f725832a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df48b0bfb95a5e21ea5f07527ba592031941fd1fd26cd6d9c431ef8ef7c987d503bef1d0b93ea951930f556526c515d76fac07ca3f9a1d23f2484c323a599056", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a1d3d4ffe7a129c3ad1c70bb5f3e7be83463020c8f94e2a1cd7c8dcc4f241b9c7afa754bc85e7516305f0649c3ef6256392cfff5bfe9b95261c611dd5fee0ca4"} 12:15:48 INFO - Running post-run listener: copy_logs_to_upload_dir 12:15:48 INFO - Copying logs to upload dir... 12:15:48 INFO - mkdir: /builds/slave/test/build/upload/logs 12:15:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.043740 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-11-14 12:15:48.071489) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 12:15:48.075503) ========= 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=6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ee41e4b21396ff694d1df8bdd50e0c07e635fc94b97683a0422274319e1bab33cb3b4ecce107b9948c64fd0227c7d1cf92a24341d4de6df931375b7f725832a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df48b0bfb95a5e21ea5f07527ba592031941fd1fd26cd6d9c431ef8ef7c987d503bef1d0b93ea951930f556526c515d76fac07ca3f9a1d23f2484c323a599056", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a1d3d4ffe7a129c3ad1c70bb5f3e7be83463020c8f94e2a1cd7c8dcc4f241b9c7afa754bc85e7516305f0649c3ef6256392cfff5bfe9b95261c611dd5fee0ca4"} build_url:https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ee41e4b21396ff694d1df8bdd50e0c07e635fc94b97683a0422274319e1bab33cb3b4ecce107b9948c64fd0227c7d1cf92a24341d4de6df931375b7f725832a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df48b0bfb95a5e21ea5f07527ba592031941fd1fd26cd6d9c431ef8ef7c987d503bef1d0b93ea951930f556526c515d76fac07ca3f9a1d23f2484c323a599056", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a1d3d4ffe7a129c3ad1c70bb5f3e7be83463020c8f94e2a1cd7c8dcc4f241b9c7afa754bc85e7516305f0649c3ef6256392cfff5bfe9b95261c611dd5fee0ca4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 12:15:48.100882) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:15:48.101217) ========= 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=6dbc10da6d83fee962c624be000001a8-1479153302.990594-1874946230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004371 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:15:48.185217) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 12:15:48.185524) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 12:15:48.185813) ========= ========= Total master_lag: 0.18 =========