builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1479909708.87 results: success (0) buildid: 20161123030208 builduid: f4871a9f0cf64f1e8d578ca886745a14 revision: 0ddfec7126ec503b54df9c4b7c3b988906f6c882 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 06:01:48.865413) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 06:01:48.865868) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 06:01:48.866192) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 06:01:48.885260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 06:01:48.885557) ========= 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=920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-23 06:01:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.3M=0s 2016-11-23 06:01:49 (88.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.072357 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 06:01:48.987640) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 06:01:48.988007) ========= 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=920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020005 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 06:01:49.040957) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-23 06:01:49.041350) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0ddfec7126ec503b54df9c4b7c3b988906f6c882 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0ddfec7126ec503b54df9c4b7c3b988906f6c882 --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=920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-23 06:01:49,462 truncating revision to first 12 chars 2016-11-23 06:01:49,462 Setting DEBUG logging. 2016-11-23 06:01:49,462 attempt 1/10 2016-11-23 06:01:49,462 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0ddfec7126ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 06:01:50,303 unpacking tar archive at: mozilla-central-0ddfec7126ec/testing/mozharness/ program finished with exit code 0 elapsedTime=1.238533 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-23 06:01:50.297268) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 06:01:50.297585) ========= script_repo_revision: 0ddfec7126ec503b54df9c4b7c3b988906f6c882 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 06:01:50.298024) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 06:01:50.298290) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 06:01:50.308129) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-11-23 06:01:50.309055) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:01:50 INFO - MultiFileLogger online at 20161123 06:01:50 in /builds/slave/test 06:01:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:01:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:01:50 INFO - {'append_to_log': False, 06:01:50 INFO - 'base_work_dir': '/builds/slave/test', 06:01:50 INFO - 'blob_upload_branch': 'Firefox', 06:01:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:01:50 INFO - 'branch': 'Firefox', 06:01:50 INFO - 'buildbot_json_path': 'buildprops.json', 06:01:50 INFO - 'config_files': ('talos/linux_config.py',), 06:01:50 INFO - 'default_actions': ('clobber', 06:01:50 INFO - 'read-buildbot-config', 06:01:50 INFO - 'download-and-extract', 06:01:50 INFO - 'populate-webroot', 06:01:50 INFO - 'create-virtualenv', 06:01:50 INFO - 'install', 06:01:50 INFO - 'run-tests'), 06:01:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:01:50 INFO - 'download_minidump_stackwalk': True, 06:01:50 INFO - 'download_symbols': 'ondemand', 06:01:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:01:50 INFO - 'tooltool.py': '/tools/tooltool.py', 06:01:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:01:50 INFO - '/tools/misc-python/virtualenv.py')}, 06:01:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:01:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:01:50 INFO - 'installer_path': 'installer.exe', 06:01:50 INFO - 'log_level': 'info', 06:01:50 INFO - 'log_name': 'talos', 06:01:50 INFO - 'log_to_console': True, 06:01:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:01:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:01:50 INFO - 'opt_config_files': (), 06:01:50 INFO - 'pip_index': False, 06:01:50 INFO - 'sps_profile': False, 06:01:50 INFO - 'sps_profile_interval': 0, 06:01:50 INFO - 'suite': 'dromaeojs-e10s', 06:01:50 INFO - 'system_bits': '32', 06:01:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:01:50 INFO - 'title': 'talos-linux64-ix-053', 06:01:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:01:50 INFO - 'use_talos_json': True, 06:01:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:01:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:01:50 INFO - 'work_dir': 'build'} 06:01:50 INFO - [mozharness: 2016-11-23 14:01:50.820841Z] Running clobber step. 06:01:50 INFO - Running pre-action listener: _resource_record_pre_action 06:01:50 INFO - Running main action method: clobber 06:01:50 INFO - rmtree: /builds/slave/test/build 06:01:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:01:51 INFO - Running post-action listener: _resource_record_post_action 06:01:51 INFO - [mozharness: 2016-11-23 14:01:51.889696Z] Finished clobber step (success) 06:01:51 INFO - [mozharness: 2016-11-23 14:01:51.889805Z] Running read-buildbot-config step. 06:01:51 INFO - Running pre-action listener: _resource_record_pre_action 06:01:51 INFO - Running main action method: read_buildbot_config 06:01:51 INFO - Using buildbot properties: 06:01:51 INFO - { 06:01:51 INFO - "project": "", 06:01:51 INFO - "product": "firefox", 06:01:51 INFO - "script_repo_revision": "production", 06:01:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:01:51 INFO - "repository": "", 06:01:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 06:01:51 INFO - "buildid": "20161123030208", 06:01:51 INFO - "stage_platform": "linux64-pgo", 06:01:51 INFO - "basedir": "/builds/slave/test", 06:01:51 INFO - "nightly_build": "True", 06:01:51 INFO - "buildnumber": 429, 06:01:51 INFO - "slavename": "talos-linux64-ix-053", 06:01:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:01:51 INFO - "platform": "ubuntu64_hw", 06:01:51 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:01:51 INFO - "branch": "mozilla-central", 06:01:51 INFO - "repo_path": "mozilla-central", 06:01:51 INFO - "revision": "0ddfec7126ec503b54df9c4b7c3b988906f6c882", 06:01:51 INFO - "pgo_build": "True", 06:01:51 INFO - "builduid": "f4871a9f0cf64f1e8d578ca886745a14", 06:01:51 INFO - "slavebuilddir": "test" 06:01:51 INFO - } 06:01:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 06:01:51 INFO - Running post-action listener: _resource_record_post_action 06:01:51 INFO - [mozharness: 2016-11-23 14:01:51.892279Z] Finished read-buildbot-config step (success) 06:01:51 INFO - [mozharness: 2016-11-23 14:01:51.892367Z] Running download-and-extract step. 06:01:51 INFO - Running pre-action listener: _resource_record_pre_action 06:01:51 INFO - Running main action method: download_and_extract 06:01:51 INFO - mkdir: /builds/slave/test/build/tests 06:01:51 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')]} 06:01:51 INFO - trying https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 06:01:51 INFO - Downloading https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 06:01:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:01:52 INFO - Downloaded 1361 bytes. 06:01:52 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 06:01:52 INFO - Using the following test package requirements: 06:01:52 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 06:01:52 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:01:52 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:01:52 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:52 INFO - u'jsshell-linux-x86_64.zip'], 06:01:52 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:01:52 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 06:01:52 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:01:52 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:01:52 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:01:52 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:01:52 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:01:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 06:01:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:01:52 INFO - Fetch https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:01:53 INFO - Http code: 200 06:01:53 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 06:01:53 INFO - x-amz-cf-id: o9BTJErnq9ZpGBO_EfyIegwEKg6EkxpUgrkBUTz8vPbghmMvd4muWw== 06:01:53 INFO - x-amz-version-id: 8Gi4770hQrTbh3xKHcFOgPJBnLEwwnDq 06:01:53 INFO - Expected file size: 21764595 06:01:53 INFO - Obtained file size: 21764595 06:01:57 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:01:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 06:01:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:01:57 INFO - Fetch https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:01:57 INFO - Http code: 200 06:01:57 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 06:01:57 INFO - x-amz-cf-id: TAcQbF6n7nZzS9ggh2YhMh5451_mUQKQnvp5xQyARdmUV9YqCO9vuQ== 06:01:57 INFO - x-amz-version-id: 8Gi4770hQrTbh3xKHcFOgPJBnLEwwnDq 06:01:58 INFO - Expected file size: 21764595 06:01:58 INFO - Obtained file size: 21764595 06:02:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 06:02:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:02:02 INFO - Fetch https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:02:03 INFO - Http code: 200 06:02:03 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 06:02:03 INFO - x-amz-cf-id: lMBwEc3_Kw3Yk20IWaWwO7ol3ic7Pc9xu5_a5f1wyI6NpSPzauWL0A== 06:02:03 INFO - x-amz-version-id: Y5DXIv10oDtBeDm7SYO2n0SuXpsJ_j2x 06:02:03 INFO - Expected file size: 14409506 06:02:03 INFO - Obtained file size: 14409506 06:02: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')]} 06:02:03 INFO - trying https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 06:02:03 INFO - Downloading https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 06:02:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:02:04 INFO - Downloaded 59743453 bytes. 06:02:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 06:02:04 INFO - mkdir: /builds/slave/test/properties 06:02:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:02:04 INFO - Writing to file /builds/slave/test/properties/build_url 06:02:04 INFO - Contents: 06:02:04 INFO - build_url:https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 06:02:05 INFO - Running post-action listener: _resource_record_post_action 06:02:05 INFO - Running post-action listener: set_extra_try_arguments 06:02:05 INFO - [mozharness: 2016-11-23 14:02:05.286352Z] Finished download-and-extract step (success) 06:02:05 INFO - [mozharness: 2016-11-23 14:02:05.286576Z] Running populate-webroot step. 06:02:05 INFO - Running pre-action listener: _resource_record_pre_action 06:02:05 INFO - Running main action method: populate_webroot 06:02:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:02:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:02:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:02:05 INFO - '--tppagecycles', 06:02:05 INFO - '7'], 06:02:05 INFO - 'tests': ['tsvgm']}}, 06:02:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:02:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:02:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:02:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:02:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:02:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:02:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:02:05 INFO - 'talos_options': ['--disable-e10s'], 06:02:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:02:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:02:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:02:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:02:05 INFO - 'talos_options': ['--disable-e10s'], 06:02:05 INFO - 'tests': ['damp', 'tps']}, 06:02:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:02:05 INFO - 'tests': ['damp', 'tps']}, 06:02:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:02:05 INFO - 'tests': ['dromaeo_dom']}, 06:02:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:02:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:02:05 INFO - 'tests': ['basic_compositor_video']}, 06:02:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:02:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:02:05 INFO - 'tests': ['a11yr', 06:02:05 INFO - 'ts_paint', 06:02:05 INFO - 'tpaint', 06:02:05 INFO - 'sessionrestore', 06:02:05 INFO - 'sessionrestore_no_auto_restore', 06:02:05 INFO - 'tabpaint']}, 06:02:05 INFO - 'other-e10s': {'tests': ['a11yr', 06:02:05 INFO - 'ts_paint', 06:02:05 INFO - 'tpaint', 06:02:05 INFO - 'sessionrestore', 06:02:05 INFO - 'sessionrestore_no_auto_restore', 06:02:05 INFO - 'tabpaint']}, 06:02:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:02:05 INFO - 'ts_paint', 06:02:05 INFO - 'tpaint', 06:02:05 INFO - 'sessionrestore', 06:02:05 INFO - 'sessionrestore_no_auto_restore', 06:02:05 INFO - 'tabpaint']}, 06:02:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:02:05 INFO - 'ts_paint', 06:02:05 INFO - 'tpaint', 06:02:05 INFO - 'sessionrestore', 06:02:05 INFO - 'sessionrestore_no_auto_restore', 06:02:05 INFO - 'tabpaint']}, 06:02:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:02:05 INFO - 'tests': ['a11yr', 06:02:05 INFO - 'ts_paint', 06:02:05 INFO - 'tpaint', 06:02:05 INFO - 'sessionrestore', 06:02:05 INFO - 'sessionrestore_no_auto_restore', 06:02:05 INFO - 'tabpaint']}, 06:02:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:02:05 INFO - 'tests': ['a11yr', 06:02:05 INFO - 'ts_paint', 06:02:05 INFO - 'tpaint', 06:02:05 INFO - 'sessionrestore', 06:02:05 INFO - 'sessionrestore_no_auto_restore', 06:02:05 INFO - 'tabpaint']}, 06:02:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:02:05 INFO - 'tests': ['tsvgx', 06:02:05 INFO - 'tsvgr_opacity', 06:02:05 INFO - 'tart', 06:02:05 INFO - 'tscrollx', 06:02:05 INFO - 'cart']}, 06:02:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:02:05 INFO - 'tsvgr_opacity', 06:02:05 INFO - 'tart', 06:02:05 INFO - 'tscrollx', 06:02:05 INFO - 'cart']}, 06:02:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:02:05 INFO - 'talos_options': ['--disable-e10s'], 06:02:05 INFO - 'tests': ['tp5o']}, 06:02:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:02:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:02:05 INFO - 'talos_options': ['--disable-e10s', 06:02:05 INFO - '--xperf_path', 06:02:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:02:05 INFO - 'tests': ['tp5n']}, 06:02:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:02:05 INFO - 'talos_options': ['--xperf_path', 06:02:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:02:05 INFO - 'tests': ['tp5n']}}, 06:02:05 INFO - 'talos.zip': {'path': '', 06:02:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:02:05 INFO - Running post-action listener: _resource_record_post_action 06:02:05 INFO - [mozharness: 2016-11-23 14:02:05.301792Z] Finished populate-webroot step (success) 06:02:05 INFO - [mozharness: 2016-11-23 14:02:05.301882Z] Running create-virtualenv step. 06:02:05 INFO - Running pre-action listener: _resource_record_pre_action 06:02:05 INFO - Running main action method: create_virtualenv 06:02:05 INFO - Creating virtualenv /builds/slave/test/build/venv 06:02:05 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 06:02:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:02:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:02:05 INFO - Using real prefix '/usr' 06:02:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:02:05 INFO - Installing distribute.............................................................................................................................................................................................done. 06:02:07 INFO - Installing pip.................done. 06:02:07 INFO - Return code: 0 06:02:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:02:08 INFO - Reading from file tmpfile_stdout 06:02:08 INFO - Output received: 06:02:08 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) 06:02:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:02:08 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')]} 06:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:08 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')]} 06:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:08 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 0x7fcefb1b2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2651b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ed130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287bfc0>, '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 0x287cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, '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': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', '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 06:02:08 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 06:02:08 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 06:02:08 INFO - Using env: {'DISPLAY': ':0', 06:02:08 INFO - 'HOME': '/home/cltbld', 06:02:08 INFO - 'LANG': 'en_US.UTF-8', 06:02:08 INFO - 'LANGUAGE': 'en_US:en', 06:02:08 INFO - 'LOGNAME': 'cltbld', 06:02:08 INFO - 'MAIL': '/var/mail/cltbld', 06:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:08 INFO - 'MOZ_NO_REMOTE': '1', 06:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:08 INFO - 'NO_EM_RESTART': '1', 06:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:08 INFO - 'PWD': '/builds/slave/test', 06:02:08 INFO - 'SHELL': '/bin/bash', 06:02:08 INFO - 'SHLVL': '1', 06:02:08 INFO - 'TERM': 'linux', 06:02:08 INFO - 'TMOUT': '86400', 06:02:08 INFO - 'USER': 'cltbld', 06:02:08 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', 06:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:08 INFO - '_': '/tools/buildbot/bin/python'} 06:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:08 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 06:02:08 INFO - Cleaning up... 06:02:08 INFO - Return code: 0 06:02:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:02:08 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')]} 06:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:08 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')]} 06:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:08 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 0x7fcefb1b2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2651b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ed130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287bfc0>, '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 0x287cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, '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': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', '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 06:02:08 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 06:02:08 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 06:02:08 INFO - Using env: {'DISPLAY': ':0', 06:02:08 INFO - 'HOME': '/home/cltbld', 06:02:08 INFO - 'LANG': 'en_US.UTF-8', 06:02:08 INFO - 'LANGUAGE': 'en_US:en', 06:02:08 INFO - 'LOGNAME': 'cltbld', 06:02:08 INFO - 'MAIL': '/var/mail/cltbld', 06:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:08 INFO - 'MOZ_NO_REMOTE': '1', 06:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:08 INFO - 'NO_EM_RESTART': '1', 06:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:08 INFO - 'PWD': '/builds/slave/test', 06:02:08 INFO - 'SHELL': '/bin/bash', 06:02:08 INFO - 'SHLVL': '1', 06:02:08 INFO - 'TERM': 'linux', 06:02:08 INFO - 'TMOUT': '86400', 06:02:08 INFO - 'USER': 'cltbld', 06:02:08 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', 06:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:08 INFO - '_': '/tools/buildbot/bin/python'} 06:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:08 INFO - Downloading/unpacking psutil>=3.1.1 06:02:08 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 06:02:08 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 06:02:08 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 06:02:08 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 06:02:08 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 06:02:08 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 06:02:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:02:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:02:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:02:10 INFO - Installing collected packages: psutil 06:02:10 INFO - Running setup.py install for psutil 06:02:10 INFO - building 'psutil._psutil_linux' extension 06:02:10 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 06:02:10 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 06:02:10 INFO - building 'psutil._psutil_posix' extension 06:02:10 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 06:02:10 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 06:02:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:02:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:02:11 INFO - Successfully installed psutil 06:02:11 INFO - Cleaning up... 06:02:11 INFO - Return code: 0 06:02:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcefb1b2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2651b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ed130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287bfc0>, '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 0x287cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, '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': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', '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 06:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:02:11 INFO - Using env: {'DISPLAY': ':0', 06:02:11 INFO - 'HOME': '/home/cltbld', 06:02:11 INFO - 'LANG': 'en_US.UTF-8', 06:02:11 INFO - 'LANGUAGE': 'en_US:en', 06:02:11 INFO - 'LOGNAME': 'cltbld', 06:02:11 INFO - 'MAIL': '/var/mail/cltbld', 06:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:11 INFO - 'MOZ_NO_REMOTE': '1', 06:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:11 INFO - 'NO_EM_RESTART': '1', 06:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:11 INFO - 'PWD': '/builds/slave/test', 06:02:11 INFO - 'SHELL': '/bin/bash', 06:02:11 INFO - 'SHLVL': '1', 06:02:11 INFO - 'TERM': 'linux', 06:02:11 INFO - 'TMOUT': '86400', 06:02:11 INFO - 'USER': 'cltbld', 06:02:11 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', 06:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:11 INFO - '_': '/tools/buildbot/bin/python'} 06:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:02:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:02:13 INFO - Installing collected packages: mozsystemmonitor 06:02:13 INFO - Running setup.py install for mozsystemmonitor 06:02:13 INFO - Successfully installed mozsystemmonitor 06:02:13 INFO - Cleaning up... 06:02:13 INFO - Return code: 0 06:02:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcefb1b2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2651b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ed130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287bfc0>, '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 0x287cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, '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': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', '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 06:02:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:02:13 INFO - Using env: {'DISPLAY': ':0', 06:02:13 INFO - 'HOME': '/home/cltbld', 06:02:13 INFO - 'LANG': 'en_US.UTF-8', 06:02:13 INFO - 'LANGUAGE': 'en_US:en', 06:02:13 INFO - 'LOGNAME': 'cltbld', 06:02:13 INFO - 'MAIL': '/var/mail/cltbld', 06:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:13 INFO - 'MOZ_NO_REMOTE': '1', 06:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:13 INFO - 'NO_EM_RESTART': '1', 06:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:13 INFO - 'PWD': '/builds/slave/test', 06:02:13 INFO - 'SHELL': '/bin/bash', 06:02:13 INFO - 'SHLVL': '1', 06:02:13 INFO - 'TERM': 'linux', 06:02:13 INFO - 'TMOUT': '86400', 06:02:13 INFO - 'USER': 'cltbld', 06:02:13 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', 06:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:13 INFO - '_': '/tools/buildbot/bin/python'} 06:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:13 INFO - Downloading/unpacking jsonschema==2.5.1 06:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:02:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:02:15 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 06:02:15 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 06:02:15 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 06:02:15 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 06:02:15 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 06:02:15 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 06:02:15 INFO - Downloading functools32-3.2.3-2.tar.gz 06:02:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:02:15 INFO - warning: no files found matching '*.txt' 06:02:15 INFO - no previously-included directories found matching 'build' 06:02:15 INFO - no previously-included directories found matching 'dist' 06:02:15 INFO - no previously-included directories found matching '.git*' 06:02:15 INFO - Installing collected packages: jsonschema, functools32 06:02:16 INFO - Running setup.py install for functools32 06:02:16 INFO - warning: no files found matching '*.txt' 06:02:16 INFO - no previously-included directories found matching 'build' 06:02:16 INFO - no previously-included directories found matching 'dist' 06:02:16 INFO - no previously-included directories found matching '.git*' 06:02:16 INFO - Successfully installed jsonschema functools32 06:02:16 INFO - Cleaning up... 06:02:16 INFO - Return code: 0 06:02:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcefb1b2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2651b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ed130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287bfc0>, '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 0x287cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, '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': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', '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 06:02:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:02:16 INFO - Using env: {'DISPLAY': ':0', 06:02:16 INFO - 'HOME': '/home/cltbld', 06:02:16 INFO - 'LANG': 'en_US.UTF-8', 06:02:16 INFO - 'LANGUAGE': 'en_US:en', 06:02:16 INFO - 'LOGNAME': 'cltbld', 06:02:16 INFO - 'MAIL': '/var/mail/cltbld', 06:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:16 INFO - 'MOZ_NO_REMOTE': '1', 06:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:16 INFO - 'NO_EM_RESTART': '1', 06:02:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:16 INFO - 'PWD': '/builds/slave/test', 06:02:16 INFO - 'SHELL': '/bin/bash', 06:02:16 INFO - 'SHLVL': '1', 06:02:16 INFO - 'TERM': 'linux', 06:02:16 INFO - 'TMOUT': '86400', 06:02:16 INFO - 'USER': 'cltbld', 06:02:16 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', 06:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:16 INFO - '_': '/tools/buildbot/bin/python'} 06:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:02:16 INFO - Cleaning up... 06:02:16 INFO - Return code: 0 06:02:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcefb1b2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2651b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ed130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287bfc0>, '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 0x287cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, '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': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', '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 06:02:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:02:16 INFO - Using env: {'DISPLAY': ':0', 06:02:16 INFO - 'HOME': '/home/cltbld', 06:02:16 INFO - 'LANG': 'en_US.UTF-8', 06:02:16 INFO - 'LANGUAGE': 'en_US:en', 06:02:16 INFO - 'LOGNAME': 'cltbld', 06:02:16 INFO - 'MAIL': '/var/mail/cltbld', 06:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:16 INFO - 'MOZ_NO_REMOTE': '1', 06:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:16 INFO - 'NO_EM_RESTART': '1', 06:02:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:16 INFO - 'PWD': '/builds/slave/test', 06:02:16 INFO - 'SHELL': '/bin/bash', 06:02:16 INFO - 'SHLVL': '1', 06:02:16 INFO - 'TERM': 'linux', 06:02:16 INFO - 'TMOUT': '86400', 06:02:16 INFO - 'USER': 'cltbld', 06:02:16 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', 06:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:16 INFO - '_': '/tools/buildbot/bin/python'} 06:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:16 INFO - Downloading/unpacking blobuploader==1.2.4 06:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:18 INFO - Downloading blobuploader-1.2.4.tar.gz 06:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:02:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:02:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:19 INFO - Downloading docopt-0.6.1.tar.gz 06:02:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:02:19 INFO - Installing collected packages: blobuploader, requests, docopt 06:02:19 INFO - Running setup.py install for blobuploader 06:02:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:02:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:02:19 INFO - Running setup.py install for requests 06:02:19 INFO - Running setup.py install for docopt 06:02:19 INFO - Successfully installed blobuploader requests docopt 06:02:19 INFO - Cleaning up... 06:02:19 INFO - Return code: 0 06:02:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02:19 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')]} 06:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:19 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')]} 06:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:19 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 0x7fcefb1b2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2651b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ed130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287bfc0>, '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 0x287cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, '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': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', '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 06:02:19 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 06:02:19 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 06:02:19 INFO - Using env: {'DISPLAY': ':0', 06:02:19 INFO - 'HOME': '/home/cltbld', 06:02:19 INFO - 'LANG': 'en_US.UTF-8', 06:02:19 INFO - 'LANGUAGE': 'en_US:en', 06:02:19 INFO - 'LOGNAME': 'cltbld', 06:02:19 INFO - 'MAIL': '/var/mail/cltbld', 06:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:19 INFO - 'MOZ_NO_REMOTE': '1', 06:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:19 INFO - 'NO_EM_RESTART': '1', 06:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:19 INFO - 'PWD': '/builds/slave/test', 06:02:19 INFO - 'SHELL': '/bin/bash', 06:02:19 INFO - 'SHLVL': '1', 06:02:19 INFO - 'TERM': 'linux', 06:02:19 INFO - 'TMOUT': '86400', 06:02:19 INFO - 'USER': 'cltbld', 06:02:19 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', 06:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:19 INFO - '_': '/tools/buildbot/bin/python'} 06:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:02:20 INFO - Running setup.py (path:/tmp/pip-Qp8BjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:02:20 INFO - Running setup.py (path:/tmp/pip-y1esvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:02:20 INFO - Running setup.py (path:/tmp/pip-1Mb4yG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:02:20 INFO - Running setup.py (path:/tmp/pip-TjYkTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:02:20 INFO - Running setup.py (path:/tmp/pip-bapYDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:02:20 INFO - Running setup.py (path:/tmp/pip-Q7G2di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:02:20 INFO - Running setup.py (path:/tmp/pip-_8_jk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:02:20 INFO - Running setup.py (path:/tmp/pip-bRVJRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:02:20 INFO - Running setup.py (path:/tmp/pip-OA6WWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:02:20 INFO - Running setup.py (path:/tmp/pip-Wctgc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:02:20 INFO - Running setup.py (path:/tmp/pip-1V00dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:02:20 INFO - Running setup.py (path:/tmp/pip-UShzaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:02:21 INFO - Running setup.py (path:/tmp/pip-kawICs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:02:21 INFO - Running setup.py (path:/tmp/pip-SPsY5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:21 INFO - Running setup.py (path:/tmp/pip-K6Qj_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:02:21 INFO - Running setup.py (path:/tmp/pip-XgBr0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:02:21 INFO - Running setup.py (path:/tmp/pip-46smMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:02:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:02:21 INFO - Running setup.py install for manifestparser 06:02:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:02:21 INFO - Running setup.py install for mozcrash 06:02:21 INFO - Running setup.py install for mozdebug 06:02:21 INFO - Running setup.py install for mozdevice 06:02:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:02:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:02:21 INFO - Running setup.py install for mozfile 06:02:21 INFO - Running setup.py install for mozhttpd 06:02:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:02:22 INFO - Running setup.py install for mozinfo 06:02:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:02:22 INFO - Running setup.py install for mozInstall 06:02:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:02:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:02:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:02:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:02:22 INFO - Running setup.py install for mozleak 06:02:22 INFO - Running setup.py install for mozlog 06:02:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:02:22 INFO - Running setup.py install for moznetwork 06:02:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:02:22 INFO - Running setup.py install for mozprocess 06:02:22 INFO - Running setup.py install for mozprofile 06:02:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:02:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:02:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:02:22 INFO - Running setup.py install for mozrunner 06:02:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:02:22 INFO - Running setup.py install for mozscreenshot 06:02:22 INFO - Running setup.py install for moztest 06:02:23 INFO - Running setup.py install for mozversion 06:02:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:02:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:02:23 INFO - Cleaning up... 06:02:23 INFO - Return code: 0 06:02:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcefb1b2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2651b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ed130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287bfc0>, '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 0x287cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, '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': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', '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 06:02:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:02:23 INFO - Using env: {'DISPLAY': ':0', 06:02:23 INFO - 'HOME': '/home/cltbld', 06:02:23 INFO - 'LANG': 'en_US.UTF-8', 06:02:23 INFO - 'LANGUAGE': 'en_US:en', 06:02:23 INFO - 'LOGNAME': 'cltbld', 06:02:23 INFO - 'MAIL': '/var/mail/cltbld', 06:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:23 INFO - 'MOZ_NO_REMOTE': '1', 06:02:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:23 INFO - 'NO_EM_RESTART': '1', 06:02:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:23 INFO - 'PWD': '/builds/slave/test', 06:02:23 INFO - 'SHELL': '/bin/bash', 06:02:23 INFO - 'SHLVL': '1', 06:02:23 INFO - 'TERM': 'linux', 06:02:23 INFO - 'TMOUT': '86400', 06:02:23 INFO - 'USER': 'cltbld', 06:02:23 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', 06:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:23 INFO - '_': '/tools/buildbot/bin/python'} 06:02:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:02:23 INFO - Running setup.py (path:/tmp/pip-RI8wl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:02:23 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)) 06:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:02:23 INFO - Running setup.py (path:/tmp/pip-w239N3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:02:23 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)) 06:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:02:23 INFO - Running setup.py (path:/tmp/pip-isW9sK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:02:23 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)) 06:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:02:23 INFO - Running setup.py (path:/tmp/pip-n9hTKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:02:23 INFO - Running setup.py (path:/tmp/pip-JzStRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:02:23 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)) 06:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:02:23 INFO - Running setup.py (path:/tmp/pip-iI8cFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:02:23 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)) 06:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:02:23 INFO - Running setup.py (path:/tmp/pip-u1NwSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:02:23 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)) 06:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:02:23 INFO - Running setup.py (path:/tmp/pip-c3j6Hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:02:23 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)) 06:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:02:23 INFO - Running setup.py (path:/tmp/pip-fxB75Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:02:24 INFO - Running setup.py (path:/tmp/pip-Vu7VuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:02:24 INFO - Running setup.py (path:/tmp/pip-TggYIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:02:24 INFO - Running setup.py (path:/tmp/pip-1CiX6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:02:24 INFO - Running setup.py (path:/tmp/pip-a2vGW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:02:24 INFO - Running setup.py (path:/tmp/pip-s6jHMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:02:24 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)) 06:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:24 INFO - Running setup.py (path:/tmp/pip-A3Tb09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:24 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)) 06:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:02:24 INFO - Running setup.py (path:/tmp/pip-eF1BFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:02:24 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)) 06:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:02:24 INFO - Running setup.py (path:/tmp/pip-xlKWsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:02:24 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)) 06:02:24 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)) 06:02:24 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)) 06:02:24 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)) 06:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:02:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:26 INFO - Downloading blessings-1.6.tar.gz 06:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:02:26 INFO - Installing collected packages: blessings 06:02:26 INFO - Running setup.py install for blessings 06:02:26 INFO - Successfully installed blessings 06:02:26 INFO - Cleaning up... 06:02:26 INFO - Return code: 0 06:02:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:02:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:02:27 INFO - Reading from file tmpfile_stdout 06:02:27 INFO - Current package versions: 06:02:27 INFO - argparse == 1.2.1 06:02:27 INFO - blessings == 1.6 06:02:27 INFO - blobuploader == 1.2.4 06:02:27 INFO - docopt == 0.6.1 06:02:27 INFO - functools32 == 3.2.3-2 06:02:27 INFO - jsonschema == 2.5.1 06:02:27 INFO - manifestparser == 1.1 06:02:27 INFO - mozInstall == 1.12 06:02:27 INFO - mozcrash == 1.0 06:02:27 INFO - mozdebug == 0.1 06:02:27 INFO - mozdevice == 0.49 06:02:27 INFO - mozfile == 1.2 06:02:27 INFO - mozhttpd == 0.7 06:02:27 INFO - mozinfo == 0.9 06:02:27 INFO - mozleak == 0.1 06:02:27 INFO - mozlog == 3.4 06:02:27 INFO - moznetwork == 0.27 06:02:27 INFO - mozprocess == 0.23 06:02:27 INFO - mozprofile == 0.28 06:02:27 INFO - mozrunner == 6.13 06:02:27 INFO - mozscreenshot == 0.1 06:02:27 INFO - mozsystemmonitor == 0.3 06:02:27 INFO - moztest == 0.7 06:02:27 INFO - mozversion == 1.4 06:02:27 INFO - psutil == 3.1.1 06:02:27 INFO - requests == 1.2.3 06:02:27 INFO - wsgiref == 0.1.2 06:02:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcefb1b2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2651b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ed130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287bfc0>, '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 0x287cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, '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': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', '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 06:02:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:02:27 INFO - Using env: {'DISPLAY': ':0', 06:02:27 INFO - 'HOME': '/home/cltbld', 06:02:27 INFO - 'LANG': 'en_US.UTF-8', 06:02:27 INFO - 'LANGUAGE': 'en_US:en', 06:02:27 INFO - 'LOGNAME': 'cltbld', 06:02:27 INFO - 'MAIL': '/var/mail/cltbld', 06:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:27 INFO - 'MOZ_NO_REMOTE': '1', 06:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:27 INFO - 'NO_EM_RESTART': '1', 06:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:27 INFO - 'PWD': '/builds/slave/test', 06:02:27 INFO - 'SHELL': '/bin/bash', 06:02:27 INFO - 'SHLVL': '1', 06:02:27 INFO - 'TERM': 'linux', 06:02:27 INFO - 'TMOUT': '86400', 06:02:27 INFO - 'USER': 'cltbld', 06:02:27 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', 06:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:27 INFO - '_': '/tools/buildbot/bin/python'} 06:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:02:27 INFO - Cleaning up... 06:02:27 INFO - Return code: 0 06:02:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcefb1b2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2651b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ed130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287bfc0>, '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 0x287cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, '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': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', '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 06:02:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:02:27 INFO - Using env: {'DISPLAY': ':0', 06:02:27 INFO - 'HOME': '/home/cltbld', 06:02:27 INFO - 'LANG': 'en_US.UTF-8', 06:02:27 INFO - 'LANGUAGE': 'en_US:en', 06:02:27 INFO - 'LOGNAME': 'cltbld', 06:02:27 INFO - 'MAIL': '/var/mail/cltbld', 06:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:27 INFO - 'MOZ_NO_REMOTE': '1', 06:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:27 INFO - 'NO_EM_RESTART': '1', 06:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:27 INFO - 'PWD': '/builds/slave/test', 06:02:27 INFO - 'SHELL': '/bin/bash', 06:02:27 INFO - 'SHLVL': '1', 06:02:27 INFO - 'TERM': 'linux', 06:02:27 INFO - 'TMOUT': '86400', 06:02:27 INFO - 'USER': 'cltbld', 06:02:27 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', 06:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:27 INFO - '_': '/tools/buildbot/bin/python'} 06:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:02:27 INFO - Cleaning up... 06:02:27 INFO - Return code: 0 06:02:27 INFO - Running post-action listener: _resource_record_post_action 06:02:27 INFO - Running post-action listener: _start_resource_monitoring 06:02:27 INFO - Starting resource monitoring. 06:02:27 INFO - [mozharness: 2016-11-23 14:02:27.531098Z] Finished create-virtualenv step (success) 06:02:27 INFO - [mozharness: 2016-11-23 14:02:27.531573Z] Running install step. 06:02:27 INFO - Running pre-action listener: _resource_record_pre_action 06:02:27 INFO - Running main action method: install 06:02:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:02:27 INFO - Reading from file tmpfile_stdout 06:02:27 INFO - Detecting whether we're running mozinstall >=1.0... 06:02:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:02:27 INFO - Reading from file tmpfile_stdout 06:02:27 INFO - Output received: 06:02:27 INFO - Usage: mozinstall [options] installer 06:02:27 INFO - Options: 06:02:27 INFO - -h, --help show this help message and exit 06:02:27 INFO - -d DEST, --destination=DEST 06:02:27 INFO - Directory to install application into. [default: 06:02:27 INFO - "/builds/slave/test"] 06:02:27 INFO - --app=APP Application being installed. [default: firefox] 06:02:27 INFO - mkdir: /builds/slave/test/build/application 06:02:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:02:45 INFO - Reading from file tmpfile_stdout 06:02:45 INFO - Output received: 06:02:45 INFO - /builds/slave/test/build/application/firefox/firefox 06:02:45 INFO - Running post-action listener: _resource_record_post_action 06:02:45 INFO - [mozharness: 2016-11-23 14:02:45.455275Z] Finished install step (success) 06:02:45 INFO - [mozharness: 2016-11-23 14:02:45.455517Z] Running run-tests step. 06:02:45 INFO - Running pre-action listener: _resource_record_pre_action 06:02:45 INFO - Running main action method: run_tests 06:02:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:02:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:02:45 INFO - Python 2.7.3 06:02:45 INFO - Return code: 0 06:02:45 INFO - grabbing minidump binary from tooltool 06:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:45 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 0x287bfc0>, '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 0x287cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:02:45 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 06:02:45 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 06:02:45 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 06:02:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:02:45 INFO - Return code: 0 06:02:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:02:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:02:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:02:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:02:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:02:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:02:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:02:45 INFO - Using env: {'DISPLAY': ':0', 06:02:45 INFO - 'HOME': '/home/cltbld', 06:02:45 INFO - 'LANG': 'en_US.UTF-8', 06:02:45 INFO - 'LANGUAGE': 'en_US:en', 06:02:45 INFO - 'LOGNAME': 'cltbld', 06:02:45 INFO - 'MAIL': '/var/mail/cltbld', 06:02:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:02:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:45 INFO - 'MOZ_NO_REMOTE': '1', 06:02:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:02:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:45 INFO - 'NO_EM_RESTART': '1', 06:02:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:45 INFO - 'PWD': '/builds/slave/test', 06:02:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:02:45 INFO - 'SHELL': '/bin/bash', 06:02:45 INFO - 'SHLVL': '1', 06:02:45 INFO - 'TERM': 'linux', 06:02:45 INFO - 'TMOUT': '86400', 06:02:45 INFO - 'USER': 'cltbld', 06:02:45 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826', 06:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:45 INFO - '_': '/tools/buildbot/bin/python'} 06:02:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:02:45 INFO - mozversion application_buildid: 20161123030208 06:02:45 INFO - mozversion application_changeset: 0ddfec7126ec503b54df9c4b7c3b988906f6c882 06:02:45 INFO - mozversion application_display_name: Nightly 06:02:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:02:45 INFO - mozversion application_name: Firefox 06:02:45 INFO - mozversion application_remotingname: firefox 06:02:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:02:45 INFO - mozversion application_vendor: Mozilla 06:02:45 INFO - mozversion application_version: 53.0a1 06:02:45 INFO - mozversion platform_buildid: 20161123030208 06:02:45 INFO - mozversion platform_changeset: 0ddfec7126ec503b54df9c4b7c3b988906f6c882 06:02:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:02:45 INFO - mozversion platform_version: 53.0a1 06:02:45 INFO - using testdate: 1479909765 06:02:45 INFO - actual date: 1479909765 06:02:45 INFO - starting webserver on 'localhost:59531' 06:02:45 INFO - SUITE-START | Running 2 tests 06:02:45 INFO - TEST-START | dromaeo_css 06:02:45 INFO - operating with platform_type : linux_ 06:02:45 INFO - Initialising browser for dromaeo_css test... 06:02:45 INFO - TEST-INFO | started process 2322 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkmimwP/profile http://localhost:59531/getInfo.html) 06:02:50 INFO - PROCESS | 2322 | __metrics Screen width/height:1600/1200 06:02:50 INFO - PROCESS | 2322 | colorDepth:24 06:02:50 INFO - PROCESS | 2322 | Browser inner width/height: 1024/697 06:02:50 INFO - PROCESS | 2322 | __metrics 06:02:51 ERROR - PROCESS | 2322 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3198: TypeError: this.tabs is undefined 06:02:52 INFO - TEST-INFO | 2322: exit 0 06:02:52 INFO - Browser initialized. 06:02:52 INFO - Running cycle 1/1 for dromaeo_css test... 06:02:52 INFO - TEST-INFO | started process 2522 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkmimwP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:03:04 INFO - PROCESS | 2522 | RSS: Main: 185581568 06:03:04 INFO - PROCESS | 2522 | 06:03:53 INFO - PROCESS | 2522 | 1479909833864 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] 06:06:05 INFO - PROCESS | 2522 | Cycle 1(1): loaded http://localhost:59531/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59531/tests/dromaeo/cssquery-ext.html) 06:06:06 INFO - PROCESS | 2522 | RSS: Main: 197382144 06:06:06 INFO - PROCESS | 2522 | 06:09:09 INFO - PROCESS | 2522 | Cycle 1(1): loaded http://localhost:59531/tests/dromaeo/cssquery-ext.html (next: http://localhost:59531/tests/dromaeo/cssquery-jquery.html) 06:09:09 INFO - PROCESS | 2522 | RSS: Main: 197193728 06:09:09 INFO - PROCESS | 2522 | 06:12:11 INFO - PROCESS | 2522 | Cycle 1(1): loaded http://localhost:59531/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59531/tests/dromaeo/cssquery-mootools.html) 06:12:12 INFO - PROCESS | 2522 | RSS: Main: 203325440 06:12:12 INFO - PROCESS | 2522 | 06:15:14 INFO - PROCESS | 2522 | Cycle 1(1): loaded http://localhost:59531/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59531/tests/dromaeo/cssquery-prototype.html) 06:15:14 INFO - PROCESS | 2522 | RSS: Main: 199970816 06:15:14 INFO - PROCESS | 2522 | 06:18:17 INFO - PROCESS | 2522 | Cycle 1(1): loaded http://localhost:59531/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59531/tests/dromaeo/cssquery-yui.html) 06:18:18 INFO - PROCESS | 2522 | RSS: Main: 203874304 06:18:18 INFO - PROCESS | 2522 | 06:21:21 INFO - PROCESS | 2522 | Cycle 1(1): loaded http://localhost:59531/tests/dromaeo/cssquery-yui.html (next: http://localhost:59531/tests/dromaeo/cssquery-dojo.html) 06:21:21 INFO - PROCESS | 2522 | RSS: Main: 203640832 06:21:21 INFO - PROCESS | 2522 | 06:21:21 INFO - PROCESS | 2522 | __start_tp_report 06:21:21 INFO - PROCESS | 2522 | _x_x_mozilla_page_load 06:21:21 INFO - PROCESS | 2522 | _x_x_mozilla_page_load_details 06:21:21 INFO - PROCESS | 2522 | |i|pagename|runs| 06:21:21 INFO - PROCESS | 2522 | |0;dojo.html;3079.3225490392115;3103.3793241351723;3109.005118362125;3109.7978631388974;3135.7804953653244;5323.8136665216725;5420.186971954204;5436.320459942507;5472.01503729329;5494.670319780816;5340.599455040868;5369.221462887879;5407.594430417715;5447.482489163533;5487.7530511127;4901.534354236342;4977.377827771528;4988.625853061017;4989.226669866159;5053.166227572447;4919.11455937931;5092.770825312869;5132.717700526469;5144.768485418165;5161.122609156434;5062.645614806965;5118.795248190068;5143.408508021588;5144.948550514484;5153.871153221162;4830.589399901012;4893.486183950669;4906.337644418029;4957.107720610289;4965.0566392385335;4877.5366340197625;4897.3878265216845;4906.877328066791;4920.581750551208;4936.728479933602;5324.4675532446445;5329.094054010828;5421.105517589593;5511.696856672881;5523.475269849358;5880.794172203952;5888.735006924699;5890.263717035371;5890.646561206341;5893.145493903403;5862.560307976919;5932.911006334908;5936.079907614284;5945.762169513214;5947.732352044169;5340.946590534123;5363.168708850096;5397.8110766123;5427.83716488506;5458.4814442627885;5991.041433370639;6054.878902422015;6055.364186760415;6077.179580756541;6119.84700382494;5791.276090488689;5795.33353664334;5820.796272130455;5822.214001109796;5825.563082768725;5632.718364081779;5654.264945557134;5875.764969401176;5891.293044834647;5895.941040589625;5661.2923384576925;5760.884782304331;5767.826965191051;5809.767609295665;5896.410358964069;5828.912566311508;5836.678982655994;5868.119782032644;5888.057910734347;5892.469677729025;4340.11027739319;4450.287953927356;4491.910161796745;4512.887177820581;4546.840860569864;3824.655780979725;3904.1801221743185;3931.1941052084253;3952;4005.8798236052967;5467.125259958388;5555;5572.665640061609;5574.526165275915;5580.246666700024;5848.824535263949;5858.8242352729485;5869.765209391662;5892.852678683067;5894.941050589525;5403.621746477787;5475.863103422446;5481.479259470344;5567.415421380778;5567.832965011056;4819;4899.118158731391;4904.215325547895;4939.678920870132;4957.652964292537;6197.96901015492;6199;6211.378862113753;6211.378862113753;6221.346758590374;5897.941020589739;5902.026165682614;5919.378465261258;5931.970340148272;5932.466078052996;5939.2575928009;5970.58205925581;5974.910376344272;6095;6123.877522449437;5679.34687510925;5684.118961560965;5686.147077938343;5693.5160511357;5720.48515633595;5800.4489573490455;5842.357340692605;5846.356900741001;5851.64890106578;5917;5691.373948865538;5701.771929122789;5720.513756330592;5730.997075511686;5746.712664366682;5580.190872323572;5614.69119198448;5639.802606908738;5642.351129620146;5672.886542269214;5666.886662266649;5667.518260947865;5690.77236910519;5711.171880077449;5738.311402631711;5734.741936612779;5760.567957403127;5772.336181339032;5785.768569257182;5798.710064496842;5420.891582168413;5438.347398312228;5464.836054918359;5650;5697.1454281856395 06:21:21 INFO - PROCESS | 2522 | |1;ext.html;541.9096424574424;559.6054781379128;563.9915401268981;573.549763435703;594.5629961977946;44002;45231.09537809242;45296.54703452964;45316.32025519616;45321;42351.152976940444;42743.786281068555;42807;42858.142837143314;42995.14009719804;8569.442986205908;8636.265917396997;8700.912990870074;10046.397216167017;10473.738156546071;10233.89766102337;10292.691219263397;10299.330543514685;10319.638812641559;10329.483525823716;10454.843177352346;10475.26673132881;10492.422916739577;10512.579496820157;10523.210759193053;10377.48112594371;10379.89620103797;10433.634822781241;10447;10452;9878.357906736039;9930.50347482623;9933.503324833802;9936.25478089139;10002.799944001079;37538.43692344617;37662.81168594139;37712.057198570255;37809.24381512382;37950.81024594887;3280.467528847206;3333.516640087198;3349.966500335014;3363.1928337199142;3370.865165393381;30616.234594135323;30695;30888.691113088807;31101.688983110333;31695.683043169505;4201.285781417167;4231.724937879028;4280.828766849322;4410.900214218098;4479.059397526524;333223;333854;335826;335942;336086.99999999756;58440.7077964616;58466.41533584695;58650;58701;58950.705246473495;55713.442865570825;55809.44190558124;55955.72022139863;56343.154852677246;56413.7179314109;16403.5899102521;16403.91798041002;16425;16498.6700265994;16559.6688066238;11539.596114135966;11792.705182370339;12152.939235303767;12328;12342.197757145757;18479.722804157947;18651.60112991531;18666.626667466848;18713.625727485647;18811.15349809262;7040.577565346096;7140.357367836919;7171.784846454615;7239.4932354734665;7308.342249197598;979.7060881735451;1019.1388276906002;1083.8265877459726;1107.213878146509;1115.4645770030268;31739.365212696077;31752.206194845312;31806.681933180836;31835.84082079621;32018.359632807213;1108.1854836695022;1110.1008183371496;1117.1063149480383;1139.2196345503191;1173.7652469506133;15545.22273886301;16589.336426542803;16597.41909033178;16743.497695069167;16947;469860;470765;471945;473830;477699;56033;56494;56612;56753.14870276949;56795;1283.3454937981696;1337.104140226051;1339.8861096806882;1358.6467518445077;1363.986360136406;28125.57811632868;28495.715042849308;29350;29544.704552954194;30260.84869575638;49180.75409623072;49239;49351.50648493469;49373.25940110973;49481.25778113259;382310;384979;388238;388643;388868;26566.7343326572;26594.202173934813;27178.456430870876;27364.45271094607;28712.425751484436;44782.3282650754;45720.77139614281;45983.77008115072;46388;46596.30105548487;36661.63338366582;36750;37549.62450375461;38192;38220;38812.80593597014;38971;39329.606703933736;39603.60396396114;39860.601393985686;38545.421818672185;39252.41121383124;39479.407808883465;39708.043793431214;39849.80075099606;33245.33509329848;35592.288154237285;35839.82080089583;35858;36150.819245904655;26274.86862565675;26883.327916802238;27001.459970800082;27164;27230.319242019108 06:21:21 INFO - PROCESS | 2522 | |2;jquery.html;368.9243705040467;371.8178092734561;401.4680548273538;402.84691817109496;422.92175947449726;14139.222342771143;17682.20430080646;18446.53883652906;19128.713069303954;19141.330053448113;15322.69354612907;15620.375184992616;17132.31470741169;19052.61894762104;19127.42617721467;5390.407055223922;5469.589780766439;5619.100943848985;5634.3520495143175;5713.971430142843;5713.342965558952;5723.828285151452;5744.994625940464;5759.625624334405;5760.4815566599;5517.5585953123855;5671.829845104653;5720.628159169662;5770.480656740892;5774.249347584808;5648.6893220872835;5679.659220446766;5691.203231547586;5692.174634677969;5698.971505142447;5354.6613346663335;5579;5643.40744221859;5646.18130371098;5654.491095801398;13686.384112714952;13781.724365512733;13939.442422303096;22696.54606907869;22729.659055114185;2198.9780102198933;2226.666000099982;2276.7609401012987;2379.1910750344964;2523.8611876346795;9789.412635241837;10098.62682269666;10167;10408.115310198642;10507.579696812118;1926.6146770645928;1942.7085937109546;1952.4142757172792;1963.5581994051224;1964.3321270767865;80914.59542702249;82174;83321.16678833256;84046.57976710139;85693.57153214194;10925.508352124014;11050.889491104987;11078.556857725762;11114.388708621103;11335;12331.383430828602;15582.922085389728;15589.29848156813;15623.921880390526;15739.685206296039;7638;7673;8051.436399451982;8123.6750529978135;8135.511869287861;7823;7904.84190316202;8014.599270036475;8192.467489613156;8222.8355432891;4011.2378648056774;4069.8400955727475;4080.387941808693;4139.689523285705;4272.230998420252;1906.1327096171208;1933.2943475631293;1992.4421162074643;2019.2831544801384;2052.568960518308;883.8762573239752;939.3753154152548;957.3537861943161;965.4207475514776;1005.8239808033564;17904.820951790574;18368.448946531626;19069.332573359865;19616.509587260432;20475;928.9210417114485;1001.384148748529;1009.4750729620556;1026.2662196529518;1035.6271742172962;10252.333598316085;10750.569977200981;10868.130549556017;10884.564617415374;10963.232573719763;459006;470272;470422;470506;472011;88498;90746;92354;93747;94219.52890235643;1012.1042877053713;1028.2493779540828;1078.983815242772;1082.377632861108;1083.5828206140693;16646.417375391804;16870.15649217559;17264.568385790455;17560;17814.643707125524;39570.80214599024;39923;39979.40030899481;40062.1987560253;40887;53485.81482296038;55128.72435637796;55764.72117639386;57183.42816571781;58051.4194858046;8213.712520061768;8221.218984196492;8337.791555211168;8429.957850210709;8661.090585488684;12293.323867187391;12559.246445213317;12749.362531873183;12798.296093714935;13198.274094924871;11313.094952403624;11326;11330.093592512743;11745.354005529778;11846.644600661994;10826.837597436202;11153.21927465102;11157.553697851996;11495.252808567417;11643.5342586299;11554.76890462203;11572.36352000648;11617.941910290394;11674.649760507198;11838.585649502225;8153;8172.632231549475;8249.79375515617;8479.830403391774;8559.657613695632;9720.659776908056;10778.461076946278;10819.621313254313;11298.971957479172;11477.253978491372 06:21:21 INFO - PROCESS | 2522 | |3;mootools.html;1321.02244339189;1407.8521755215702;1409.8449170591239;1531.6477210241637;1578.2108945527243;7449.776506704794;7670.232976702327;7906.881396779046;8411.957940210297;8423.831523369528;7912.208779122085;8186.181381861826;8187.959060204691;8351.582420878947;8416.452930559524;2310.376198426424;2319.489712263299;2326.2904814031713;2337.4273303040695;2340.2745149003777;2348.0607756897207;2386.0455817672896;2393.640953856918;2394.317619478449;2401.0275838285525;2311.9075236990584;2334.101370972171;2350.6591544226076;2354.223106374901;2358.457554762406;2283.5547068321516;2296.6899468571696;2305.8155347572238;2309;2319.93040208794;2241.181968581472;2305.9308220753405;2307.7922986931258;2314.3982564533176;2321.419645088728;8392.370572207048;8454.112318206622;8487.40588158829;8503.277221436123;8507.574621268912;5184.170532714786;5285.418603953562;5320.095583750733;5323.201519772027;5333.813316533902;3168.8098714077228;3280.5899262592175;3298.1589694627714;3536.5402497675136;3538.8053657048854;1072.855164552791;1079.0219280493307;1139.3961200563715;1151.7063148897062;1164.90680745541;11394.1454390921;11412;11447.08423326132;11456.541738330458;11479.942600287028;4599.149157405891;4632.884177895579;4693.460252070987;4705.882352941204;4899.632527560448;9755.219582433388;9871.506424678737;9878.555465004092;9896.406215627085;9926.106650401498;5347.759350829222;5350.0904846176245;5356.4107948125675;5360.061989151883;5372.140457526777;4108.5275193352545;4186.979065104716;4818.590419814285;4879.463259041502;4924.4090709115135;3765.661090501868;3903.765774053509;3915.5105611798526;3989.4614227078973;3991.6607088397814;1291.2059083663667;1299.8505171905163;1313.8160657507956;1321.8479874814327;1328.863821432661;867.2108381372921;947.7204224753714;969.3069455339466;977.1162162564607;981.1365997921926;5565.526930210896;5655.5475561954945;5675.233843431167;5731.799387021434;5856.238688970407;445.11422269683095;448.9955100449019;455.5126015163743;455.7835028361568;457.1382943152182;3426.640202778672;3458.9135271617906;3482;3496.1084923344893;3596.694280986093;9987.350822196535;10173.593056277667;10271.126954208827;10303.3817970922;10310.278280520442;10162.4918754062;10181.18550515957;10227.795444091076;10238.436885971194;10251.179905607534;7381.594012329266;7775.22247775218;7781.92218077812;7856.175101614363;7883.724069657649;5569.860753481195;5690.800821971211;5692.1746346778655;5735.627184233012;5801.738921748616;9150.679726209552;9266.583003764981;9309.953450232706;9389.765255868659;9416.529173541432;9445.338826282368;9638.228941684509;9667.371620844622;9683.9031609683;9703.272254580794;6568.211814582281;6701.396874281338;7179;7499.400047996256;7626.618669066635;7944;8021.2379823916635;8105.918940810752;8122.106568277367;8128.390370722102;6922.5154239204785;7217;7303.8539229216185;7306.232845551353;7313.744018959311;6930.27232140618;7101.680424381018;7124.715011399486;7322.670479828527;7329.120505539369;6842.657867106525;6857.828554286183;6881.4494840413645;6892.379685828299;6906.8618627628175;4467.486239082547;4546.931796023128;4903.41159060915;5002.549770520671;5115.769790359368;5012.49894392625;5083.949160508348;5107.157319042316;5187.766550505161;5224.05966925957 06:21:21 INFO - PROCESS | 2522 | |4;prototype.html;327.7885763682425;333.7380156577087;337.5308321433208;340.58788865472786;344.1928677251843;5375.543078838298;5382.62321637485;5401.27082843816;5402.648827826189;5419.485148910852;5342.622532972829;5346.385165705945;5352.5182733553975;5378.757955891984;5421.430749771276;4045.919081618366;4120.58794120587;4138.937915931264;4172.791360431981;4220.324748040314;4202.2646036943415;4216.367544868263;4220.451341325624;4226.577342265779;4230.921115115641;4189.937150942738;4193.266178418779;4205.705600607958;4209.536950935395;4224.260754367973;4119.320312148507;4119.485064366954;4143.212789570002;4223.831046758157;4226.767527785971;3711.109333759905;3724.16206353571;3726.273376691546;3729.198222382201;3740.831662575191;5193.584513238932;5199.6360254782185;5209.843704688866;5211.869703257449;5257.237700533401;4512.172570109111;4727.432708075019;4778.163821331288;4809.807607695688;4810.759462026885;5526.613137080406;5542.5565954723525;5549.639273447213;5556.888862222733;5581.916271255935;4005.619466150711;4031.9596804031876;4032.8991775205855;4037.959620403817;4038.1020920167766;5738.913916291259;5828.329742079631;5842.707864606795;5842.824715258549;5911.527077833763;4130.112025914443;4132.40080188371;4133.441985332001;4153.359423027887;4153.854615088458;4192.91614167721;4199.853005144805;4207.810648520824;4214.789260536961;4218.725782824106;4555.453345598549;4818.156822556039;4824.758762061883;4832.540908613676;4859.465458799529;5623.353314368818;5629.746661400247;5642.605017648725;5670.5463562914865;5692.975264452439;1394.1913690059741;1405.2692599848021;1407.859214078584;1423.7508436023654;1425.0808228692435;944.1549812917538;974.3958745577787;976.6484065736329;988.7725823060737;1011.5195282240877;5128.230765385222;5175.637705360664;5229.372475302912;5235.842924712265;5289.920651190158;5473.31583552056;5554.528050066655;5554.666719996813;5561.5272701820795;5561.833145005657;5236.559946014876;5241.213817927342;5277.788888444419;5330.840074797762;5550.250716153349;2966.6736658967498;2999.2501874531367;2999.8500074996164;3005.4890668586395;3005.5942447769708;5797.594168408255;5916.615419997686;5947.37552556984;5949.970250148808;5951.404859514014;5500.50495455411;5574.498295153456;5651.321841378978;5660.415083776466;5690.833379157263;5765.567582431335;5780.161876527964;5914.674692891932;5951.464368206882;5976.223090998143;5341.023821186031;5520.895820835769;5587.972060139673;5624.381318054929;5636.182753500638;5504.22940788282;5546.833594992157;5554;5561.777528898799;5587.525060369914;5925.140854575976;5925.792597259076;5939.821805345847;5951.732172052355;5957.821265362046;3870.3226935286775;4013.9397909030804;4094.733842300241;4100.380349761887;4116.958830411658;5728.770849165987;5737.139429085503;5758.309002919509;5762.567807414377;5825.368896708928;5510.641808282448;5529.253550770755;5539.532024013559;5539.612227144061;5549.556035517229;5383.892322153457;5631.887362252814;5637.8442419304765;5659.717014149193;5675.262215911905;5605.635633683797;5607.775688972559;5614.6631202128;5631.887362252814;5685.77256909719;5516.586256030733;5588.916166257428;5617.241672374177;5634.802781902614;5657.971710141423;5491.643043202179;5526.64597173695;5552.139418390156;5574.637648552831;5589.161625756006 06:21:21 INFO - PROCESS | 2522 | |5;yui.html;684.9486288528361;742.5730205132047;779.5751315533034;791.1890312429761;826.1243082332728;13987.440502379905;14861.256937153139;14929.552113436586;14967.850321496782;14988.325525351358;13318.40067196976;13393.464261429532;13406.06157568968;13415.19508829471;13420.328983550808;482.351237585447;496.9811885634453;763.8815983522535;780.6604127204656;782.460102529253;786.3159051625065;790.0243199648429;790.1663744749287;790.2255789326464;791.7664289034719;833.2001278772386;834.0075310380628;834.4993004197463;842.4566154830131;843.9578021098952;828.130463013833;833.0420016980461;833.7707130539089;835.340081335744;838.6771093129158;608.9177960975256;610.0757352610798;611.1382950040467;611.8042226487526;613.2120225510242;13347.199168049949;13374.531891383853;13379.464821407131;13435;13704.24626645534;13142;13573.932130339384;13994.93002534991;14445;14468.11040592154;9932.751681207956;10114.848277275847;10465.633702820442;10465.633702820442;10484;3554.626764189749;3602.6217247189193;3691.667749902495;3721.4603882437164;3737.663610275088;61318.386816131715;61715.69142154305;61726.38273617251;62339.68830155866;64891.02663460099;9831.459269740233;10433.478326083665;10506.737331566772;10557.155427565776;10686.251962362716;17885.910570447064;18005.909970450062;18059.458216253533;18076.909615451837;18197;7258.709651613876;7430.368418684472;7449.88825167623;7510.924890751132;7566.31903128721;4300.09697963425;4358.36803663467;4373.671974601918;4441.911161776747;4459.0858873930765;3304.4052070627517;3395.0833275015607;3395.270016946319;3428.777129486575;3443.707284880763;572.1703529881605;582.624207386242;599.6072572465042;600.1268154834705;619.1393962392278;613.4785432382439;630.9652969086744;676.2932735291632;705.1291654806311;712.2770388056024;8794.472331660121;9215.078492150866;9516.904830951602;9596.209497248687;9730.270229732798;586.234963372794;594.8602078511547;640.1230314469207;675.2403546010738;716.2729829223342;4222.366645003212;4261.75828537407;4485.416895803524;4492.640588752892;4831.589314908272;71122;84493.57753211318;86368.56815716007;87932;88045.55977220072;27643.170704878885;28125.859370703423;68190;76499;78402;55636.72181639066;57661.711691441276;59774.70112649496;62397.37602623916;69915.25211869743;9463.479508627091;9743.80512389734;9832.705018849447;9885.357451765612;9895.604175832887;31669.36661266808;41307.1738565233;41614;43066.56933430751;45559.54440455553;53733;59112;59189.40810592011;59939.70030149821;61659.691701541204;11568.13239007061;11902.761944761229;11951.10366722482;12205.20666156697;12341.197822141532;12399.442025108712;12754.744905101661;13134.934325328311;13599.796003059764;14287;12270.570530031406;12307.56923507673;12889.09776315649;12978.286194259406;12985.870141298466;12776.424961688239;13013.154144980925;13085.803712944504;13159.144655597356;13339.399727012502;11852.76294474123;12201.84990979086;12342.876571234172;12401.689957750768;12583.433745481658;9985.201183905125;10036.949815250877;10232.59069637236;10463.319884207502;10622.73443163927;10232.488375581042;11085.113190944543;11406.429678516208;11486.540538378371;11541.769164616828 06:21:21 INFO - PROCESS | 2522 | __end_tp_report 06:21:21 INFO - PROCESS | 2522 | __start_cc_report 06:21:21 INFO - PROCESS | 2522 | _x_x_mozilla_cycle_collect,320 06:21:21 INFO - PROCESS | 2522 | __end_cc_report 06:21:21 INFO - PROCESS | 2522 | __startTimestamp1479910881533__endTimestamp 06:21:21 INFO - PROCESS | 2522 | 06:21:21 INFO - PROCESS | 2522 | ------- Summary: start ------- 06:21:21 INFO - PROCESS | 2522 | Number of tests: 6 06:21:21 INFO - PROCESS | 2522 | 06:21:21 INFO - PROCESS | 2522 | [#0] dojo.html Cycles:165 Average:5428.93 Median:5642.35 stddev:637.30 (11.3%) stddev-sans-first:612.02 06:21:21 INFO - PROCESS | 2522 | Values: 3079.3 3103.4 3109.0 3109.8 3135.8 5323.8 5420.2 5436.3 5472.0 5494.7 5340.6 5369.2 5407.6 5447.5 5487.8 4901.5 4977.4 4988.6 4989.2 5053.2 4919.1 5092.8 5132.7 5144.8 5161.1 5062.6 5118.8 5143.4 5144.9 5153.9 4830.6 4893.5 4906.3 4957.1 4965.1 4877.5 4897.4 4906.9 4920.6 4936.7 5324.5 5329.1 5421.1 5511.7 5523.5 5880.8 5888.7 5890.3 5890.6 5893.1 5862.6 5932.9 5936.1 5945.8 5947.7 5340.9 5363.2 5397.8 5427.8 5458.5 5991.0 6054.9 6055.4 6077.2 6119.8 5791.3 5795.3 5820.8 5822.2 5825.6 5632.7 5654.3 5875.8 5891.3 5895.9 5661.3 5760.9 5767.8 5809.8 5896.4 5828.9 5836.7 5868.1 5888.1 5892.5 4340.1 4450.3 4491.9 4512.9 4546.8 3824.7 3904.2 3931.2 3952.0 4005.9 5467.1 5555.0 5572.7 5574.5 5580.2 5848.8 5858.8 5869.8 5892.9 5894.9 5403.6 5475.9 5481.5 5567.4 5567.8 4819.0 4899.1 4904.2 4939.7 4957.7 6198.0 6199.0 6211.4 6211.4 6221.3 5897.9 5902.0 5919.4 5932.0 5932.5 5939.3 5970.6 5974.9 6095.0 6123.9 5679.3 5684.1 5686.1 5693.5 5720.5 5800.4 5842.4 5846.4 5851.6 5917.0 5691.4 5701.8 5720.5 5731.0 5746.7 5580.2 5614.7 5639.8 5642.4 5672.9 5666.9 5667.5 5690.8 5711.2 5738.3 5734.7 5760.6 5772.3 5785.8 5798.7 5420.9 5438.3 5464.8 5650.0 5697.1 06:21:21 INFO - PROCESS | 2522 | 06:21:21 INFO - PROCESS | 2522 | [#1] ext.html Cycles:180 Average:56029.21 Median:36004.41 stddev:106166.72 (294.9%) stddev-sans-first:106382.80 06:21:21 INFO - PROCESS | 2522 | Values: 541.9 559.6 564.0 573.5 594.6 44002.0 45231.1 45296.5 45316.3 45321.0 42351.2 42743.8 42807.0 42858.1 42995.1 8569.4 8636.3 8700.9 10046.4 10473.7 10233.9 10292.7 10299.3 10319.6 10329.5 10454.8 10475.3 10492.4 10512.6 10523.2 10377.5 10379.9 10433.6 10447.0 10452.0 9878.4 9930.5 9933.5 9936.3 10002.8 37538.4 37662.8 37712.1 37809.2 37950.8 3280.5 3333.5 3350.0 3363.2 3370.9 30616.2 30695.0 30888.7 31101.7 31695.7 4201.3 4231.7 4280.8 4410.9 4479.1 333223.0 333854.0 335826.0 335942.0 336087.0 58440.7 58466.4 58650.0 58701.0 58950.7 55713.4 55809.4 55955.7 56343.2 56413.7 16403.6 16403.9 16425.0 16498.7 16559.7 11539.6 11792.7 12152.9 12328.0 12342.2 18479.7 18651.6 18666.6 18713.6 18811.2 7040.6 7140.4 7171.8 7239.5 7308.3 979.7 1019.1 1083.8 1107.2 1115.5 31739.4 31752.2 31806.7 31835.8 32018.4 1108.2 1110.1 1117.1 1139.2 1173.8 15545.2 16589.3 16597.4 16743.5 16947.0 469860.0 470765.0 471945.0 473830.0 477699.0 56033.0 56494.0 56612.0 56753.1 56795.0 1283.3 1337.1 1339.9 1358.6 1364.0 28125.6 28495.7 29350.0 29544.7 30260.8 49180.8 49239.0 49351.5 49373.3 49481.3 382310.0 384979.0 388238.0 388643.0 388868.0 26566.7 26594.2 27178.5 27364.5 28712.4 44782.3 45720.8 45983.8 46388.0 46596.3 36661.6 36750.0 37549.6 38192.0 38220.0 38812.8 38971.0 39329.6 39603.6 39860.6 38545.4 39252.4 39479.4 39708.0 39849.8 33245.3 35592.3 35839.8 35858.0 36150.8 26274.9 26883.3 27001.5 27164.0 27230.3 06:21:21 INFO - PROCESS | 2522 | 06:21:21 INFO - PROCESS | 2522 | [#2] jquery.html Cycles:180 Average:27996.70 Median:2327.98 stddev:77435.62 (3326.3%) stddev-sans-first:77625.06 06:21:21 INFO - PROCESS | 2522 | Values: 368.9 371.8 401.5 402.8 422.9 14139.2 17682.2 18446.5 19128.7 19141.3 15322.7 15620.4 17132.3 19052.6 19127.4 5390.4 5469.6 5619.1 5634.4 5714.0 5713.3 5723.8 5745.0 5759.6 5760.5 5517.6 5671.8 5720.6 5770.5 5774.2 5648.7 5679.7 5691.2 5692.2 5699.0 5354.7 5579.0 5643.4 5646.2 5654.5 13686.4 13781.7 13939.4 22696.5 22729.7 2199.0 2226.7 2276.8 2379.2 2523.9 9789.4 10098.6 10167.0 10408.1 10507.6 1926.6 1942.7 1952.4 1963.6 1964.3 80914.6 82174.0 83321.2 84046.6 85693.6 10925.5 11050.9 11078.6 11114.4 11335.0 12331.4 15582.9 15589.3 15623.9 15739.7 7638.0 7673.0 8051.4 8123.7 8135.5 7823.0 7904.8 8014.6 8192.5 8222.8 4011.2 4069.8 4080.4 4139.7 4272.2 1906.1 1933.3 1992.4 2019.3 2052.6 883.9 939.4 957.4 965.4 1005.8 17904.8 18368.4 19069.3 19616.5 20475.0 928.9 1001.4 1009.5 1026.3 1035.6 10252.3 10750.6 10868.1 10884.6 10963.2 459006.0 470272.0 470422.0 470506.0 472011.0 88498.0 90746.0 92354.0 93747.0 94219.5 1012.1 1028.2 1079.0 1082.4 1083.6 16646.4 16870.2 17264.6 17560.0 17814.6 39570.8 39923.0 39979.4 40062.2 40887.0 53485.8 55128.7 55764.7 57183.4 58051.4 8213.7 8221.2 8337.8 8430.0 8661.1 12293.3 12559.2 12749.4 12798.3 13198.3 11313.1 11326.0 11330.1 11745.4 11846.6 10826.8 11153.2 11157.6 11495.3 11643.5 11554.8 11572.4 11617.9 11674.6 11838.6 8153.0 8172.6 8249.8 8479.8 8559.7 9720.7 10778.5 10819.6 11299.0 11477.3 06:21:21 INFO - PROCESS | 2522 | 06:21:21 INFO - PROCESS | 2522 | [#3] mootools.html Cycles:180 Average:5512.40 Median:5111.46 stddev:3072.26 (60.1%) stddev-sans-first:3064.73 06:21:21 INFO - PROCESS | 2522 | Values: 1321.0 1407.9 1409.8 1531.6 1578.2 7449.8 7670.2 7906.9 8412.0 8423.8 7912.2 8186.2 8188.0 8351.6 8416.5 2310.4 2319.5 2326.3 2337.4 2340.3 2348.1 2386.0 2393.6 2394.3 2401.0 2311.9 2334.1 2350.7 2354.2 2358.5 2283.6 2296.7 2305.8 2309.0 2319.9 2241.2 2305.9 2307.8 2314.4 2321.4 8392.4 8454.1 8487.4 8503.3 8507.6 5184.2 5285.4 5320.1 5323.2 5333.8 3168.8 3280.6 3298.2 3536.5 3538.8 1072.9 1079.0 1139.4 1151.7 1164.9 11394.1 11412.0 11447.1 11456.5 11479.9 4599.1 4632.9 4693.5 4705.9 4899.6 9755.2 9871.5 9878.6 9896.4 9926.1 5347.8 5350.1 5356.4 5360.1 5372.1 4108.5 4187.0 4818.6 4879.5 4924.4 3765.7 3903.8 3915.5 3989.5 3991.7 1291.2 1299.9 1313.8 1321.8 1328.9 867.2 947.7 969.3 977.1 981.1 5565.5 5655.5 5675.2 5731.8 5856.2 445.1 449.0 455.5 455.8 457.1 3426.6 3458.9 3482.0 3496.1 3596.7 9987.4 10173.6 10271.1 10303.4 10310.3 10162.5 10181.2 10227.8 10238.4 10251.2 7381.6 7775.2 7781.9 7856.2 7883.7 5569.9 5690.8 5692.2 5735.6 5801.7 9150.7 9266.6 9310.0 9389.8 9416.5 9445.3 9638.2 9667.4 9683.9 9703.3 6568.2 6701.4 7179.0 7499.4 7626.6 7944.0 8021.2 8105.9 8122.1 8128.4 6922.5 7217.0 7303.9 7306.2 7313.7 6930.3 7101.7 7124.7 7322.7 7329.1 6842.7 6857.8 6881.4 6892.4 6906.9 4467.5 4546.9 4903.4 5002.5 5115.8 5012.5 5083.9 5107.2 5187.8 5224.1 06:21:21 INFO - PROCESS | 2522 | 06:21:21 INFO - PROCESS | 2522 | [#4] prototype.html Cycles:180 Average:4703.00 Median:5380.69 stddev:1371.63 (25.5%) stddev-sans-first:1335.59 06:21:21 INFO - PROCESS | 2522 | Values: 327.8 333.7 337.5 340.6 344.2 5375.5 5382.6 5401.3 5402.6 5419.5 5342.6 5346.4 5352.5 5378.8 5421.4 4045.9 4120.6 4138.9 4172.8 4220.3 4202.3 4216.4 4220.5 4226.6 4230.9 4189.9 4193.3 4205.7 4209.5 4224.3 4119.3 4119.5 4143.2 4223.8 4226.8 3711.1 3724.2 3726.3 3729.2 3740.8 5193.6 5199.6 5209.8 5211.9 5257.2 4512.2 4727.4 4778.2 4809.8 4810.8 5526.6 5542.6 5549.6 5556.9 5581.9 4005.6 4032.0 4032.9 4038.0 4038.1 5738.9 5828.3 5842.7 5842.8 5911.5 4130.1 4132.4 4133.4 4153.4 4153.9 4192.9 4199.9 4207.8 4214.8 4218.7 4555.5 4818.2 4824.8 4832.5 4859.5 5623.4 5629.7 5642.6 5670.5 5693.0 1394.2 1405.3 1407.9 1423.8 1425.1 944.2 974.4 976.6 988.8 1011.5 5128.2 5175.6 5229.4 5235.8 5289.9 5473.3 5554.5 5554.7 5561.5 5561.8 5236.6 5241.2 5277.8 5330.8 5550.3 2966.7 2999.3 2999.9 3005.5 3005.6 5797.6 5916.6 5947.4 5950.0 5951.4 5500.5 5574.5 5651.3 5660.4 5690.8 5765.6 5780.2 5914.7 5951.5 5976.2 5341.0 5520.9 5588.0 5624.4 5636.2 5504.2 5546.8 5554.0 5561.8 5587.5 5925.1 5925.8 5939.8 5951.7 5957.8 3870.3 4013.9 4094.7 4100.4 4117.0 5728.8 5737.1 5758.3 5762.6 5825.4 5510.6 5529.3 5539.5 5539.6 5549.6 5383.9 5631.9 5637.8 5659.7 5675.3 5605.6 5607.8 5614.7 5631.9 5685.8 5516.6 5588.9 5617.2 5634.8 5658.0 5491.6 5526.6 5552.1 5574.6 5589.2 06:21:21 INFO - PROCESS | 2522 | 06:21:21 INFO - PROCESS | 2522 | [#5] yui.html Cycles:180 Average:16389.66 Median:4489.03 stddev:21423.36 (477.2%) stddev-sans-first:21451.00 06:21:21 INFO - PROCESS | 2522 | Values: 684.9 742.6 779.6 791.2 826.1 13987.4 14861.3 14929.6 14967.9 14988.3 13318.4 13393.5 13406.1 13415.2 13420.3 482.4 497.0 763.9 780.7 782.5 786.3 790.0 790.2 790.2 791.8 833.2 834.0 834.5 842.5 844.0 828.1 833.0 833.8 835.3 838.7 608.9 610.1 611.1 611.8 613.2 13347.2 13374.5 13379.5 13435.0 13704.2 13142.0 13573.9 13994.9 14445.0 14468.1 9932.8 10114.8 10465.6 10465.6 10484.0 3554.6 3602.6 3691.7 3721.5 3737.7 61318.4 61715.7 61726.4 62339.7 64891.0 9831.5 10433.5 10506.7 10557.2 10686.3 17885.9 18005.9 18059.5 18076.9 18197.0 7258.7 7430.4 7449.9 7510.9 7566.3 4300.1 4358.4 4373.7 4441.9 4459.1 3304.4 3395.1 3395.3 3428.8 3443.7 572.2 582.6 599.6 600.1 619.1 613.5 631.0 676.3 705.1 712.3 8794.5 9215.1 9516.9 9596.2 9730.3 586.2 594.9 640.1 675.2 716.3 4222.4 4261.8 4485.4 4492.6 4831.6 71122.0 84493.6 86368.6 87932.0 88045.6 27643.2 28125.9 68190.0 76499.0 78402.0 55636.7 57661.7 59774.7 62397.4 69915.3 9463.5 9743.8 9832.7 9885.4 9895.6 31669.4 41307.2 41614.0 43066.6 45559.5 53733.0 59112.0 59189.4 59939.7 61659.7 11568.1 11902.8 11951.1 12205.2 12341.2 12399.4 12754.7 13134.9 13599.8 14287.0 12270.6 12307.6 12889.1 12978.3 12985.9 12776.4 13013.2 13085.8 13159.1 13339.4 11852.8 12201.8 12342.9 12401.7 12583.4 9985.2 10036.9 10232.6 10463.3 10622.7 10232.5 11085.1 11406.4 11486.5 11541.8 06:21:21 INFO - PROCESS | 2522 | -------- Summary: end -------- 06:21:21 INFO - PROCESS | 2522 | 06:21:22 INFO - TEST-INFO | 2522: exit 0 06:21:22 INFO - TEST-OK | dromaeo_css | took 1116880ms 06:21:22 INFO - TEST-START | kraken 06:21:22 INFO - operating with platform_type : linux_ 06:21:22 INFO - Initialising browser for kraken test... 06:21:22 INFO - TEST-INFO | started process 3010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp52eH9E/profile http://localhost:59531/getInfo.html) 06:21:27 INFO - PROCESS | 3010 | __metrics Screen width/height:1600/1200 06:21:27 INFO - PROCESS | 3010 | colorDepth:24 06:21:27 INFO - PROCESS | 3010 | Browser inner width/height: 1024/697 06:21:27 INFO - PROCESS | 3010 | __metrics 06:21:27 ERROR - PROCESS | 3010 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3198: TypeError: this.tabs is undefined 06:21:28 INFO - TEST-INFO | 3010: exit 0 06:21:28 INFO - Browser initialized. 06:21:28 INFO - Running cycle 1/1 for kraken test... 06:21:28 INFO - TEST-INFO | started process 3135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp52eH9E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:21:41 INFO - PROCESS | 3135 | RSS: Main: 186085376 06:21:41 INFO - PROCESS | 3135 | 06:21:43 INFO - PROCESS | 3135 | Cycle 1(1): loaded http://localhost:59531/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59531/tests/kraken/driver.html?testName=audio-beat-detection) 06:21:44 INFO - PROCESS | 3135 | RSS: Main: 198885376 06:21:44 INFO - PROCESS | 3135 | 06:21:47 INFO - PROCESS | 3135 | Cycle 1(1): loaded http://localhost:59531/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59531/tests/kraken/driver.html?testName=audio-dft) 06:21:47 INFO - PROCESS | 3135 | RSS: Main: 197025792 06:21:47 INFO - PROCESS | 3135 | 06:21:50 INFO - PROCESS | 3135 | Cycle 1(1): loaded http://localhost:59531/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59531/tests/kraken/driver.html?testName=audio-fft) 06:21:51 INFO - PROCESS | 3135 | RSS: Main: 193445888 06:21:51 INFO - PROCESS | 3135 | 06:21:53 INFO - PROCESS | 3135 | Cycle 1(1): loaded http://localhost:59531/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59531/tests/kraken/driver.html?testName=audio-oscillator) 06:21:54 INFO - PROCESS | 3135 | RSS: Main: 194019328 06:21:54 INFO - PROCESS | 3135 | 06:21:56 INFO - PROCESS | 3135 | Cycle 1(1): loaded http://localhost:59531/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59531/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:21:56 INFO - PROCESS | 3135 | RSS: Main: 194355200 06:21:56 INFO - PROCESS | 3135 | 06:22:00 INFO - PROCESS | 3135 | Cycle 1(1): loaded http://localhost:59531/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59531/tests/kraken/driver.html?testName=imaging-darkroom) 06:22:00 INFO - PROCESS | 3135 | RSS: Main: 199487488 06:22:00 INFO - PROCESS | 3135 | 06:22:04 INFO - PROCESS | 3135 | Cycle 1(1): loaded http://localhost:59531/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59531/tests/kraken/driver.html?testName=imaging-desaturate) 06:22:04 INFO - PROCESS | 3135 | RSS: Main: 196038656 06:22:04 INFO - PROCESS | 3135 | 06:22:07 INFO - PROCESS | 3135 | Cycle 1(1): loaded http://localhost:59531/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59531/tests/kraken/driver.html?testName=json-parse-financial) 06:22:08 INFO - PROCESS | 3135 | RSS: Main: 197156864 06:22:08 INFO - PROCESS | 3135 | 06:22:09 INFO - PROCESS | 3135 | Cycle 1(1): loaded http://localhost:59531/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59531/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:22:10 INFO - PROCESS | 3135 | RSS: Main: 197214208 06:22:10 INFO - PROCESS | 3135 | 06:22:12 INFO - PROCESS | 3135 | Cycle 1(1): loaded http://localhost:59531/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59531/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:22:12 INFO - PROCESS | 3135 | RSS: Main: 196882432 06:22:12 INFO - PROCESS | 3135 | 06:22:15 INFO - PROCESS | 3135 | Cycle 1(1): loaded http://localhost:59531/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59531/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:22:15 INFO - PROCESS | 3135 | RSS: Main: 197537792 06:22:15 INFO - PROCESS | 3135 | 06:22:18 INFO - PROCESS | 3135 | Cycle 1(1): loaded http://localhost:59531/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59531/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:22:19 INFO - PROCESS | 3135 | RSS: Main: 197386240 06:22:19 INFO - PROCESS | 3135 | 06:22:22 INFO - PROCESS | 3135 | Cycle 1(1): loaded http://localhost:59531/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59531/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:22:22 INFO - PROCESS | 3135 | RSS: Main: 197713920 06:22:22 INFO - PROCESS | 3135 | 06:22:24 INFO - PROCESS | 3135 | Cycle 1(1): loaded http://localhost:59531/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59531/tests/kraken/driver.html?testName=ai-astar) 06:22:24 INFO - PROCESS | 3135 | RSS: Main: 198713344 06:22:24 INFO - PROCESS | 3135 | 06:22:24 INFO - PROCESS | 3135 | __start_tp_report 06:22:24 INFO - PROCESS | 3135 | _x_x_mozilla_page_load 06:22:24 INFO - PROCESS | 3135 | _x_x_mozilla_page_load_details 06:22:24 INFO - PROCESS | 3135 | |i|pagename|runs| 06:22:24 INFO - PROCESS | 3135 | |0;ai-astar;104;114;114;112;112;112;112;112;113;112 06:22:24 INFO - PROCESS | 3135 | |1;audio-beat-detection;150;126;128;161;126;125;131;132;143;128 06:22:24 INFO - PROCESS | 3135 | |2;audio-dft;161;165;164;168;173;164;162;166;163;164 06:22:24 INFO - PROCESS | 3135 | |3;audio-fft;75;76;77;113;75;75;77;76;101;76 06:22:24 INFO - PROCESS | 3135 | |4;audio-oscillator;82;82;115;83;82;84;101;82;82;110 06:22:24 INFO - PROCESS | 3135 | |5;imaging-gaussian-blur;119;118;117;117;118;117;119;118;118;118 06:22:24 INFO - PROCESS | 3135 | |6;imaging-darkroom;148;149;148;147;147;147;146;148;148;146 06:22:24 INFO - PROCESS | 3135 | |7;imaging-desaturate;97;96;96;96;96;95;96;96;97;96 06:22:24 INFO - PROCESS | 3135 | |8;json-parse-financial;53;53;56;54;55;56;57;55;54;65 06:22:24 INFO - PROCESS | 3135 | |9;json-stringify-tinderbox;62;63;61;62;62;67;62;62;61;62 06:22:24 INFO - PROCESS | 3135 | |10;stanford-crypto-aes;88;84;82;82;81;82;81;87;89;83 06:22:24 INFO - PROCESS | 3135 | |11;stanford-crypto-ccm;141;150;136;135;138;139;138;134;178;148 06:22:24 INFO - PROCESS | 3135 | |12;stanford-crypto-pbkdf2;167;168;167;165;168;162;169;170;167;163 06:22:24 INFO - PROCESS | 3135 | |13;stanford-crypto-sha256-iterative;69;65;66;66;67;67;64;66;65;65 06:22:24 INFO - PROCESS | 3135 | __end_tp_report 06:22:24 INFO - PROCESS | 3135 | __start_cc_report 06:22:24 INFO - PROCESS | 3135 | _x_x_mozilla_cycle_collect,829 06:22:24 INFO - PROCESS | 3135 | __end_cc_report 06:22:24 INFO - PROCESS | 3135 | __startTimestamp1479910944618__endTimestamp 06:22:24 INFO - PROCESS | 3135 | 06:22:24 INFO - PROCESS | 3135 | ------- Summary: start ------- 06:22:24 INFO - PROCESS | 3135 | Number of tests: 14 06:22:24 INFO - PROCESS | 3135 | 06:22:24 INFO - PROCESS | 3135 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:2.83 (2.5%) stddev-sans-first:0.88 06:22:24 INFO - PROCESS | 3135 | Values: 104.0 114.0 114.0 112.0 112.0 112.0 112.0 112.0 113.0 112.0 06:22:24 INFO - PROCESS | 3135 | 06:22:24 INFO - PROCESS | 3135 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:131.50 stddev:12.25 (9.3%) stddev-sans-first:11.73 06:22:24 INFO - PROCESS | 3135 | Values: 150.0 126.0 128.0 161.0 126.0 125.0 131.0 132.0 143.0 128.0 06:22:24 INFO - PROCESS | 3135 | 06:22:24 INFO - PROCESS | 3135 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.50 stddev:3.43 (2.1%) stddev-sans-first:3.32 06:22:24 INFO - PROCESS | 3135 | Values: 161.0 165.0 164.0 168.0 173.0 164.0 162.0 166.0 163.0 164.0 06:22:24 INFO - PROCESS | 3135 | 06:22:24 INFO - PROCESS | 3135 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:13.44 (17.7%) stddev-sans-first:14.01 06:22:24 INFO - PROCESS | 3135 | Values: 75.0 76.0 77.0 113.0 75.0 75.0 77.0 76.0 101.0 76.0 06:22:24 INFO - PROCESS | 3135 | 06:22:24 INFO - PROCESS | 3135 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:82.00 stddev:13.12 (16.0%) stddev-sans-first:13.57 06:22:24 INFO - PROCESS | 3135 | Values: 82.0 82.0 115.0 83.0 82.0 84.0 101.0 82.0 82.0 110.0 06:22:24 INFO - PROCESS | 3135 | 06:22:24 INFO - PROCESS | 3135 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 06:22:24 INFO - PROCESS | 3135 | Values: 119.0 118.0 117.0 117.0 118.0 117.0 119.0 118.0 118.0 118.0 06:22:24 INFO - PROCESS | 3135 | 06:22:24 INFO - PROCESS | 3135 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.00 06:22:24 INFO - PROCESS | 3135 | Values: 148.0 149.0 148.0 147.0 147.0 147.0 146.0 148.0 148.0 146.0 06:22:24 INFO - PROCESS | 3135 | 06:22:24 INFO - PROCESS | 3135 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 06:22:24 INFO - PROCESS | 3135 | Values: 97.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 97.0 96.0 06:22:24 INFO - PROCESS | 3135 | 06:22:24 INFO - PROCESS | 3135 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.50 stddev:3.49 (6.3%) stddev-sans-first:3.55 06:22:24 INFO - PROCESS | 3135 | Values: 53.0 53.0 56.0 54.0 55.0 56.0 57.0 55.0 54.0 65.0 06:22:24 INFO - PROCESS | 3135 | 06:22:24 INFO - PROCESS | 3135 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.00 stddev:1.71 (2.8%) stddev-sans-first:1.81 06:22:24 INFO - PROCESS | 3135 | Values: 62.0 63.0 61.0 62.0 62.0 67.0 62.0 62.0 61.0 62.0 06:22:24 INFO - PROCESS | 3135 | 06:22:24 INFO - PROCESS | 3135 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.50 stddev:3.00 (3.6%) stddev-sans-first:2.79 06:22:24 INFO - PROCESS | 3135 | Values: 88.0 84.0 82.0 82.0 81.0 82.0 81.0 87.0 89.0 83.0 06:22:24 INFO - PROCESS | 3135 | 06:22:24 INFO - PROCESS | 3135 | [#11] stanford-crypto-ccm Cycles:10 Average:143.70 Median:140.00 stddev:13.16 (9.4%) stddev-sans-first:13.92 06:22:24 INFO - PROCESS | 3135 | Values: 141.0 150.0 136.0 135.0 138.0 139.0 138.0 134.0 178.0 148.0 06:22:24 INFO - PROCESS | 3135 | 06:22:24 INFO - PROCESS | 3135 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.60 Median:167.50 stddev:2.55 (1.5%) stddev-sans-first:2.70 06:22:24 INFO - PROCESS | 3135 | Values: 167.0 168.0 167.0 165.0 168.0 162.0 169.0 170.0 167.0 163.0 06:22:24 INFO - PROCESS | 3135 | 06:22:24 INFO - PROCESS | 3135 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.41 (2.1%) stddev-sans-first:1.00 06:22:24 INFO - PROCESS | 3135 | Values: 69.0 65.0 66.0 66.0 67.0 67.0 64.0 66.0 65.0 65.0 06:22:24 INFO - PROCESS | 3135 | -------- Summary: end -------- 06:22:24 INFO - PROCESS | 3135 | 06:22:25 INFO - TEST-INFO | 3135: exit 0 06:22:25 INFO - TEST-OK | kraken | took 63128ms 06:22:25 INFO - SUITE-END | took 1180s 06:22:25 INFO - Completed test suite (00:19:40) 06:22:25 INFO - javascript benchmark 06:22:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7035.652642791242, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3079.3225490392115, 3103.3793241351723, 3109.005118362125, 3109.7978631388974, 3135.7804953653244, 5323.8136665216725, 5420.186971954204, 5436.320459942507, 5472.01503729329, 5494.670319780816, 5340.599455040868, 5369.221462887879, 5407.594430417715, 5447.482489163533, 5487.7530511127, 4901.534354236342, 4977.377827771528, 4988.625853061017, 4989.226669866159, 5053.166227572447, 4919.11455937931, 5092.770825312869, 5132.717700526469, 5144.768485418165, 5161.122609156434, 5062.645614806965, 5118.795248190068, 5143.408508021588, 5144.948550514484, 5153.871153221162, 4830.589399901012, 4893.486183950669, 4906.337644418029, 4957.107720610289, 4965.0566392385335, 4877.5366340197625, 4897.3878265216845, 4906.877328066791, 4920.581750551208, 4936.728479933602, 5324.4675532446445, 5329.094054010828, 5421.105517589593, 5511.696856672881, 5523.475269849358, 5880.794172203952, 5888.735006924699, 5890.263717035371, 5890.646561206341, 5893.145493903403, 5862.560307976919, 5932.911006334908, 5936.079907614284, 5945.762169513214, 5947.732352044169, 5340.946590534123, 5363.168708850096, 5397.8110766123, 5427.83716488506, 5458.4814442627885, 5991.041433370639, 6054.878902422015, 6055.364186760415, 6077.179580756541, 6119.84700382494, 5791.276090488689, 5795.33353664334, 5820.796272130455, 5822.214001109796, 5825.563082768725, 5632.718364081779, 5654.264945557134, 5875.764969401176, 5891.293044834647, 5895.941040589625, 5661.2923384576925, 5760.884782304331, 5767.826965191051, 5809.767609295665, 5896.410358964069, 5828.912566311508, 5836.678982655994, 5868.119782032644, 5888.057910734347, 5892.469677729025, 4340.11027739319, 4450.287953927356, 4491.910161796745, 4512.887177820581, 4546.840860569864, 3824.655780979725, 3904.1801221743185, 3931.1941052084253, 3952.0, 4005.8798236052967, 5467.125259958388, 5555.0, 5572.665640061609, 5574.526165275915, 5580.246666700024, 5848.824535263949, 5858.8242352729485, 5869.765209391662, 5892.852678683067, 5894.941050589525, 5403.621746477787, 5475.863103422446, 5481.479259470344, 5567.415421380778, 5567.832965011056, 4819.0, 4899.118158731391, 4904.215325547895, 4939.678920870132, 4957.652964292537, 6197.96901015492, 6199.0, 6211.378862113753, 6211.378862113753, 6221.346758590374, 5897.941020589739, 5902.026165682614, 5919.378465261258, 5931.970340148272, 5932.466078052996, 5939.2575928009, 5970.58205925581, 5974.910376344272, 6095.0, 6123.877522449437, 5679.34687510925, 5684.118961560965, 5686.147077938343, 5693.5160511357, 5720.48515633595, 5800.4489573490455, 5842.357340692605, 5846.356900741001, 5851.64890106578, 5917.0, 5691.373948865538, 5701.771929122789, 5720.513756330592, 5730.997075511686, 5746.712664366682, 5580.190872323572, 5614.69119198448, 5639.802606908738, 5642.351129620146, 5672.886542269214, 5666.886662266649, 5667.518260947865, 5690.77236910519, 5711.171880077449, 5738.311402631711, 5734.741936612779, 5760.567957403127, 5772.336181339032, 5785.768569257182, 5798.710064496842, 5420.891582168413, 5438.347398312228, 5464.836054918359, 5650.0, 5697.1454281856395], "value": 5384.320941170001, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.9096424574424, 559.6054781379128, 563.9915401268981, 573.549763435703, 594.5629961977946, 44002.0, 45231.09537809242, 45296.54703452964, 45316.32025519616, 45321.0, 42351.152976940444, 42743.786281068555, 42807.0, 42858.142837143314, 42995.14009719804, 8569.442986205908, 8636.265917396997, 8700.912990870074, 10046.397216167017, 10473.738156546071, 10233.89766102337, 10292.691219263397, 10299.330543514685, 10319.638812641559, 10329.483525823716, 10454.843177352346, 10475.26673132881, 10492.422916739577, 10512.579496820157, 10523.210759193053, 10377.48112594371, 10379.89620103797, 10433.634822781241, 10447.0, 10452.0, 9878.357906736039, 9930.50347482623, 9933.503324833802, 9936.25478089139, 10002.799944001079, 37538.43692344617, 37662.81168594139, 37712.057198570255, 37809.24381512382, 37950.81024594887, 3280.467528847206, 3333.516640087198, 3349.966500335014, 3363.1928337199142, 3370.865165393381, 30616.234594135323, 30695.0, 30888.691113088807, 31101.688983110333, 31695.683043169505, 4201.285781417167, 4231.724937879028, 4280.828766849322, 4410.900214218098, 4479.059397526524, 333223.0, 333854.0, 335826.0, 335942.0, 336086.99999999756, 58440.7077964616, 58466.41533584695, 58650.0, 58701.0, 58950.705246473495, 55713.442865570825, 55809.44190558124, 55955.72022139863, 56343.154852677246, 56413.7179314109, 16403.5899102521, 16403.91798041002, 16425.0, 16498.6700265994, 16559.6688066238, 11539.596114135966, 11792.705182370339, 12152.939235303767, 12328.0, 12342.197757145757, 18479.722804157947, 18651.60112991531, 18666.626667466848, 18713.625727485647, 18811.15349809262, 7040.577565346096, 7140.357367836919, 7171.784846454615, 7239.4932354734665, 7308.342249197598, 979.7060881735451, 1019.1388276906002, 1083.8265877459726, 1107.213878146509, 1115.4645770030268, 31739.365212696077, 31752.206194845312, 31806.681933180836, 31835.84082079621, 32018.359632807213, 1108.1854836695022, 1110.1008183371496, 1117.1063149480383, 1139.2196345503191, 1173.7652469506133, 15545.22273886301, 16589.336426542803, 16597.41909033178, 16743.497695069167, 16947.0, 469860.0, 470765.0, 471945.0, 473830.0, 477699.0, 56033.0, 56494.0, 56612.0, 56753.14870276949, 56795.0, 1283.3454937981696, 1337.104140226051, 1339.8861096806882, 1358.6467518445077, 1363.986360136406, 28125.57811632868, 28495.715042849308, 29350.0, 29544.704552954194, 30260.84869575638, 49180.75409623072, 49239.0, 49351.50648493469, 49373.25940110973, 49481.25778113259, 382310.0, 384979.0, 388238.0, 388643.0, 388868.0, 26566.7343326572, 26594.202173934813, 27178.456430870876, 27364.45271094607, 28712.425751484436, 44782.3282650754, 45720.77139614281, 45983.77008115072, 46388.0, 46596.30105548487, 36661.63338366582, 36750.0, 37549.62450375461, 38192.0, 38220.0, 38812.80593597014, 38971.0, 39329.606703933736, 39603.60396396114, 39860.601393985686, 38545.421818672185, 39252.41121383124, 39479.407808883465, 39708.043793431214, 39849.80075099606, 33245.33509329848, 35592.288154237285, 35839.82080089583, 35858.0, 36150.819245904655, 26274.86862565675, 26883.327916802238, 27001.459970800082, 27164.0, 27230.319242019108], "value": 19806.356542791553, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.9243705040467, 371.8178092734561, 401.4680548273538, 402.84691817109496, 422.92175947449726, 14139.222342771143, 17682.20430080646, 18446.53883652906, 19128.713069303954, 19141.330053448113, 15322.69354612907, 15620.375184992616, 17132.31470741169, 19052.61894762104, 19127.42617721467, 5390.407055223922, 5469.589780766439, 5619.100943848985, 5634.3520495143175, 5713.971430142843, 5713.342965558952, 5723.828285151452, 5744.994625940464, 5759.625624334405, 5760.4815566599, 5517.5585953123855, 5671.829845104653, 5720.628159169662, 5770.480656740892, 5774.249347584808, 5648.6893220872835, 5679.659220446766, 5691.203231547586, 5692.174634677969, 5698.971505142447, 5354.6613346663335, 5579.0, 5643.40744221859, 5646.18130371098, 5654.491095801398, 13686.384112714952, 13781.724365512733, 13939.442422303096, 22696.54606907869, 22729.659055114185, 2198.9780102198933, 2226.666000099982, 2276.7609401012987, 2379.1910750344964, 2523.8611876346795, 9789.412635241837, 10098.62682269666, 10167.0, 10408.115310198642, 10507.579696812118, 1926.6146770645928, 1942.7085937109546, 1952.4142757172792, 1963.5581994051224, 1964.3321270767865, 80914.59542702249, 82174.0, 83321.16678833256, 84046.57976710139, 85693.57153214194, 10925.508352124014, 11050.889491104987, 11078.556857725762, 11114.388708621103, 11335.0, 12331.383430828602, 15582.922085389728, 15589.29848156813, 15623.921880390526, 15739.685206296039, 7638.0, 7673.0, 8051.436399451982, 8123.6750529978135, 8135.511869287861, 7823.0, 7904.84190316202, 8014.599270036475, 8192.467489613156, 8222.8355432891, 4011.2378648056774, 4069.8400955727475, 4080.387941808693, 4139.689523285705, 4272.230998420252, 1906.1327096171208, 1933.2943475631293, 1992.4421162074643, 2019.2831544801384, 2052.568960518308, 883.8762573239752, 939.3753154152548, 957.3537861943161, 965.4207475514776, 1005.8239808033564, 17904.820951790574, 18368.448946531626, 19069.332573359865, 19616.509587260432, 20475.0, 928.9210417114485, 1001.384148748529, 1009.4750729620556, 1026.2662196529518, 1035.6271742172962, 10252.333598316085, 10750.569977200981, 10868.130549556017, 10884.564617415374, 10963.232573719763, 459006.0, 470272.0, 470422.0, 470506.0, 472011.0, 88498.0, 90746.0, 92354.0, 93747.0, 94219.52890235643, 1012.1042877053713, 1028.2493779540828, 1078.983815242772, 1082.377632861108, 1083.5828206140693, 16646.417375391804, 16870.15649217559, 17264.568385790455, 17560.0, 17814.643707125524, 39570.80214599024, 39923.0, 39979.40030899481, 40062.1987560253, 40887.0, 53485.81482296038, 55128.72435637796, 55764.72117639386, 57183.42816571781, 58051.4194858046, 8213.712520061768, 8221.218984196492, 8337.791555211168, 8429.957850210709, 8661.090585488684, 12293.323867187391, 12559.246445213317, 12749.362531873183, 12798.296093714935, 13198.274094924871, 11313.094952403624, 11326.0, 11330.093592512743, 11745.354005529778, 11846.644600661994, 10826.837597436202, 11153.21927465102, 11157.553697851996, 11495.252808567417, 11643.5342586299, 11554.76890462203, 11572.36352000648, 11617.941910290394, 11674.649760507198, 11838.585649502225, 8153.0, 8172.632231549475, 8249.79375515617, 8479.830403391774, 8559.657613695632, 9720.659776908056, 10778.461076946278, 10819.621313254313, 11298.971957479172, 11477.253978491372], "value": 8968.700689834544, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.02244339189, 1407.8521755215702, 1409.8449170591239, 1531.6477210241637, 1578.2108945527243, 7449.776506704794, 7670.232976702327, 7906.881396779046, 8411.957940210297, 8423.831523369528, 7912.208779122085, 8186.181381861826, 8187.959060204691, 8351.582420878947, 8416.452930559524, 2310.376198426424, 2319.489712263299, 2326.2904814031713, 2337.4273303040695, 2340.2745149003777, 2348.0607756897207, 2386.0455817672896, 2393.640953856918, 2394.317619478449, 2401.0275838285525, 2311.9075236990584, 2334.101370972171, 2350.6591544226076, 2354.223106374901, 2358.457554762406, 2283.5547068321516, 2296.6899468571696, 2305.8155347572238, 2309.0, 2319.93040208794, 2241.181968581472, 2305.9308220753405, 2307.7922986931258, 2314.3982564533176, 2321.419645088728, 8392.370572207048, 8454.112318206622, 8487.40588158829, 8503.277221436123, 8507.574621268912, 5184.170532714786, 5285.418603953562, 5320.095583750733, 5323.201519772027, 5333.813316533902, 3168.8098714077228, 3280.5899262592175, 3298.1589694627714, 3536.5402497675136, 3538.8053657048854, 1072.855164552791, 1079.0219280493307, 1139.3961200563715, 1151.7063148897062, 1164.90680745541, 11394.1454390921, 11412.0, 11447.08423326132, 11456.541738330458, 11479.942600287028, 4599.149157405891, 4632.884177895579, 4693.460252070987, 4705.882352941204, 4899.632527560448, 9755.219582433388, 9871.506424678737, 9878.555465004092, 9896.406215627085, 9926.106650401498, 5347.759350829222, 5350.0904846176245, 5356.4107948125675, 5360.061989151883, 5372.140457526777, 4108.5275193352545, 4186.979065104716, 4818.590419814285, 4879.463259041502, 4924.4090709115135, 3765.661090501868, 3903.765774053509, 3915.5105611798526, 3989.4614227078973, 3991.6607088397814, 1291.2059083663667, 1299.8505171905163, 1313.8160657507956, 1321.8479874814327, 1328.863821432661, 867.2108381372921, 947.7204224753714, 969.3069455339466, 977.1162162564607, 981.1365997921926, 5565.526930210896, 5655.5475561954945, 5675.233843431167, 5731.799387021434, 5856.238688970407, 445.11422269683095, 448.9955100449019, 455.5126015163743, 455.7835028361568, 457.1382943152182, 3426.640202778672, 3458.9135271617906, 3482.0, 3496.1084923344893, 3596.694280986093, 9987.350822196535, 10173.593056277667, 10271.126954208827, 10303.3817970922, 10310.278280520442, 10162.4918754062, 10181.18550515957, 10227.795444091076, 10238.436885971194, 10251.179905607534, 7381.594012329266, 7775.22247775218, 7781.92218077812, 7856.175101614363, 7883.724069657649, 5569.860753481195, 5690.800821971211, 5692.1746346778655, 5735.627184233012, 5801.738921748616, 9150.679726209552, 9266.583003764981, 9309.953450232706, 9389.765255868659, 9416.529173541432, 9445.338826282368, 9638.228941684509, 9667.371620844622, 9683.9031609683, 9703.272254580794, 6568.211814582281, 6701.396874281338, 7179.0, 7499.400047996256, 7626.618669066635, 7944.0, 8021.2379823916635, 8105.918940810752, 8122.106568277367, 8128.390370722102, 6922.5154239204785, 7217.0, 7303.8539229216185, 7306.232845551353, 7313.744018959311, 6930.27232140618, 7101.680424381018, 7124.715011399486, 7322.670479828527, 7329.120505539369, 6842.657867106525, 6857.828554286183, 6881.4494840413645, 6892.379685828299, 6906.8618627628175, 4467.486239082547, 4546.931796023128, 4903.41159060915, 5002.549770520671, 5115.769790359368, 5012.49894392625, 5083.949160508348, 5107.157319042316, 5187.766550505161, 5224.05966925957], "value": 4386.544281828497, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.7885763682425, 333.7380156577087, 337.5308321433208, 340.58788865472786, 344.1928677251843, 5375.543078838298, 5382.62321637485, 5401.27082843816, 5402.648827826189, 5419.485148910852, 5342.622532972829, 5346.385165705945, 5352.5182733553975, 5378.757955891984, 5421.430749771276, 4045.919081618366, 4120.58794120587, 4138.937915931264, 4172.791360431981, 4220.324748040314, 4202.2646036943415, 4216.367544868263, 4220.451341325624, 4226.577342265779, 4230.921115115641, 4189.937150942738, 4193.266178418779, 4205.705600607958, 4209.536950935395, 4224.260754367973, 4119.320312148507, 4119.485064366954, 4143.212789570002, 4223.831046758157, 4226.767527785971, 3711.109333759905, 3724.16206353571, 3726.273376691546, 3729.198222382201, 3740.831662575191, 5193.584513238932, 5199.6360254782185, 5209.843704688866, 5211.869703257449, 5257.237700533401, 4512.172570109111, 4727.432708075019, 4778.163821331288, 4809.807607695688, 4810.759462026885, 5526.613137080406, 5542.5565954723525, 5549.639273447213, 5556.888862222733, 5581.916271255935, 4005.619466150711, 4031.9596804031876, 4032.8991775205855, 4037.959620403817, 4038.1020920167766, 5738.913916291259, 5828.329742079631, 5842.707864606795, 5842.824715258549, 5911.527077833763, 4130.112025914443, 4132.40080188371, 4133.441985332001, 4153.359423027887, 4153.854615088458, 4192.91614167721, 4199.853005144805, 4207.810648520824, 4214.789260536961, 4218.725782824106, 4555.453345598549, 4818.156822556039, 4824.758762061883, 4832.540908613676, 4859.465458799529, 5623.353314368818, 5629.746661400247, 5642.605017648725, 5670.5463562914865, 5692.975264452439, 1394.1913690059741, 1405.2692599848021, 1407.859214078584, 1423.7508436023654, 1425.0808228692435, 944.1549812917538, 974.3958745577787, 976.6484065736329, 988.7725823060737, 1011.5195282240877, 5128.230765385222, 5175.637705360664, 5229.372475302912, 5235.842924712265, 5289.920651190158, 5473.31583552056, 5554.528050066655, 5554.666719996813, 5561.5272701820795, 5561.833145005657, 5236.559946014876, 5241.213817927342, 5277.788888444419, 5330.840074797762, 5550.250716153349, 2966.6736658967498, 2999.2501874531367, 2999.8500074996164, 3005.4890668586395, 3005.5942447769708, 5797.594168408255, 5916.615419997686, 5947.37552556984, 5949.970250148808, 5951.404859514014, 5500.50495455411, 5574.498295153456, 5651.321841378978, 5660.415083776466, 5690.833379157263, 5765.567582431335, 5780.161876527964, 5914.674692891932, 5951.464368206882, 5976.223090998143, 5341.023821186031, 5520.895820835769, 5587.972060139673, 5624.381318054929, 5636.182753500638, 5504.22940788282, 5546.833594992157, 5554.0, 5561.777528898799, 5587.525060369914, 5925.140854575976, 5925.792597259076, 5939.821805345847, 5951.732172052355, 5957.821265362046, 3870.3226935286775, 4013.9397909030804, 4094.733842300241, 4100.380349761887, 4116.958830411658, 5728.770849165987, 5737.139429085503, 5758.309002919509, 5762.567807414377, 5825.368896708928, 5510.641808282448, 5529.253550770755, 5539.532024013559, 5539.612227144061, 5549.556035517229, 5383.892322153457, 5631.887362252814, 5637.8442419304765, 5659.717014149193, 5675.262215911905, 5605.635633683797, 5607.775688972559, 5614.6631202128, 5631.887362252814, 5685.77256909719, 5516.586256030733, 5588.916166257428, 5617.241672374177, 5634.802781902614, 5657.971710141423, 5491.643043202179, 5526.64597173695, 5552.139418390156, 5574.637648552831, 5589.161625756006], "value": 4266.998909125316, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.9486288528361, 742.5730205132047, 779.5751315533034, 791.1890312429761, 826.1243082332728, 13987.440502379905, 14861.256937153139, 14929.552113436586, 14967.850321496782, 14988.325525351358, 13318.40067196976, 13393.464261429532, 13406.06157568968, 13415.19508829471, 13420.328983550808, 482.351237585447, 496.9811885634453, 763.8815983522535, 780.6604127204656, 782.460102529253, 786.3159051625065, 790.0243199648429, 790.1663744749287, 790.2255789326464, 791.7664289034719, 833.2001278772386, 834.0075310380628, 834.4993004197463, 842.4566154830131, 843.9578021098952, 828.130463013833, 833.0420016980461, 833.7707130539089, 835.340081335744, 838.6771093129158, 608.9177960975256, 610.0757352610798, 611.1382950040467, 611.8042226487526, 613.2120225510242, 13347.199168049949, 13374.531891383853, 13379.464821407131, 13435.0, 13704.24626645534, 13142.0, 13573.932130339384, 13994.93002534991, 14445.0, 14468.11040592154, 9932.751681207956, 10114.848277275847, 10465.633702820442, 10465.633702820442, 10484.0, 3554.626764189749, 3602.6217247189193, 3691.667749902495, 3721.4603882437164, 3737.663610275088, 61318.386816131715, 61715.69142154305, 61726.38273617251, 62339.68830155866, 64891.02663460099, 9831.459269740233, 10433.478326083665, 10506.737331566772, 10557.155427565776, 10686.251962362716, 17885.910570447064, 18005.909970450062, 18059.458216253533, 18076.909615451837, 18197.0, 7258.709651613876, 7430.368418684472, 7449.88825167623, 7510.924890751132, 7566.31903128721, 4300.09697963425, 4358.36803663467, 4373.671974601918, 4441.911161776747, 4459.0858873930765, 3304.4052070627517, 3395.0833275015607, 3395.270016946319, 3428.777129486575, 3443.707284880763, 572.1703529881605, 582.624207386242, 599.6072572465042, 600.1268154834705, 619.1393962392278, 613.4785432382439, 630.9652969086744, 676.2932735291632, 705.1291654806311, 712.2770388056024, 8794.472331660121, 9215.078492150866, 9516.904830951602, 9596.209497248687, 9730.270229732798, 586.234963372794, 594.8602078511547, 640.1230314469207, 675.2403546010738, 716.2729829223342, 4222.366645003212, 4261.75828537407, 4485.416895803524, 4492.640588752892, 4831.589314908272, 71122.0, 84493.57753211318, 86368.56815716007, 87932.0, 88045.55977220072, 27643.170704878885, 28125.859370703423, 68190.0, 76499.0, 78402.0, 55636.72181639066, 57661.711691441276, 59774.70112649496, 62397.37602623916, 69915.25211869743, 9463.479508627091, 9743.80512389734, 9832.705018849447, 9885.357451765612, 9895.604175832887, 31669.36661266808, 41307.1738565233, 41614.0, 43066.56933430751, 45559.54440455553, 53733.0, 59112.0, 59189.40810592011, 59939.70030149821, 61659.691701541204, 11568.13239007061, 11902.761944761229, 11951.10366722482, 12205.20666156697, 12341.197822141532, 12399.442025108712, 12754.744905101661, 13134.934325328311, 13599.796003059764, 14287.0, 12270.570530031406, 12307.56923507673, 12889.09776315649, 12978.286194259406, 12985.870141298466, 12776.424961688239, 13013.154144980925, 13085.803712944504, 13159.144655597356, 13339.399727012502, 11852.76294474123, 12201.84990979086, 12342.876571234172, 12401.689957750768, 12583.433745481658, 9985.201183905125, 10036.949815250877, 10232.59069637236, 10463.319884207502, 10622.73443163927, 10232.488375581042, 11085.113190944543, 11406.429678516208, 11486.540538378371, 11541.769164616828], "value": 6774.397896842054, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 112.0, 112.0, 112.0, 112.0, 112.0, 113.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 126.0, 128.0, 161.0, 126.0, 125.0, 131.0, 132.0, 143.0, 128.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 164.0, 168.0, 173.0, 164.0, 162.0, 166.0, 163.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 113.0, 75.0, 75.0, 77.0, 76.0, 101.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 115.0, 83.0, 82.0, 84.0, 101.0, 82.0, 82.0, 110.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 117.0, 118.0, 117.0, 119.0, 118.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 147.0, 147.0, 147.0, 146.0, 148.0, 148.0, 146.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 56.0, 54.0, 55.0, 56.0, 57.0, 55.0, 54.0, 65.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 62.0, 62.0, 67.0, 62.0, 62.0, 61.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 82.0, 82.0, 81.0, 82.0, 81.0, 87.0, 89.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 150.0, 136.0, 135.0, 138.0, 139.0, 138.0, 134.0, 178.0, 148.0], "value": 143.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 167.0, 165.0, 168.0, 162.0, 169.0, 170.0, 167.0, 163.0], "value": 166.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 66.0, 66.0, 67.0, 67.0, 64.0, 66.0, 65.0, 65.0], "value": 66.0, "unit": "score"}]}]} 06:22:25 INFO - Return code: 0 06:22:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:22:25 ERROR - # TBPL SUCCESS # 06:22:25 INFO - Running post-action listener: _resource_record_post_action 06:22:25 INFO - [mozharness: 2016-11-23 14:22:25.938113Z] Finished run-tests step (success) 06:22:25 INFO - Running post-run listener: _resource_record_post_run 06:22:26 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 395640832; Read time: 24; Write time: 277628 06:22:26 INFO - TinderboxPrint: CPU usage
13.4% 06:22:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 06:22:26 INFO - TinderboxPrint: I/O write bytes / time
395,640,832 / 277,628 06:22:26 INFO - TinderboxPrint: CPU idle
8,267.3 (86.5%) 06:22:26 INFO - TinderboxPrint: CPU user
1,222.2 (12.8%) 06:22:26 INFO - TinderboxPrint: Swap in / out
0 / 0 06:22:26 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106602496; Read time: 0; Write time: 85948 06:22:26 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289038336; Read time: 24; Write time: 191680 06:22:26 INFO - Running post-run listener: _upload_blobber_files 06:22:26 INFO - Blob upload gear active. 06:22:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:22:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:22:26 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:22:26 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:22:26 INFO - (blobuploader) - INFO - Open directory for files ... 06:22:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:22:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:22:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:28 INFO - (blobuploader) - INFO - Done attempting. 06:22:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:22:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:22:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:28 INFO - (blobuploader) - INFO - Done attempting. 06:22:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:22:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:22:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:32 INFO - (blobuploader) - INFO - Done attempting. 06:22:32 INFO - (blobuploader) - INFO - Iteration through files over. 06:22:32 INFO - Return code: 0 06:22:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:22:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:22:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1934f555442bd97eebbaff6d23f45dc6d517626c428bdc1d7ea0bfd5b5be4b89eca5946bc65ddaa227b51e4aeab861e7fb3e2a58c42b23d43f5761be3d487ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea5f4b530675cb5a0b47e7c7045397e9b138e5fcc351a86b5be5491ff1a1b2b88d7a5d9a632979a03d04d973f8dae88b71910117b2d7e2c95d096fc4763fe49a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df5978a4166c9da3082276cb02f91d1c7032457802eaef6dfcbb28d8de10b2bd0f65ee14235a226265f2eb74355b09f1619113ae241608be4b88ab8aaab48d60"} 06:22:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:22:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:22:32 INFO - Contents: 06:22:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1934f555442bd97eebbaff6d23f45dc6d517626c428bdc1d7ea0bfd5b5be4b89eca5946bc65ddaa227b51e4aeab861e7fb3e2a58c42b23d43f5761be3d487ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea5f4b530675cb5a0b47e7c7045397e9b138e5fcc351a86b5be5491ff1a1b2b88d7a5d9a632979a03d04d973f8dae88b71910117b2d7e2c95d096fc4763fe49a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df5978a4166c9da3082276cb02f91d1c7032457802eaef6dfcbb28d8de10b2bd0f65ee14235a226265f2eb74355b09f1619113ae241608be4b88ab8aaab48d60"} 06:22:32 INFO - Running post-run listener: copy_logs_to_upload_dir 06:22:32 INFO - Copying logs to upload dir... 06:22:32 INFO - mkdir: /builds/slave/test/build/upload/logs 06:22:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.276068 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-11-23 06:22:32.602909) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 06:22:32.606441) ========= 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=920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1934f555442bd97eebbaff6d23f45dc6d517626c428bdc1d7ea0bfd5b5be4b89eca5946bc65ddaa227b51e4aeab861e7fb3e2a58c42b23d43f5761be3d487ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea5f4b530675cb5a0b47e7c7045397e9b138e5fcc351a86b5be5491ff1a1b2b88d7a5d9a632979a03d04d973f8dae88b71910117b2d7e2c95d096fc4763fe49a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df5978a4166c9da3082276cb02f91d1c7032457802eaef6dfcbb28d8de10b2bd0f65ee14235a226265f2eb74355b09f1619113ae241608be4b88ab8aaab48d60"} build_url:https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011635 build_url: 'https://queue.taskcluster.net/v1/task/cw_B2vSJQAq3spRESeNd9A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1934f555442bd97eebbaff6d23f45dc6d517626c428bdc1d7ea0bfd5b5be4b89eca5946bc65ddaa227b51e4aeab861e7fb3e2a58c42b23d43f5761be3d487ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea5f4b530675cb5a0b47e7c7045397e9b138e5fcc351a86b5be5491ff1a1b2b88d7a5d9a632979a03d04d973f8dae88b71910117b2d7e2c95d096fc4763fe49a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df5978a4166c9da3082276cb02f91d1c7032457802eaef6dfcbb28d8de10b2bd0f65ee14235a226265f2eb74355b09f1619113ae241608be4b88ab8aaab48d60"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 06:22:32.632001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 06:22:32.632347) ========= 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=920470bf432669ad7e3a5387000001ca-1479909708.486207-876277826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 06:22:32.717986) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 06:22:32.718309) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 06:22:32.718646) ========= ========= Total master_lag: 0.19 =========