builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1476613438.85 results: success (0) buildid: 20161016003004 builduid: 9efdcbb1feda421781bc951d1a310523 revision: 94f47e1077442d749f7fe7de027fcbdfeacf3daf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-16 03:23:58.851500) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-16 03:23:58.851947) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-16 03:23:58.852300) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-16 03:23:58.926529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 03:23:58.927087) ========= 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=41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-16 03:23:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.9M=0s 2016-10-16 03:23:59 (38.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.173198 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 03:23:59.136735) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 03:23:59.137502) ========= 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=41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014366 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 03:23:59.190925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 03:23:59.191294) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 94f47e1077442d749f7fe7de027fcbdfeacf3daf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 94f47e1077442d749f7fe7de027fcbdfeacf3daf --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=41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-16 03:23:59,316 truncating revision to first 12 chars 2016-10-16 03:23:59,316 Setting DEBUG logging. 2016-10-16 03:23:59,316 attempt 1/10 2016-10-16 03:23:59,316 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/94f47e107744?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-16 03:23:59,750 unpacking tar archive at: mozilla-inbound-94f47e107744/testing/mozharness/ program finished with exit code 0 elapsedTime=0.752898 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 03:23:59.959841) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-16 03:23:59.960176) ========= script_repo_revision: 94f47e1077442d749f7fe7de027fcbdfeacf3daf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-16 03:23:59.960600) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-16 03:23:59.960918) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-16 03:23:59.971008) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-16 03:23:59.971344) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:24:00 INFO - MultiFileLogger online at 20161016 03:24:00 in /builds/slave/test 03:24:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 03:24:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:24:00 INFO - {'append_to_log': False, 03:24:00 INFO - 'base_work_dir': '/builds/slave/test', 03:24:00 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:24:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:24:00 INFO - 'branch': 'Mozilla-Inbound', 03:24:00 INFO - 'buildbot_json_path': 'buildprops.json', 03:24:00 INFO - 'config_files': ('talos/linux_config.py',), 03:24:00 INFO - 'default_actions': ('clobber', 03:24:00 INFO - 'read-buildbot-config', 03:24:00 INFO - 'download-and-extract', 03:24:00 INFO - 'populate-webroot', 03:24:00 INFO - 'create-virtualenv', 03:24:00 INFO - 'install', 03:24:00 INFO - 'run-tests'), 03:24:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:24:00 INFO - 'download_minidump_stackwalk': True, 03:24:00 INFO - 'download_symbols': 'ondemand', 03:24:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:24:00 INFO - 'tooltool.py': '/tools/tooltool.py', 03:24:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:24:00 INFO - '/tools/misc-python/virtualenv.py')}, 03:24:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:24:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:24:00 INFO - 'installer_path': 'installer.exe', 03:24:00 INFO - 'log_level': 'info', 03:24:00 INFO - 'log_name': 'talos', 03:24:00 INFO - 'log_to_console': True, 03:24:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:24:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:24:00 INFO - 'opt_config_files': (), 03:24:00 INFO - 'pip_index': False, 03:24:00 INFO - 'sps_profile': False, 03:24:00 INFO - 'sps_profile_interval': 0, 03:24:00 INFO - 'suite': 'dromaeojs', 03:24:00 INFO - 'system_bits': '32', 03:24:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:24:00 INFO - 'title': 'talos-linux64-ix-026', 03:24:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:24:00 INFO - 'use_talos_json': True, 03:24:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:24:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:24:00 INFO - 'work_dir': 'build'} 03:24:00 INFO - [mozharness: 2016-10-16 10:24:00.306105Z] Running clobber step. 03:24:00 INFO - Running pre-action listener: _resource_record_pre_action 03:24:00 INFO - Running main action method: clobber 03:24:00 INFO - rmtree: /builds/slave/test/build 03:24:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:24:00 INFO - Running post-action listener: _resource_record_post_action 03:24:00 INFO - [mozharness: 2016-10-16 10:24:00.730017Z] Finished clobber step (success) 03:24:00 INFO - [mozharness: 2016-10-16 10:24:00.730119Z] Running read-buildbot-config step. 03:24:00 INFO - Running pre-action listener: _resource_record_pre_action 03:24:00 INFO - Running main action method: read_buildbot_config 03:24:00 INFO - Using buildbot properties: 03:24:00 INFO - { 03:24:00 INFO - "project": "", 03:24:00 INFO - "product": "firefox", 03:24:00 INFO - "script_repo_revision": "production", 03:24:00 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 03:24:00 INFO - "repository": "", 03:24:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 03:24:00 INFO - "buildid": "20161016003004", 03:24:00 INFO - "pgo_build": "True", 03:24:00 INFO - "basedir": "/builds/slave/test", 03:24:00 INFO - "buildnumber": 1703, 03:24:00 INFO - "slavename": "talos-linux64-ix-026", 03:24:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:24:00 INFO - "platform": "ubuntu64_hw", 03:24:00 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:24:00 INFO - "branch": "mozilla-inbound", 03:24:00 INFO - "repo_path": "integration/mozilla-inbound", 03:24:00 INFO - "revision": "94f47e1077442d749f7fe7de027fcbdfeacf3daf", 03:24:00 INFO - "stage_platform": "linux64-pgo", 03:24:00 INFO - "builduid": "9efdcbb1feda421781bc951d1a310523", 03:24:00 INFO - "slavebuilddir": "test" 03:24:00 INFO - } 03:24:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:24:00 INFO - Running post-action listener: _resource_record_post_action 03:24:00 INFO - [mozharness: 2016-10-16 10:24:00.732574Z] Finished read-buildbot-config step (success) 03:24:00 INFO - [mozharness: 2016-10-16 10:24:00.732662Z] Running download-and-extract step. 03:24:00 INFO - Running pre-action listener: _resource_record_pre_action 03:24:00 INFO - Running main action method: download_and_extract 03:24:00 INFO - mkdir: /builds/slave/test/build/tests 03:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:00 INFO - trying https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:24:00 INFO - Downloading https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:24:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:24:01 INFO - Downloaded 1361 bytes. 03:24:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:24:01 INFO - Using the following test package requirements: 03:24:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:24:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:24:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:24:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:24:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:24:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:24:01 INFO - u'jsshell-linux-x86_64.zip'], 03:24:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:24:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:24:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:24:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:24:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:24:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:24:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:24:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:24:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:24:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:24:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:24:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:24:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:24:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:24:01 INFO - Fetch https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:24:02 INFO - Http code: 200 03:24:02 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 03:24:02 INFO - x-amz-cf-id: NZZqSqccb1SzZy-Ii02-trI1QaAxGNUVsUIXXZuuH0UG6UHraswtSw== 03:24:02 INFO - x-amz-version-id: eZwDnU2HnHj7d4lMzjpDkpHmIqikO7kE 03:24:03 INFO - Expected file size: 22096436 03:24:03 INFO - Obtained file size: 22096436 03:24:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:24:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:24:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:24:07 INFO - Fetch https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:24:07 INFO - Http code: 200 03:24:07 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 03:24:07 INFO - x-amz-cf-id: VLwCOAPFho8ThcV50B0MzGYzbZkjt5C2rRtET8P3ujrOcrdAqiJFLA== 03:24:07 INFO - x-amz-version-id: eZwDnU2HnHj7d4lMzjpDkpHmIqikO7kE 03:24:08 INFO - Expected file size: 22096436 03:24:08 INFO - Obtained file size: 22096436 03:24:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:24:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:24:12 INFO - Fetch https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:24:13 INFO - Http code: 200 03:24:13 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 03:24:13 INFO - x-amz-cf-id: 4XbJJFmYVkykCvLEOGvF-YYaEtOhxt6bX3rcCdHWh8N0VnDFoczYpg== 03:24:13 INFO - x-amz-version-id: 6zlbOCWwD3Rtkmlsw60wKw7bQvLQDfVP 03:24:14 INFO - Expected file size: 14409028 03:24:14 INFO - Obtained file size: 14409028 03:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:14 INFO - trying https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:24:14 INFO - Downloading https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:24:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:24:17 INFO - Downloaded 59607946 bytes. 03:24:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:24:17 INFO - mkdir: /builds/slave/test/properties 03:24:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:24:17 INFO - Writing to file /builds/slave/test/properties/build_url 03:24:17 INFO - Contents: 03:24:17 INFO - build_url:https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:24:17 INFO - Running post-action listener: _resource_record_post_action 03:24:17 INFO - Running post-action listener: set_extra_try_arguments 03:24:17 INFO - [mozharness: 2016-10-16 10:24:17.757015Z] Finished download-and-extract step (success) 03:24:17 INFO - [mozharness: 2016-10-16 10:24:17.757242Z] Running populate-webroot step. 03:24:17 INFO - Running pre-action listener: _resource_record_pre_action 03:24:17 INFO - Running main action method: populate_webroot 03:24:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:24:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:24:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:24:17 INFO - '--tppagecycles', 03:24:17 INFO - '7'], 03:24:17 INFO - 'tests': ['tsvgm']}}, 03:24:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:24:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:24:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:24:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:24:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:24:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:24:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:17 INFO - 'talos_options': ['--disable-e10s'], 03:24:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:24:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:24:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:17 INFO - 'talos_options': ['--disable-e10s'], 03:24:17 INFO - 'tests': ['damp', 'tps']}, 03:24:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:17 INFO - 'tests': ['damp', 'tps']}, 03:24:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:24:17 INFO - 'tests': ['dromaeo_dom']}, 03:24:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:24:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:24:17 INFO - 'tests': ['basic_compositor_video']}, 03:24:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:24:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:24:17 INFO - 'tests': ['a11yr', 03:24:17 INFO - 'ts_paint', 03:24:17 INFO - 'tpaint', 03:24:17 INFO - 'sessionrestore', 03:24:17 INFO - 'sessionrestore_no_auto_restore', 03:24:17 INFO - 'tabpaint']}, 03:24:17 INFO - 'other-e10s': {'tests': ['a11yr', 03:24:17 INFO - 'ts_paint', 03:24:17 INFO - 'tpaint', 03:24:17 INFO - 'sessionrestore', 03:24:17 INFO - 'sessionrestore_no_auto_restore', 03:24:17 INFO - 'tabpaint']}, 03:24:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:24:17 INFO - 'ts_paint', 03:24:17 INFO - 'tpaint', 03:24:17 INFO - 'sessionrestore', 03:24:17 INFO - 'sessionrestore_no_auto_restore', 03:24:17 INFO - 'tabpaint']}, 03:24:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:24:17 INFO - 'ts_paint', 03:24:17 INFO - 'tpaint', 03:24:17 INFO - 'sessionrestore', 03:24:17 INFO - 'sessionrestore_no_auto_restore', 03:24:17 INFO - 'tabpaint']}, 03:24:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:24:17 INFO - 'tests': ['a11yr', 03:24:17 INFO - 'ts_paint', 03:24:17 INFO - 'tpaint', 03:24:17 INFO - 'sessionrestore', 03:24:17 INFO - 'sessionrestore_no_auto_restore', 03:24:17 INFO - 'tabpaint']}, 03:24:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:24:17 INFO - 'tests': ['a11yr', 03:24:17 INFO - 'ts_paint', 03:24:17 INFO - 'tpaint', 03:24:17 INFO - 'sessionrestore', 03:24:17 INFO - 'sessionrestore_no_auto_restore', 03:24:17 INFO - 'tabpaint']}, 03:24:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:24:17 INFO - 'tests': ['tsvgx', 03:24:17 INFO - 'tsvgr_opacity', 03:24:17 INFO - 'tart', 03:24:17 INFO - 'tscrollx', 03:24:17 INFO - 'cart']}, 03:24:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:24:17 INFO - 'tsvgr_opacity', 03:24:17 INFO - 'tart', 03:24:17 INFO - 'tscrollx', 03:24:17 INFO - 'cart']}, 03:24:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:17 INFO - 'talos_options': ['--disable-e10s'], 03:24:17 INFO - 'tests': ['tp5o']}, 03:24:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:17 INFO - 'tests': ['tp5o']}, 03:24:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:17 INFO - 'talos_options': ['--disable-e10s', 03:24:17 INFO - '--xperf_path', 03:24:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:24:17 INFO - 'tests': ['tp5n']}, 03:24:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:17 INFO - 'talos_options': ['--xperf_path', 03:24:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:24:17 INFO - 'tests': ['tp5n']}}, 03:24:17 INFO - 'talos.zip': {'path': '', 03:24:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:24:17 INFO - Running post-action listener: _resource_record_post_action 03:24:17 INFO - [mozharness: 2016-10-16 10:24:17.773674Z] Finished populate-webroot step (success) 03:24:17 INFO - [mozharness: 2016-10-16 10:24:17.773761Z] Running create-virtualenv step. 03:24:17 INFO - Running pre-action listener: _resource_record_pre_action 03:24:17 INFO - Running main action method: create_virtualenv 03:24:17 INFO - Creating virtualenv /builds/slave/test/build/venv 03:24:17 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 03:24:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:24:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:24:17 INFO - Using real prefix '/usr' 03:24:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:24:18 INFO - Installing distribute.............................................................................................................................................................................................done. 03:24:21 INFO - Installing pip.................done. 03:24:21 INFO - Return code: 0 03:24:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:24:21 INFO - Reading from file tmpfile_stdout 03:24:21 INFO - Output received: 03:24:21 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) 03:24:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:21 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 0x7f584189bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd60f60>, '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 0xd61d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd621d0>, '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': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', '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 03:24:21 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 03:24:21 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 03:24:21 INFO - Using env: {'DISPLAY': ':0', 03:24:21 INFO - 'HOME': '/home/cltbld', 03:24:21 INFO - 'LANG': 'en_US.UTF-8', 03:24:21 INFO - 'LANGUAGE': 'en_US:en', 03:24:21 INFO - 'LOGNAME': 'cltbld', 03:24:21 INFO - 'MAIL': '/var/mail/cltbld', 03:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:21 INFO - 'MOZ_NO_REMOTE': '1', 03:24:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:21 INFO - 'NO_EM_RESTART': '1', 03:24:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:21 INFO - 'PWD': '/builds/slave/test', 03:24:21 INFO - 'SHELL': '/bin/bash', 03:24:21 INFO - 'SHLVL': '1', 03:24:21 INFO - 'TERM': 'linux', 03:24:21 INFO - 'TMOUT': '86400', 03:24:21 INFO - 'USER': 'cltbld', 03:24:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', 03:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:21 INFO - '_': '/tools/buildbot/bin/python'} 03:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:21 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 03:24:21 INFO - Cleaning up... 03:24:21 INFO - Return code: 0 03:24:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:21 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 0x7f584189bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd60f60>, '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 0xd61d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd621d0>, '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': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', '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 03:24:21 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 03:24:21 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 03:24:21 INFO - Using env: {'DISPLAY': ':0', 03:24:21 INFO - 'HOME': '/home/cltbld', 03:24:21 INFO - 'LANG': 'en_US.UTF-8', 03:24:21 INFO - 'LANGUAGE': 'en_US:en', 03:24:21 INFO - 'LOGNAME': 'cltbld', 03:24:21 INFO - 'MAIL': '/var/mail/cltbld', 03:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:21 INFO - 'MOZ_NO_REMOTE': '1', 03:24:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:21 INFO - 'NO_EM_RESTART': '1', 03:24:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:21 INFO - 'PWD': '/builds/slave/test', 03:24:21 INFO - 'SHELL': '/bin/bash', 03:24:21 INFO - 'SHLVL': '1', 03:24:21 INFO - 'TERM': 'linux', 03:24:21 INFO - 'TMOUT': '86400', 03:24:21 INFO - 'USER': 'cltbld', 03:24:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', 03:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:21 INFO - '_': '/tools/buildbot/bin/python'} 03:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:21 INFO - Downloading/unpacking psutil>=3.1.1 03:24:21 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 03:24:21 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 03:24:21 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 03:24:21 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 03:24:21 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 03:24:21 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 03:24:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:24:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:24:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:24:23 INFO - Installing collected packages: psutil 03:24:23 INFO - Running setup.py install for psutil 03:24:24 INFO - building 'psutil._psutil_linux' extension 03:24:24 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 03:24:25 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 03:24:25 INFO - building 'psutil._psutil_posix' extension 03:24:25 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 03:24:25 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 03:24:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:24:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:24:25 INFO - Successfully installed psutil 03:24:25 INFO - Cleaning up... 03:24:25 INFO - Return code: 0 03:24:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f584189bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd60f60>, '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 0xd61d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd621d0>, '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': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', '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 03:24:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:24:25 INFO - Using env: {'DISPLAY': ':0', 03:24:25 INFO - 'HOME': '/home/cltbld', 03:24:25 INFO - 'LANG': 'en_US.UTF-8', 03:24:25 INFO - 'LANGUAGE': 'en_US:en', 03:24:25 INFO - 'LOGNAME': 'cltbld', 03:24:25 INFO - 'MAIL': '/var/mail/cltbld', 03:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:25 INFO - 'MOZ_NO_REMOTE': '1', 03:24:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:25 INFO - 'NO_EM_RESTART': '1', 03:24:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:25 INFO - 'PWD': '/builds/slave/test', 03:24:25 INFO - 'SHELL': '/bin/bash', 03:24:25 INFO - 'SHLVL': '1', 03:24:25 INFO - 'TERM': 'linux', 03:24:25 INFO - 'TMOUT': '86400', 03:24:25 INFO - 'USER': 'cltbld', 03:24:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', 03:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:25 INFO - '_': '/tools/buildbot/bin/python'} 03:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:24:26 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 03:24:26 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 03:24:26 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 03:24:26 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 03:24:26 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 03:24:26 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 03:24:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:24:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:24:28 INFO - Installing collected packages: mozsystemmonitor 03:24:28 INFO - Running setup.py install for mozsystemmonitor 03:24:28 INFO - Successfully installed mozsystemmonitor 03:24:28 INFO - Cleaning up... 03:24:28 INFO - Return code: 0 03:24:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:24:28 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')]} 03:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:28 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')]} 03:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:28 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 0x7f584189bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd60f60>, '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 0xd61d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd621d0>, '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': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', '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 03:24:28 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 03:24:28 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 03:24:28 INFO - Using env: {'DISPLAY': ':0', 03:24:28 INFO - 'HOME': '/home/cltbld', 03:24:28 INFO - 'LANG': 'en_US.UTF-8', 03:24:28 INFO - 'LANGUAGE': 'en_US:en', 03:24:28 INFO - 'LOGNAME': 'cltbld', 03:24:28 INFO - 'MAIL': '/var/mail/cltbld', 03:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:28 INFO - 'MOZ_NO_REMOTE': '1', 03:24:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:28 INFO - 'NO_EM_RESTART': '1', 03:24:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:28 INFO - 'PWD': '/builds/slave/test', 03:24:28 INFO - 'SHELL': '/bin/bash', 03:24:28 INFO - 'SHLVL': '1', 03:24:28 INFO - 'TERM': 'linux', 03:24:28 INFO - 'TMOUT': '86400', 03:24:28 INFO - 'USER': 'cltbld', 03:24:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', 03:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:28 INFO - '_': '/tools/buildbot/bin/python'} 03:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:28 INFO - Downloading/unpacking jsonschema==2.5.1 03:24:28 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 03:24:28 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 03:24:28 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 03:24:28 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 03:24:28 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 03:24:28 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 03:24:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:24:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:30 INFO - Downloading functools32-3.2.3-2.tar.gz 03:24:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:24:30 INFO - warning: no files found matching '*.txt' 03:24:30 INFO - no previously-included directories found matching 'build' 03:24:30 INFO - no previously-included directories found matching 'dist' 03:24:30 INFO - no previously-included directories found matching '.git*' 03:24:30 INFO - Installing collected packages: jsonschema, functools32 03:24:30 INFO - Running setup.py install for functools32 03:24:30 INFO - warning: no files found matching '*.txt' 03:24:30 INFO - no previously-included directories found matching 'build' 03:24:30 INFO - no previously-included directories found matching 'dist' 03:24:30 INFO - no previously-included directories found matching '.git*' 03:24:30 INFO - Successfully installed jsonschema functools32 03:24:30 INFO - Cleaning up... 03:24:30 INFO - Return code: 0 03:24:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f584189bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd60f60>, '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 0xd61d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd621d0>, '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': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', '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 03:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:24:30 INFO - Using env: {'DISPLAY': ':0', 03:24:30 INFO - 'HOME': '/home/cltbld', 03:24:30 INFO - 'LANG': 'en_US.UTF-8', 03:24:30 INFO - 'LANGUAGE': 'en_US:en', 03:24:30 INFO - 'LOGNAME': 'cltbld', 03:24:30 INFO - 'MAIL': '/var/mail/cltbld', 03:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:30 INFO - 'MOZ_NO_REMOTE': '1', 03:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:30 INFO - 'NO_EM_RESTART': '1', 03:24:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:30 INFO - 'PWD': '/builds/slave/test', 03:24:30 INFO - 'SHELL': '/bin/bash', 03:24:30 INFO - 'SHLVL': '1', 03:24:30 INFO - 'TERM': 'linux', 03:24:30 INFO - 'TMOUT': '86400', 03:24:30 INFO - 'USER': 'cltbld', 03:24:30 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', 03:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:30 INFO - '_': '/tools/buildbot/bin/python'} 03:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:24:31 INFO - Cleaning up... 03:24:31 INFO - Return code: 0 03:24:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:24:31 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')]} 03:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:31 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')]} 03:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:31 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 0x7f584189bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd60f60>, '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 0xd61d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd621d0>, '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': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', '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 03:24:31 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 03:24:31 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 03:24:31 INFO - Using env: {'DISPLAY': ':0', 03:24:31 INFO - 'HOME': '/home/cltbld', 03:24:31 INFO - 'LANG': 'en_US.UTF-8', 03:24:31 INFO - 'LANGUAGE': 'en_US:en', 03:24:31 INFO - 'LOGNAME': 'cltbld', 03:24:31 INFO - 'MAIL': '/var/mail/cltbld', 03:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:31 INFO - 'MOZ_NO_REMOTE': '1', 03:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:31 INFO - 'NO_EM_RESTART': '1', 03:24:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:31 INFO - 'PWD': '/builds/slave/test', 03:24:31 INFO - 'SHELL': '/bin/bash', 03:24:31 INFO - 'SHLVL': '1', 03:24:31 INFO - 'TERM': 'linux', 03:24:31 INFO - 'TMOUT': '86400', 03:24:31 INFO - 'USER': 'cltbld', 03:24:31 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', 03:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:31 INFO - '_': '/tools/buildbot/bin/python'} 03:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:31 INFO - Downloading/unpacking blobuploader==1.2.4 03:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:33 INFO - Downloading blobuploader-1.2.4.tar.gz 03:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:24:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:24:33 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 03:24:33 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 03:24:33 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 03:24:33 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 03:24:33 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 03:24:33 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 03:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:24:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:24:33 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 03:24:33 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 03:24:33 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 03:24:33 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 03:24:33 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 03:24:33 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 03:24:33 INFO - Downloading docopt-0.6.1.tar.gz 03:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:24:34 INFO - Installing collected packages: blobuploader, requests, docopt 03:24:34 INFO - Running setup.py install for blobuploader 03:24:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:24:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:24:34 INFO - Running setup.py install for requests 03:24:34 INFO - Running setup.py install for docopt 03:24:34 INFO - Successfully installed blobuploader requests docopt 03:24:34 INFO - Cleaning up... 03:24:34 INFO - Return code: 0 03:24:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24:34 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')]} 03:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:34 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')]} 03:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:34 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 0x7f584189bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd60f60>, '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 0xd61d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd621d0>, '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': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', '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 03:24:34 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 03:24:34 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 03:24:34 INFO - Using env: {'DISPLAY': ':0', 03:24:34 INFO - 'HOME': '/home/cltbld', 03:24:34 INFO - 'LANG': 'en_US.UTF-8', 03:24:34 INFO - 'LANGUAGE': 'en_US:en', 03:24:34 INFO - 'LOGNAME': 'cltbld', 03:24:34 INFO - 'MAIL': '/var/mail/cltbld', 03:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:34 INFO - 'MOZ_NO_REMOTE': '1', 03:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:34 INFO - 'NO_EM_RESTART': '1', 03:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:34 INFO - 'PWD': '/builds/slave/test', 03:24:34 INFO - 'SHELL': '/bin/bash', 03:24:34 INFO - 'SHLVL': '1', 03:24:34 INFO - 'TERM': 'linux', 03:24:34 INFO - 'TMOUT': '86400', 03:24:34 INFO - 'USER': 'cltbld', 03:24:34 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', 03:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:34 INFO - '_': '/tools/buildbot/bin/python'} 03:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:24:34 INFO - Running setup.py (path:/tmp/pip-3t5NiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:24:34 INFO - Running setup.py (path:/tmp/pip-mGdcfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:24:34 INFO - Running setup.py (path:/tmp/pip-u6ZFl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:24:35 INFO - Running setup.py (path:/tmp/pip-pxnpVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:24:35 INFO - Running setup.py (path:/tmp/pip-TevtOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:24:35 INFO - Running setup.py (path:/tmp/pip-tMQt_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:24:35 INFO - Running setup.py (path:/tmp/pip-LU1jKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:24:35 INFO - Running setup.py (path:/tmp/pip-oFjlcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:24:35 INFO - Running setup.py (path:/tmp/pip-4SN5Px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:24:35 INFO - Running setup.py (path:/tmp/pip-FgFFXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:24:35 INFO - Running setup.py (path:/tmp/pip-1rvVit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:24:35 INFO - Running setup.py (path:/tmp/pip-5ZgKyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:24:35 INFO - Running setup.py (path:/tmp/pip-ZTnfN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:24:35 INFO - Running setup.py (path:/tmp/pip-DpKIxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:35 INFO - Running setup.py (path:/tmp/pip-QEvziE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:24:35 INFO - Running setup.py (path:/tmp/pip-488fw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:24:36 INFO - Running setup.py (path:/tmp/pip-fD_jD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:24:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:24:36 INFO - Running setup.py install for manifestparser 03:24:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:24:36 INFO - Running setup.py install for mozcrash 03:24:36 INFO - Running setup.py install for mozdebug 03:24:36 INFO - Running setup.py install for mozdevice 03:24:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:24:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:24:36 INFO - Running setup.py install for mozfile 03:24:36 INFO - Running setup.py install for mozhttpd 03:24:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:24:36 INFO - Running setup.py install for mozinfo 03:24:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:24:36 INFO - Running setup.py install for mozInstall 03:24:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:24:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:24:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:24:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:24:36 INFO - Running setup.py install for mozleak 03:24:36 INFO - Running setup.py install for mozlog 03:24:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:24:37 INFO - Running setup.py install for moznetwork 03:24:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:24:37 INFO - Running setup.py install for mozprocess 03:24:37 INFO - Running setup.py install for mozprofile 03:24:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:24:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:24:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:24:37 INFO - Running setup.py install for mozrunner 03:24:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:24:37 INFO - Running setup.py install for mozscreenshot 03:24:37 INFO - Running setup.py install for moztest 03:24:37 INFO - Running setup.py install for mozversion 03:24:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:24:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:24:37 INFO - Cleaning up... 03:24:37 INFO - Return code: 0 03:24:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24:37 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')]} 03:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:37 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')]} 03:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:37 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 0x7f584189bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd60f60>, '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 0xd61d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd621d0>, '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': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', '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 03:24:37 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 03:24:37 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 03:24:37 INFO - Using env: {'DISPLAY': ':0', 03:24:37 INFO - 'HOME': '/home/cltbld', 03:24:37 INFO - 'LANG': 'en_US.UTF-8', 03:24:37 INFO - 'LANGUAGE': 'en_US:en', 03:24:37 INFO - 'LOGNAME': 'cltbld', 03:24:37 INFO - 'MAIL': '/var/mail/cltbld', 03:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:37 INFO - 'MOZ_NO_REMOTE': '1', 03:24:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:37 INFO - 'NO_EM_RESTART': '1', 03:24:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:37 INFO - 'PWD': '/builds/slave/test', 03:24:37 INFO - 'SHELL': '/bin/bash', 03:24:37 INFO - 'SHLVL': '1', 03:24:37 INFO - 'TERM': 'linux', 03:24:37 INFO - 'TMOUT': '86400', 03:24:37 INFO - 'USER': 'cltbld', 03:24:37 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', 03:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:37 INFO - '_': '/tools/buildbot/bin/python'} 03:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:24:38 INFO - Running setup.py (path:/tmp/pip-wNvqRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:24:38 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)) 03:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:24:38 INFO - Running setup.py (path:/tmp/pip-IVow_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:24:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:24:38 INFO - Running setup.py (path:/tmp/pip-g1rZiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:24:38 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)) 03:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:24:38 INFO - Running setup.py (path:/tmp/pip-P9Y4H2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:24:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:24:38 INFO - Running setup.py (path:/tmp/pip-apPDpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:24:38 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)) 03:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:24:38 INFO - Running setup.py (path:/tmp/pip-nZBcbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:24:38 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)) 03:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:24:38 INFO - Running setup.py (path:/tmp/pip-tO5MxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:24:38 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)) 03:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:24:38 INFO - Running setup.py (path:/tmp/pip-lzpCyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:24:38 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)) 03:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:24:38 INFO - Running setup.py (path:/tmp/pip-4C1Z0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:24:38 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)) 03:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:24:38 INFO - Running setup.py (path:/tmp/pip-QzCgpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:24:38 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)) 03:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:24:38 INFO - Running setup.py (path:/tmp/pip-GJGrPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:24:38 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)) 03:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:24:38 INFO - Running setup.py (path:/tmp/pip-oXiOTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:24:38 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)) 03:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:24:38 INFO - Running setup.py (path:/tmp/pip-0S3C0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:24:39 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)) 03:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:24:39 INFO - Running setup.py (path:/tmp/pip-Qb32ZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:39 INFO - Running setup.py (path:/tmp/pip-G8YaQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:39 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)) 03:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:24:39 INFO - Running setup.py (path:/tmp/pip-AKiuWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:24:39 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)) 03:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:24:39 INFO - Running setup.py (path:/tmp/pip-rfRxu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:24:39 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)) 03:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:24:39 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)) 03:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:24:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:24:39 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 03:24:39 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 03:24:39 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 03:24:39 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 03:24:39 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 03:24:39 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 03:24:41 INFO - Downloading blessings-1.6.tar.gz 03:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:24:41 INFO - Installing collected packages: blessings 03:24:41 INFO - Running setup.py install for blessings 03:24:41 INFO - Successfully installed blessings 03:24:41 INFO - Cleaning up... 03:24:41 INFO - Return code: 0 03:24:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:24:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:24:41 INFO - Reading from file tmpfile_stdout 03:24:41 INFO - Current package versions: 03:24:41 INFO - argparse == 1.2.1 03:24:41 INFO - blessings == 1.6 03:24:41 INFO - blobuploader == 1.2.4 03:24:41 INFO - docopt == 0.6.1 03:24:41 INFO - functools32 == 3.2.3-2 03:24:41 INFO - jsonschema == 2.5.1 03:24:41 INFO - manifestparser == 1.1 03:24:41 INFO - mozInstall == 1.12 03:24:41 INFO - mozcrash == 0.17 03:24:41 INFO - mozdebug == 0.1 03:24:41 INFO - mozdevice == 0.48 03:24:41 INFO - mozfile == 1.2 03:24:41 INFO - mozhttpd == 0.7 03:24:41 INFO - mozinfo == 0.9 03:24:41 INFO - mozleak == 0.1 03:24:41 INFO - mozlog == 3.4 03:24:41 INFO - moznetwork == 0.27 03:24:41 INFO - mozprocess == 0.23 03:24:41 INFO - mozprofile == 0.28 03:24:41 INFO - mozrunner == 6.12 03:24:41 INFO - mozscreenshot == 0.1 03:24:41 INFO - mozsystemmonitor == 0.3 03:24:41 INFO - moztest == 0.7 03:24:41 INFO - mozversion == 1.4 03:24:41 INFO - psutil == 3.1.1 03:24:41 INFO - requests == 1.2.3 03:24:41 INFO - wsgiref == 0.1.2 03:24:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24:41 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')]} 03:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:41 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')]} 03:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:41 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 0x7f584189bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd60f60>, '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 0xd61d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd621d0>, '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': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', '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 03:24:41 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 03:24:41 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 03:24:41 INFO - Using env: {'DISPLAY': ':0', 03:24:41 INFO - 'HOME': '/home/cltbld', 03:24:41 INFO - 'LANG': 'en_US.UTF-8', 03:24:41 INFO - 'LANGUAGE': 'en_US:en', 03:24:41 INFO - 'LOGNAME': 'cltbld', 03:24:41 INFO - 'MAIL': '/var/mail/cltbld', 03:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:41 INFO - 'MOZ_NO_REMOTE': '1', 03:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:41 INFO - 'NO_EM_RESTART': '1', 03:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:41 INFO - 'PWD': '/builds/slave/test', 03:24:41 INFO - 'SHELL': '/bin/bash', 03:24:41 INFO - 'SHLVL': '1', 03:24:41 INFO - 'TERM': 'linux', 03:24:41 INFO - 'TMOUT': '86400', 03:24:41 INFO - 'USER': 'cltbld', 03:24:41 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', 03:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:41 INFO - '_': '/tools/buildbot/bin/python'} 03:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:41 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)) 03:24:41 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)) 03:24:41 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)) 03:24:41 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)) 03:24:41 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)) 03:24:41 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)) 03:24:41 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)) 03:24:41 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)) 03:24:41 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)) 03:24:41 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)) 03:24:41 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)) 03:24:41 INFO - Cleaning up... 03:24:41 INFO - Return code: 0 03:24:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:24:41 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')]} 03:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:41 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')]} 03:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:41 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 0x7f584189bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd60f60>, '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 0xd61d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd621d0>, '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': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', '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 03:24:41 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 03:24:41 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 03:24:41 INFO - Using env: {'DISPLAY': ':0', 03:24:41 INFO - 'HOME': '/home/cltbld', 03:24:41 INFO - 'LANG': 'en_US.UTF-8', 03:24:41 INFO - 'LANGUAGE': 'en_US:en', 03:24:41 INFO - 'LOGNAME': 'cltbld', 03:24:41 INFO - 'MAIL': '/var/mail/cltbld', 03:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:41 INFO - 'MOZ_NO_REMOTE': '1', 03:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:41 INFO - 'NO_EM_RESTART': '1', 03:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:42 INFO - 'PWD': '/builds/slave/test', 03:24:42 INFO - 'SHELL': '/bin/bash', 03:24:42 INFO - 'SHLVL': '1', 03:24:42 INFO - 'TERM': 'linux', 03:24:42 INFO - 'TMOUT': '86400', 03:24:42 INFO - 'USER': 'cltbld', 03:24:42 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', 03:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:42 INFO - '_': '/tools/buildbot/bin/python'} 03:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:24:42 INFO - Cleaning up... 03:24:42 INFO - Return code: 0 03:24:42 INFO - Running post-action listener: _resource_record_post_action 03:24:42 INFO - Running post-action listener: _start_resource_monitoring 03:24:42 INFO - Starting resource monitoring. 03:24:42 INFO - [mozharness: 2016-10-16 10:24:42.270225Z] Finished create-virtualenv step (success) 03:24:42 INFO - [mozharness: 2016-10-16 10:24:42.271198Z] Running install step. 03:24:42 INFO - Running pre-action listener: _resource_record_pre_action 03:24:42 INFO - Running main action method: install 03:24:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:24:42 INFO - Reading from file tmpfile_stdout 03:24:42 INFO - Detecting whether we're running mozinstall >=1.0... 03:24:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:24:42 INFO - Reading from file tmpfile_stdout 03:24:42 INFO - Output received: 03:24:42 INFO - Usage: mozinstall [options] installer 03:24:42 INFO - Options: 03:24:42 INFO - -h, --help show this help message and exit 03:24:42 INFO - -d DEST, --destination=DEST 03:24:42 INFO - Directory to install application into. [default: 03:24:42 INFO - "/builds/slave/test"] 03:24:42 INFO - --app=APP Application being installed. [default: firefox] 03:24:42 INFO - mkdir: /builds/slave/test/build/application 03:24:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:24:59 INFO - Reading from file tmpfile_stdout 03:24:59 INFO - Output received: 03:24:59 INFO - /builds/slave/test/build/application/firefox/firefox 03:24:59 INFO - Running post-action listener: _resource_record_post_action 03:24:59 INFO - [mozharness: 2016-10-16 10:24:59.540182Z] Finished install step (success) 03:24:59 INFO - [mozharness: 2016-10-16 10:24:59.540427Z] Running run-tests step. 03:24:59 INFO - Running pre-action listener: _resource_record_pre_action 03:24:59 INFO - Running main action method: run_tests 03:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:24:59 INFO - Python 2.7.3 03:24:59 INFO - Return code: 0 03:24:59 INFO - grabbing minidump binary from tooltool 03:24:59 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')]} 03:24:59 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 0xd60f60>, '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 0xd61d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd621d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:24:59 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 03:24:59 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 03:24:59 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 03:24:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:24:59 INFO - Return code: 0 03:24:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:24:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:24:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:24:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:24:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:24:59 INFO - Using env: {'DISPLAY': ':0', 03:24:59 INFO - 'HOME': '/home/cltbld', 03:24:59 INFO - 'LANG': 'en_US.UTF-8', 03:24:59 INFO - 'LANGUAGE': 'en_US:en', 03:24:59 INFO - 'LOGNAME': 'cltbld', 03:24:59 INFO - 'MAIL': '/var/mail/cltbld', 03:24:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:24:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:59 INFO - 'MOZ_NO_REMOTE': '1', 03:24:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:59 INFO - 'NO_EM_RESTART': '1', 03:24:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:59 INFO - 'PWD': '/builds/slave/test', 03:24:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:24:59 INFO - 'SHELL': '/bin/bash', 03:24:59 INFO - 'SHLVL': '1', 03:24:59 INFO - 'TERM': 'linux', 03:24:59 INFO - 'TMOUT': '86400', 03:24:59 INFO - 'USER': 'cltbld', 03:24:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496', 03:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:59 INFO - '_': '/tools/buildbot/bin/python'} 03:24:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:25:00 INFO - mozversion application_buildid: 20161016003004 03:25:00 INFO - mozversion application_changeset: 94f47e1077442d749f7fe7de027fcbdfeacf3daf 03:25:00 INFO - mozversion application_display_name: Nightly 03:25:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:25:00 INFO - mozversion application_name: Firefox 03:25:00 INFO - mozversion application_remotingname: firefox 03:25:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:25:00 INFO - mozversion application_vendor: Mozilla 03:25:00 INFO - mozversion application_version: 52.0a1 03:25:00 INFO - mozversion platform_buildid: 20161016003004 03:25:00 INFO - mozversion platform_changeset: 94f47e1077442d749f7fe7de027fcbdfeacf3daf 03:25:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:25:00 INFO - mozversion platform_version: 52.0a1 03:25:00 INFO - using testdate: 1476613500 03:25:00 INFO - actual date: 1476613500 03:25:00 INFO - starting webserver on 'localhost:52222' 03:25:00 INFO - SUITE-START | Running 2 tests 03:25:00 INFO - TEST-START | dromaeo_css 03:25:00 INFO - operating with platform_type : linux_ 03:25:00 INFO - Initialising browser for dromaeo_css test... 03:25:00 INFO - TEST-INFO | started process 3437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCNcuR_/profile http://localhost:52222/getInfo.html) 03:25:04 INFO - PROCESS | 3437 | __metrics Screen width/height:1600/1200 03:25:04 INFO - PROCESS | 3437 | colorDepth:24 03:25:04 INFO - PROCESS | 3437 | Browser inner width/height: 1024/697 03:25:04 INFO - PROCESS | 3437 | __metrics 03:25:07 INFO - PROCESS | 3437 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:25:07 INFO - PROCESS | 3437 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:25:08 INFO - TEST-INFO | 3437: exit 0 03:25:08 INFO - Browser initialized. 03:25:08 INFO - Running cycle 1/1 for dromaeo_css test... 03:25:08 INFO - TEST-INFO | started process 3522 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCNcuR_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:25:20 INFO - PROCESS | 3522 | RSS: Main: 171708416 03:25:20 INFO - PROCESS | 3522 | 03:26:12 INFO - PROCESS | 3522 | 1476613572032 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] 03:28:23 INFO - PROCESS | 3522 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52222/tests/dromaeo/cssquery-ext.html) 03:28:24 INFO - PROCESS | 3522 | RSS: Main: 328683520 03:28:24 INFO - PROCESS | 3522 | 03:31:27 INFO - PROCESS | 3522 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-ext.html (next: http://localhost:52222/tests/dromaeo/cssquery-jquery.html) 03:31:27 INFO - PROCESS | 3522 | RSS: Main: 279777280 03:31:27 INFO - PROCESS | 3522 | 03:34:30 INFO - PROCESS | 3522 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52222/tests/dromaeo/cssquery-mootools.html) 03:34:30 INFO - PROCESS | 3522 | RSS: Main: 215207936 03:34:30 INFO - PROCESS | 3522 | 03:37:32 INFO - PROCESS | 3522 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52222/tests/dromaeo/cssquery-prototype.html) 03:37:33 INFO - PROCESS | 3522 | RSS: Main: 214867968 03:37:33 INFO - PROCESS | 3522 | 03:40:36 INFO - PROCESS | 3522 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52222/tests/dromaeo/cssquery-yui.html) 03:40:36 INFO - PROCESS | 3522 | RSS: Main: 216924160 03:40:36 INFO - PROCESS | 3522 | 03:43:39 INFO - PROCESS | 3522 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-yui.html (next: http://localhost:52222/tests/dromaeo/cssquery-dojo.html) 03:43:40 INFO - PROCESS | 3522 | RSS: Main: 306651136 03:43:40 INFO - PROCESS | 3522 | 03:43:40 INFO - PROCESS | 3522 | __start_tp_report 03:43:40 INFO - PROCESS | 3522 | _x_x_mozilla_page_load 03:43:40 INFO - PROCESS | 3522 | _x_x_mozilla_page_load_details 03:43:40 INFO - PROCESS | 3522 | |i|pagename|runs| 03:43:40 INFO - PROCESS | 3522 | |0;dojo.html;3048.4055609156217;3065.1264389648954;3100.906972790816;3107.176598201477;3112.299732560174;5178.2232665100255;5238.083335416296;5305.151175811871;5382.730863456826;5415.458454154587;5269.394019687737;5311.49540793624;5351.411344752074;5355.812546560871;5439.4832490913395;4858.587020103296;4887.095887260851;4887.975560122194;4952.257161425797;4954.925676114861;4916.70499770015;4926.113299606088;4977.850664480054;4978.925316120261;5003.374578177728;4965.354503914504;5012.072766538184;5019.54824065834;5061.873453163664;5084.186530155176;4743.667943243974;4767.952320476786;4781.832635857728;4842;4892.2661600760175;4846.0550192712435;4848.175810112254;4880.585150262232;4904.926426103611;4949.876253093666;5313.378469335202;5331.600129990227;5335.413104558495;5369.24830523727;5431.728413579305;5507.972460137674;5556.888862222733;5698.572607054488;5715.5427565794635;5729.484346408802;5764.423557644202;5804.941950580483;5807.128930660435;5814.738336774855;5879;5435.537979271767;5437.34751829783;5439.564834813205;5441.673499590037;5443.945560544384;5656.745446454919;5891.852703682443;5892.911606325909;5894.646321220741;5901.970490147522;5526.668399896019;5545.140503222007;5623.100303951348;5693.971530142323;5694.231278777394;5670.603057785916;5717.628354156966;5722.198892155018;5725.627834190765;5818;5719.656820590778;5719.971400142973;5720.313562372458;5731.312242530923;5804.6807425592;5451.373092094381;5452.236686863842;5509.090999985037;5598.076317407664;5729.341125770507;4287.056847493546;4296.849610263688;4297.39836422901;4298.656107511391;4299.1831552005015;3886.203328317688;3900.921981560353;3906.2968665639887;3908.1988192420486;3919.451276821247;5291.126964050965;5295.338082739658;5299.973500132552;5301.416844147141;5304.336957880265;5561.054620714407;5601.80393686219;5604.859878502988;5617.38208797032;5618.0449323615085;5281.867953301121;5308.150695888717;5312.787488500417;5314.468553144655;5327.81352652663;4892.486288939681;4896.632752543503;4909.116359055404;4926.655134140576;4931.876703082452;5935.376785437467;5937.851553711192;5938.8812223755285;5942.108683697394;5944.227250457413;5494.917576236279;5545;5749.338826035059;5765.91351129725;5772.6536407815665;5886.852828679317;5949.2266005419015;5957.791477298274;5998.820035398945;6057.939420605914;5687.800926967537;5697.658140511582;5702.144678298288;5707.143928410605;5708.115242137475;5536.833894983157;5802.796902108406;5803.274590676166;5813.215215945793;5818.76724930998;5462.235287059894;5480.671159730429;5503.862403439946;5524.088525393265;5610.4670056344585;5493.697846618475;5502.147167189092;5511.614187007031;5514.310711161105;5514.338279406497;5459.645123066988;5478.287822583039;5489.890202196014;5499.477549632778;5546.584006199632;5468.699221542854;5503.972480137573;5663.263775709132;5700.885982280248;5708.942910571007;5566.081596536526;5599.524040456607;5600.103983362643;5603.747831347518;5630.60585758993 03:43:40 INFO - PROCESS | 3522 | |1;ext.html;539.3848097575196;600.3126420248815;608.8356143841163;626.6115008694608;640.5004096804494;30604.54093188601;42979.78510107449;43130.784346078224;43422.13155736883;43463.78268108663;43426.56573434272;43815.34276985848;43840.780796096056;43856.78071609638;43897;8045.517268963852;8858.601362938683;8933.46399216049;9004.23464005557;9027.638894444248;8054.154313797055;10547.261691681548;10734.78530429391;10774.515146818372;10974.176936729737;10803.351798892052;10832.079273261783;10866.67399978002;10874.45627718615;10875.673729788079;8054.879176812353;8229.341652667772;10647.361158330486;10717.464126793708;10727.356358618508;10294.639687610897;10643.30818496803;10655.30740501865;10950.835737463944;10961.177911656578;40505.79747101275;40907.181856363;40909.38635920463;40912;40981;3071.6467606225347;3130.076627394924;3134.2634480896972;3275;3567.357875582394;31007;31630;31761.523577146363;31771.205719856956;32231;4300;4320.552614874021;4335.089631177457;4397.846075387346;4461.977690111561;304994;306223;306872.9999999978;307469;308175;34118.31763364719;56935.71532142313;57202.7139864298;57227.42772572304;57289;33875.491867622004;35741.28517429637;35937.8203108988;36075;36101;12947;13192.802107968388;13220.471181152838;13232;13234.470621175045;9572.329936904489;9667.371620844622;10571.577136914591;10697.786044279072;10843.783124337628;8079.2324729151815;8101.189881011852;8116.350691944748;8238.340932725368;8260.793480163044;3138.5606015157896;3148.9055328340187;3170.334229811719;3178.173674844557;3233.0462513558555;957.6791774755395;973.7176218896441;1036.9325993810378;1060.931039482431;1078.5146683992234;31361;31713.841430792698;31788.364232715216;31870.362592748013;31908.521372179435;1046.08467590858;1069.550788668761;1110.5058249079243;1122.2144498850837;1124.0670243697875;15862.841371586137;16737.581560461087;16782.496525104267;16799;16937.32250709958;506524;510447;512695;512825;512988;55608.44391556113;56331;56402.71798640981;56409;56420.153697694564;1148.1388958281289;1205.9276443413423;1268.835051443325;1272.1222356573935;1294.5792617399195;27978.440431190855;32070.83964580162;32099.839500802347;32330.676693232766;32372.514412284305;47841;48494.515054849;48557;48614;48619.756901216686;346038;346901;347569;347628;348718;26738.866305668347;27127.321816953943;27147.86426067857;27665.446691066467;28719.712802871705;45663;45745;46162.307565385876;46190.53809461863;46216.537834621224;38616.6138338613;40911.38632920568;43172.78413607912;43842.780786097144;44958;39730.801345994245;39910.40134398045;40298.395524066575;40623.07279129345;40871.38692919549;39925.80037099796;40348;40478.79760601178;41027.794861025504;41090.1781964365;34052.82973585116;36634.26731465409;37327.626723732414;37429;37546;27980.44039119247;28134.577981330705;28435.715642843308;28497.572536411557;28512.287192820346 03:43:40 INFO - PROCESS | 3522 | |2;jquery.html;359.6439524870376;375.35064338694076;377.72426128925883;390.3870922651437;407.1815650542409;14550.345234464461;14726.926365368172;18164.349776895124;18552.814471855276;18608.441746747587;17409.30362785487;18058;18212.544686382847;18235;18276.634467310647;4018.9397159042637;5358.59810514212;5579.442055794429;5581.609287349887;5583.5254003409755;4202.411662367271;5983.252093488314;6188.938110618881;6276.68616569172;6386.840328991766;6109.450149486545;6234.189555357797;6283.151774510428;6334.461570766491;6345.650989195616;6241.531885108612;6248;6267.592606480564;6283.560150789446;6283.905741413837;5334.67991920486;5376.704281264529;5405.18922161675;5429.126951201829;5462.6995515246645;22052.88973555138;22381;22389.664155037688;22500.324990250156;22560.43598910024;2016.7680716717618;2070.234013415031;2073.5541858500496;2075.9065842037144;2736.3843135294596;9223.723288301362;9383.906160938372;9420.717378478588;9506.574013897902;10233.897661023444;1925.951851203717;1932.391296741522;2012.3258708332726;2031.207828946712;2045.6522391193532;79304.60347698224;81011.5949420255;83538;87497;87970.56014719949;9533.427994320364;9828.803423931482;10047.799044019079;10290;10751.892481075245;15027.849721502864;15044.172570508508;15059.623509412133;15061.548153555412;15067.623309417133;7100.893486597705;7230.13238411394;7393.55638661682;7465.962670186723;7495.400367970549;7004.894926576106;7024.1571011478945;7086.751963681247;7258.782236532912;7298.160711518137;4473.932891006638;4632.305154226893;4642.257238841769;4690.437147542317;4692.41344831896;1850.3893715073993;1898.506388339042;1943.6209939061748;1959.549303660166;1967.6163148185967;950.7195377363694;962.5235508423375;966.8598053282235;969.9612015519441;1004.3973615830444;16997.830021699872;18280.542986425447;18552.07239638013;18720.53198670044;19070.2371905125;917.2707697380598;967.1682353176262;967.8935317115112;1016.913562347194;1037.4708898461838;9591.518244197363;10309.690709278733;10426.27016108865;10439.164866810637;10520.684379468628;336946;339222;344689;442884;447975;90266.54866725755;93751.53124234335;94315.52842235882;94908;95002.52498737462;980.6469670918464;989.618996686281;1038.766277587552;1083.1443159903588;1096.780643871229;16138.838611614203;16889.40887068996;16955.49133525996;17038;17323.393681221096;38835;39339.65612922933;39983.40024899687;40175.1964960705;40289.395659064554;54375.72812135914;56212.43787562072;56591.43408565861;56659;57433.138502921654;8108.675652973815;8163.79590510242;8242.17578242195;8318.70884519039;8355.373346998878;11479.483423246142;12516.624501264976;12576.245425274146;12766.61700148997;13049.478020879058;10922.781544369227;11145.49845256949;11281.774364512828;11471.483783229607;11518.502594662641;11168.944155279496;11184.776304474028;11500.252483588874;11558.537658493902;11585.478653460446;10697.197710171924;11109;11313.20807543464;11353.829692554453;11492.712682183012;8076.800063966822;8248.958755206186;8255.133211012757;8275.62759675828;8417.158284171534;8557.015943166616;11043.337399756041;11132.165087618623;11212.103031757602;11469.598564050219 03:43:40 INFO - PROCESS | 3522 | |3;mootools.html;1320.1221187910041;1451.6516036151327;1478.3495262084684;1597.273240675492;1798.7122060470326;7754.961225193873;8653.264472519835;9015;9018.413803102794;9247.398919070272;8938.419002764816;8968.327375446836;9036.50299233542;9046.819063618741;9060.229880460152;2233.9888300558514;2252.8648281103106;2259.649754288088;2262.2760716570706;2262.45701031752;2219.0679914435977;2239.992003598379;2283.075354481438;2287.977120228793;2288.8397812153157;2229.2754854672216;2236.3738153317017;2236.4856083100894;2237.6755370471274;2272.9545409091807;2176.662617294322;2178.5207254404004;2178.6623073423566;2195.1877805212093;2196.791304826039;2159.050017992094;2162.4701948022835;2166.36439488187;2167.100653228924;2169.956600867974;8739.126087391274;8920.910790892072;8941.150590693873;8943.060978597283;8959.865602015974;5117.334746482933;5272.156454967225;5291.232771248186;5384.353877534721;5388.030154572176;3130.624325081005;3290.9835450822593;3356.63077061523;3368.949465758016;3373.2241584435474;1041.739565108723;1056.6618682021756;1060.9787804243872;1073.7154654016692;1080.783843231357;12747.936260318731;12793.680157996032;12857.807132893107;12871.806922896165;12884.420201090974;4323.740575565476;4333.8699839004885;4463.4420697412825;4480.372747815309;4485.0805584855025;10051.396916185053;10054.949725251474;10057.446840423701;10064.748381290527;10070.74823129413;5264.105102132647;5267.420583735786;5267.710275934784;5270.525652691276;5272.551833094153;3951.881443556698;4093.7134400592267;4237.173751118502;4915.827946021872;4918.803247870117;3607.8196090195383;3661.7436779425184;3694.113412780913;3771.2080463103057;3779.5842457329672;1016.4714348538866;1070.5664205996584;1073.431081526792;1077.8975997280245;1088.8040152772578;732.3774791427351;893.5398269891011;895.1853813030242;907.9591418386188;911.9224865886341;5468.507834294853;5488.286522752017;5596.225963456478;5689.544836413077;5732.34078081026;412.4967539601681;414.9813258403379;440.8082484119418;441.13097198518864;442.52870692712156;3662.6520480554304;3771.981140094282;3773.6792372648633;3791.3175628387157;3791.7156213284115;10940.945295273472;11355.772884542263;11396.715082123013;11490.712732181595;11496.885031149748;10994.450277486254;11430.314181149157;11432.94283528577;11440.885591143982;11440.942795286137;8236.711715089943;8417.242448179693;8426.53654049021;8426.873596896052;8435.873461898076;5341.572674185978;5433.8369848904595;5451.1005684063275;5495.642783219078;5584.022796010763;10112.878475619225;10272.794544109225;10353.74115647115;10410;10443.94778026105;9322.673706420243;10509.842352364567;10540.209484288862;10561.207909406672;10646.946765266124;6783.660816959034;7132.572045677276;7196.820079498055;7311.159216689936;7434.107907051189;8561.529115898686;8623.56882155877;8640.697575584825;8717.128287171232;8780.868286975829;7633.084029916446;7645.120811106794;7683.500572462772;7684.154742978156;7733.613319333898;7777.300042996158;7784.571848548384;7820.296173344426;7839.25527074927;7892.210778922062;6895.207051188977;6912.965435172792;6928.307169283032;6948.027276181439;6953.130858642669;4883.706977581356;4915.778789954389;4991.425986011655;4991.700497970133;5075.467075956972;4886.975565122294;4898.975505122452;5069.340985671839;5108.872278193075;5146.511081447256 03:43:40 INFO - PROCESS | 3522 | |4;prototype.html;296.13085593782245;302.4253917556643;311.18935173872063;315.7174328975568;317.65058435720726;5227.581793456519;5279.260903473512;5285.339332583427;5291.788328466857;5292.417834038262;5252.290940723001;5254.211868219769;5257.290265814124;5259.815906443275;5289.391719952207;3901.4928059352314;4022.698297627675;4023.1551374211303;4024.436578878959;4026.335654616985;3658.042947023343;3998.0204849811835;4037.9596204037875;4082.6937979651498;4083.12212874232;4030.435738996543;4041.4746083009168;4043.6158564936286;4045.554988951213;4057.229126465962;4040.0707837197315;4050.574689657573;4051.5948405159543;4053.9865033741567;4056.8782936511802;3334.149791803099;3442.9311413771584;3458.9308213835584;3541.29174165168;3561.4123669594487;5091;5092;5097.464766199532;5106.821261255838;5107.821226257063;4572.839950601746;4579.603221017588;4583;4586.770661466913;4596.5863072323655;5324.361076670785;5404.864978354551;5427.348718153808;5446.455354464521;5448.564114870801;3880.3403421418143;3885.2423777363424;3891.210043380049;3892.2799282132896;3915.960840391588;5355.634313250135;5541.445855414467;5634.943650563483;5664.518515926151;5673.290838645128;3880.0881792778673;3955.288048151303;3971.404289356562;3979.1245925896255;3983.183447393277;4000.9399859002137;4006.8797936061965;4008.6793056555407;4032.697547683935;4038.818253178614;4493.59557639814;4607.838725644587;4620.907581848344;4621.653375996813;4634.930476042862;5481.972590137104;5511.862203444865;5513.751881165357;5532.612717109763;5542;1384.5223397927698;1397.8881689464818;1401.187311359409;1402.975827645804;1409.7532931736905;862.8317478091838;904.5070436612062;917.9908200917905;919.5034681272039;922.3128769066954;4756.500567440438;4767.475577686451;4774.880627984328;4784.928226076611;4792.0895029944195;5015.774290156952;5020.397552293675;5044.268581055726;5053.620978426633;5080.644354895196;4597.276575353439;4654.371659825948;4767;4777.518969119584;4790.233562630032;2644.7751941085226;2650.721674224217;2659.8138130331076;2669.546177149889;2672.8797204125863;5070.492950704974;5086.237064440364;5089.440161582297;5103.642745007814;5118.769655365518;5005.6996580205305;5009.393236869448;5039.773210205476;5367.275417818622;5835.649861008353;5826.426864746495;5894;5897.852553686106;5898.262717160355;5918.674472903946;5692.6299790513485;5715.31416230055;5719.656820590778;5731.455511726379;5736.196932429547;5470.835874923759;5567.582431317586;5660.603757736919;5661.377248502579;5670.858228544319;5514.310711161105;5672.801451949162;5744.4829965303325;5867.32525759526;5887.558433117448;3909.8436062558317;3925.371940489508;3947.585503522089;3950;3957.8614748483665;5667.518260947701;5669.376368599534;5682.77268909239;5690.9756243874845;5695.487406133302;5370.946290537201;5546.500814926676;5549.278593782782;5559.275954782209;5586.692731899622;5519.917201241904;5536.944630553643;5557.3331200256225;5560.944390556043;5566;5363.436839131991;5546.195801608825;5546.861328466821;5547;5556.194351819045;5550.198114291723;5587.804426845203;5595.328560572757;5597.748101335531;5598.440155984369;5449.945500544944;5462.535684466706;5469.156038859691;5474.534664553557;5479.205515200353 03:43:40 INFO - PROCESS | 3522 | |5;yui.html;697.400235797214;704.4329314901502;730.7661548304542;776.4254451705735;833.9583020848958;15470.535883923472;15677.529674109766;16018.679626407466;16030.198490075509;16041.278142483587;15747.527574172764;15787.368505259805;15848.76226856598;15852.841471585281;15867.127307998084;668.6890595872918;678.3453966921944;802.430274505102;824.3446460064233;827.6565225431439;796.3788245168778;798.8641930871737;815.0097631377874;819.33633756657;819.8565251081067;862.4049405909933;867.8958524977012;868.0624925080929;868.3313848336777;868.6264906090379;699.5452955578863;702.2906864067278;860.6643409070437;862.4911302331623;862.611824678897;603.3001718007134;603.5744799916049;620.3486339343671;621.2638023941644;621.9129321894939;14214.431422743079;14238.28808559568;14272.500462483764;14285.78571321431;14306.284685765775;13780.655483612889;13983.720325593431;14012.369443375073;14194.148351098864;14506.854931450656;12235.265884046985;12355.62933112008;12795.296258705768;12883.549075782303;12962.15745976518;4382.671299652507;4437.090396468716;4484;4529.818807247706;4581.335706322598;79619.26091825338;79780.60109699414;79839;80102;80968.59515702442;10778.676639700821;11067.557297708001;11076.778464430667;11123.16576256784;11314.943425282821;20347.15139880418;20575.58848823015;20602.175912963314;20689.58620827575;21078;8147.592620368958;8252.33981281508;8302.128276530999;8324.791880203044;8499.702510412106;4655.976720116378;4718.834840780556;4736.100140973204;4810.470848206694;4894.902101957941;3389.983050084734;3465;3484.651534846546;3496.7727097738566;3505.158761897126;589.6874656432097;592.523018969725;607.2439812433548;609.4088733928082;620.3672254300589;674.7773234832493;682.2256738601723;690.9792706218822;704.8766465868453;705.6859697434695;9354.158125768578;9787.90212097884;9926.156276716416;9927.702168934944;9960.302778805559;572.01898743654;599.5293694449836;698.9440844732511;716.7312257903286;746.391690772019;4660.254359302496;5015.247712843103;5040.59675225981;5072.416672082684;5080;102517.48741256246;104487;105758;106397.46801266099;109813;92268.53865730629;92756;93880.53059734657;94030.52984735032;94410;82563.58718206371;82923.58538207391;83005.16994830096;83250.99999999879;84195;9376.531173441164;9690.70927872165;9694.9030509694;9698.51507424612;9759.853602195832;45717;45858.312125318815;46678.53321466742;46877.53122468868;47638.523614764796;64145;64265.35734642594;66811.3318866805;66914.66542667255;69788.65105674643;13170.209787412787;13654.863451365756;13757.587272381845;13766.24285664298;13934.58196254114;14539.563813085624;14551.126932384092;15268.3892644293;15600.141992190538;15611.219439028231;13436.865631343953;13998.300084995506;14235.928820355832;14851.777223341442;14940.925295373454;14307.92846035763;14472.276386180438;14881.404743810126;15056.63091028943;15704;14156.056349253511;14620.561383158521;14715.632109196928;15015.699686006;15674.451394201149;10999.34003959765;11720.648380548597;11994;12149.453274602487;12494.437750301076;10048.49757512136;10461.424621645578;11620.070394368598;11631.812089231853;11700.2979821211 03:43:40 INFO - PROCESS | 3522 | __end_tp_report 03:43:40 INFO - PROCESS | 3522 | __start_cc_report 03:43:40 INFO - PROCESS | 3522 | _x_x_mozilla_cycle_collect,1571 03:43:40 INFO - PROCESS | 3522 | __end_cc_report 03:43:40 INFO - PROCESS | 3522 | __startTimestamp1476614620073__endTimestamp 03:43:40 INFO - PROCESS | 3522 | 03:43:40 INFO - PROCESS | 3522 | ------- Summary: start ------- 03:43:40 INFO - PROCESS | 3522 | Number of tests: 6 03:43:40 INFO - PROCESS | 3522 | 03:43:40 INFO - PROCESS | 3522 | [#0] dojo.html Cycles:165 Average:5307.18 Median:5489.89 stddev:601.75 (11.0%) stddev-sans-first:576.92 03:43:40 INFO - PROCESS | 3522 | Values: 3048.4 3065.1 3100.9 3107.2 3112.3 5178.2 5238.1 5305.2 5382.7 5415.5 5269.4 5311.5 5351.4 5355.8 5439.5 4858.6 4887.1 4888.0 4952.3 4954.9 4916.7 4926.1 4977.9 4978.9 5003.4 4965.4 5012.1 5019.5 5061.9 5084.2 4743.7 4768.0 4781.8 4842.0 4892.3 4846.1 4848.2 4880.6 4904.9 4949.9 5313.4 5331.6 5335.4 5369.2 5431.7 5508.0 5556.9 5698.6 5715.5 5729.5 5764.4 5804.9 5807.1 5814.7 5879.0 5435.5 5437.3 5439.6 5441.7 5443.9 5656.7 5891.9 5892.9 5894.6 5902.0 5526.7 5545.1 5623.1 5694.0 5694.2 5670.6 5717.6 5722.2 5725.6 5818.0 5719.7 5720.0 5720.3 5731.3 5804.7 5451.4 5452.2 5509.1 5598.1 5729.3 4287.1 4296.8 4297.4 4298.7 4299.2 3886.2 3900.9 3906.3 3908.2 3919.5 5291.1 5295.3 5300.0 5301.4 5304.3 5561.1 5601.8 5604.9 5617.4 5618.0 5281.9 5308.2 5312.8 5314.5 5327.8 4892.5 4896.6 4909.1 4926.7 4931.9 5935.4 5937.9 5938.9 5942.1 5944.2 5494.9 5545.0 5749.3 5765.9 5772.7 5886.9 5949.2 5957.8 5998.8 6057.9 5687.8 5697.7 5702.1 5707.1 5708.1 5536.8 5802.8 5803.3 5813.2 5818.8 5462.2 5480.7 5503.9 5524.1 5610.5 5493.7 5502.1 5511.6 5514.3 5514.3 5459.6 5478.3 5489.9 5499.5 5546.6 5468.7 5504.0 5663.3 5700.9 5708.9 5566.1 5599.5 5600.1 5603.7 5630.6 03:43:40 INFO - PROCESS | 3522 | 03:43:40 INFO - PROCESS | 3522 | [#1] ext.html Cycles:180 Average:54244.34 Median:176142.68 stddev:105597.12 (59.9%) stddev-sans-first:105816.36 03:43:40 INFO - PROCESS | 3522 | Values: 539.4 600.3 608.8 626.6 640.5 30604.5 42979.8 43130.8 43422.1 43463.8 43426.6 43815.3 43840.8 43856.8 43897.0 8045.5 8858.6 8933.5 9004.2 9027.6 8054.2 10547.3 10734.8 10774.5 10974.2 10803.4 10832.1 10866.7 10874.5 10875.7 8054.9 8229.3 10647.4 10717.5 10727.4 10294.6 10643.3 10655.3 10950.8 10961.2 40505.8 40907.2 40909.4 40912.0 40981.0 3071.6 3130.1 3134.3 3275.0 3567.4 31007.0 31630.0 31761.5 31771.2 32231.0 4300.0 4320.6 4335.1 4397.8 4462.0 304994.0 306223.0 306873.0 307469.0 308175.0 34118.3 56935.7 57202.7 57227.4 57289.0 33875.5 35741.3 35937.8 36075.0 36101.0 12947.0 13192.8 13220.5 13232.0 13234.5 9572.3 9667.4 10571.6 10697.8 10843.8 8079.2 8101.2 8116.4 8238.3 8260.8 3138.6 3148.9 3170.3 3178.2 3233.0 957.7 973.7 1036.9 1060.9 1078.5 31361.0 31713.8 31788.4 31870.4 31908.5 1046.1 1069.6 1110.5 1122.2 1124.1 15862.8 16737.6 16782.5 16799.0 16937.3 506524.0 510447.0 512695.0 512825.0 512988.0 55608.4 56331.0 56402.7 56409.0 56420.2 1148.1 1205.9 1268.8 1272.1 1294.6 27978.4 32070.8 32099.8 32330.7 32372.5 47841.0 48494.5 48557.0 48614.0 48619.8 346038.0 346901.0 347569.0 347628.0 348718.0 26738.9 27127.3 27147.9 27665.4 28719.7 45663.0 45745.0 46162.3 46190.5 46216.5 38616.6 40911.4 43172.8 43842.8 44958.0 39730.8 39910.4 40298.4 40623.1 40871.4 39925.8 40348.0 40478.8 41027.8 41090.2 34052.8 36634.3 37327.6 37429.0 37546.0 27980.4 28134.6 28435.7 28497.6 28512.3 03:43:40 INFO - PROCESS | 3522 | 03:43:40 INFO - PROCESS | 3522 | [#2] jquery.html Cycles:180 Average:25676.94 Median:19865.02 stddev:64522.13 (324.8%) stddev-sans-first:64675.13 03:43:40 INFO - PROCESS | 3522 | Values: 359.6 375.4 377.7 390.4 407.2 14550.3 14726.9 18164.3 18552.8 18608.4 17409.3 18058.0 18212.5 18235.0 18276.6 4018.9 5358.6 5579.4 5581.6 5583.5 4202.4 5983.3 6188.9 6276.7 6386.8 6109.5 6234.2 6283.2 6334.5 6345.7 6241.5 6248.0 6267.6 6283.6 6283.9 5334.7 5376.7 5405.2 5429.1 5462.7 22052.9 22381.0 22389.7 22500.3 22560.4 2016.8 2070.2 2073.6 2075.9 2736.4 9223.7 9383.9 9420.7 9506.6 10233.9 1926.0 1932.4 2012.3 2031.2 2045.7 79304.6 81011.6 83538.0 87497.0 87970.6 9533.4 9828.8 10047.8 10290.0 10751.9 15027.8 15044.2 15059.6 15061.5 15067.6 7100.9 7230.1 7393.6 7466.0 7495.4 7004.9 7024.2 7086.8 7258.8 7298.2 4473.9 4632.3 4642.3 4690.4 4692.4 1850.4 1898.5 1943.6 1959.5 1967.6 950.7 962.5 966.9 970.0 1004.4 16997.8 18280.5 18552.1 18720.5 19070.2 917.3 967.2 967.9 1016.9 1037.5 9591.5 10309.7 10426.3 10439.2 10520.7 336946.0 339222.0 344689.0 442884.0 447975.0 90266.5 93751.5 94315.5 94908.0 95002.5 980.6 989.6 1038.8 1083.1 1096.8 16138.8 16889.4 16955.5 17038.0 17323.4 38835.0 39339.7 39983.4 40175.2 40289.4 54375.7 56212.4 56591.4 56659.0 57433.1 8108.7 8163.8 8242.2 8318.7 8355.4 11479.5 12516.6 12576.2 12766.6 13049.5 10922.8 11145.5 11281.8 11471.5 11518.5 11168.9 11184.8 11500.3 11558.5 11585.5 10697.2 11109.0 11313.2 11353.8 11492.7 8076.8 8249.0 8255.1 8275.6 8417.2 8557.0 11043.3 11132.2 11212.1 11469.6 03:43:40 INFO - PROCESS | 3522 | 03:43:40 INFO - PROCESS | 3522 | [#3] mootools.html Cycles:180 Average:5744.21 Median:2387.34 stddev:3448.54 (144.5%) stddev-sans-first:3442.19 03:43:40 INFO - PROCESS | 3522 | Values: 1320.1 1451.7 1478.3 1597.3 1798.7 7755.0 8653.3 9015.0 9018.4 9247.4 8938.4 8968.3 9036.5 9046.8 9060.2 2234.0 2252.9 2259.6 2262.3 2262.5 2219.1 2240.0 2283.1 2288.0 2288.8 2229.3 2236.4 2236.5 2237.7 2273.0 2176.7 2178.5 2178.7 2195.2 2196.8 2159.1 2162.5 2166.4 2167.1 2170.0 8739.1 8920.9 8941.2 8943.1 8959.9 5117.3 5272.2 5291.2 5384.4 5388.0 3130.6 3291.0 3356.6 3368.9 3373.2 1041.7 1056.7 1061.0 1073.7 1080.8 12747.9 12793.7 12857.8 12871.8 12884.4 4323.7 4333.9 4463.4 4480.4 4485.1 10051.4 10054.9 10057.4 10064.7 10070.7 5264.1 5267.4 5267.7 5270.5 5272.6 3951.9 4093.7 4237.2 4915.8 4918.8 3607.8 3661.7 3694.1 3771.2 3779.6 1016.5 1070.6 1073.4 1077.9 1088.8 732.4 893.5 895.2 908.0 911.9 5468.5 5488.3 5596.2 5689.5 5732.3 412.5 415.0 440.8 441.1 442.5 3662.7 3772.0 3773.7 3791.3 3791.7 10940.9 11355.8 11396.7 11490.7 11496.9 10994.5 11430.3 11432.9 11440.9 11440.9 8236.7 8417.2 8426.5 8426.9 8435.9 5341.6 5433.8 5451.1 5495.6 5584.0 10112.9 10272.8 10353.7 10410.0 10443.9 9322.7 10509.8 10540.2 10561.2 10646.9 6783.7 7132.6 7196.8 7311.2 7434.1 8561.5 8623.6 8640.7 8717.1 8780.9 7633.1 7645.1 7683.5 7684.2 7733.6 7777.3 7784.6 7820.3 7839.3 7892.2 6895.2 6913.0 6928.3 6948.0 6953.1 4883.7 4915.8 4991.4 4991.7 5075.5 4887.0 4899.0 5069.3 5108.9 5146.5 03:43:40 INFO - PROCESS | 3522 | 03:43:40 INFO - PROCESS | 3522 | [#4] prototype.html Cycles:180 Average:4529.82 Median:5090.22 stddev:1354.03 (26.6%) stddev-sans-first:1320.02 03:43:40 INFO - PROCESS | 3522 | Values: 296.1 302.4 311.2 315.7 317.7 5227.6 5279.3 5285.3 5291.8 5292.4 5252.3 5254.2 5257.3 5259.8 5289.4 3901.5 4022.7 4023.2 4024.4 4026.3 3658.0 3998.0 4038.0 4082.7 4083.1 4030.4 4041.5 4043.6 4045.6 4057.2 4040.1 4050.6 4051.6 4054.0 4056.9 3334.1 3442.9 3458.9 3541.3 3561.4 5091.0 5092.0 5097.5 5106.8 5107.8 4572.8 4579.6 4583.0 4586.8 4596.6 5324.4 5404.9 5427.3 5446.5 5448.6 3880.3 3885.2 3891.2 3892.3 3916.0 5355.6 5541.4 5634.9 5664.5 5673.3 3880.1 3955.3 3971.4 3979.1 3983.2 4000.9 4006.9 4008.7 4032.7 4038.8 4493.6 4607.8 4620.9 4621.7 4634.9 5482.0 5511.9 5513.8 5532.6 5542.0 1384.5 1397.9 1401.2 1403.0 1409.8 862.8 904.5 918.0 919.5 922.3 4756.5 4767.5 4774.9 4784.9 4792.1 5015.8 5020.4 5044.3 5053.6 5080.6 4597.3 4654.4 4767.0 4777.5 4790.2 2644.8 2650.7 2659.8 2669.5 2672.9 5070.5 5086.2 5089.4 5103.6 5118.8 5005.7 5009.4 5039.8 5367.3 5835.6 5826.4 5894.0 5897.9 5898.3 5918.7 5692.6 5715.3 5719.7 5731.5 5736.2 5470.8 5567.6 5660.6 5661.4 5670.9 5514.3 5672.8 5744.5 5867.3 5887.6 3909.8 3925.4 3947.6 3950.0 3957.9 5667.5 5669.4 5682.8 5691.0 5695.5 5370.9 5546.5 5549.3 5559.3 5586.7 5519.9 5536.9 5557.3 5560.9 5566.0 5363.4 5546.2 5546.9 5547.0 5556.2 5550.2 5587.8 5595.3 5597.7 5598.4 5449.9 5462.5 5469.2 5474.5 5479.2 03:43:40 INFO - PROCESS | 3522 | 03:43:40 INFO - PROCESS | 3522 | [#5] yui.html Cycles:180 Average:20210.94 Median:25798.18 stddev:28176.43 (109.2%) stddev-sans-first:28217.37 03:43:40 INFO - PROCESS | 3522 | Values: 697.4 704.4 730.8 776.4 834.0 15470.5 15677.5 16018.7 16030.2 16041.3 15747.5 15787.4 15848.8 15852.8 15867.1 668.7 678.3 802.4 824.3 827.7 796.4 798.9 815.0 819.3 819.9 862.4 867.9 868.1 868.3 868.6 699.5 702.3 860.7 862.5 862.6 603.3 603.6 620.3 621.3 621.9 14214.4 14238.3 14272.5 14285.8 14306.3 13780.7 13983.7 14012.4 14194.1 14506.9 12235.3 12355.6 12795.3 12883.5 12962.2 4382.7 4437.1 4484.0 4529.8 4581.3 79619.3 79780.6 79839.0 80102.0 80968.6 10778.7 11067.6 11076.8 11123.2 11314.9 20347.2 20575.6 20602.2 20689.6 21078.0 8147.6 8252.3 8302.1 8324.8 8499.7 4656.0 4718.8 4736.1 4810.5 4894.9 3390.0 3465.0 3484.7 3496.8 3505.2 589.7 592.5 607.2 609.4 620.4 674.8 682.2 691.0 704.9 705.7 9354.2 9787.9 9926.2 9927.7 9960.3 572.0 599.5 698.9 716.7 746.4 4660.3 5015.2 5040.6 5072.4 5080.0 102517.5 104487.0 105758.0 106397.5 109813.0 92268.5 92756.0 93880.5 94030.5 94410.0 82563.6 82923.6 83005.2 83251.0 84195.0 9376.5 9690.7 9694.9 9698.5 9759.9 45717.0 45858.3 46678.5 46877.5 47638.5 64145.0 64265.4 66811.3 66914.7 69788.7 13170.2 13654.9 13757.6 13766.2 13934.6 14539.6 14551.1 15268.4 15600.1 15611.2 13436.9 13998.3 14235.9 14851.8 14940.9 14307.9 14472.3 14881.4 15056.6 15704.0 14156.1 14620.6 14715.6 15015.7 15674.5 10999.3 11720.6 11994.0 12149.5 12494.4 10048.5 10461.4 11620.1 11631.8 11700.3 03:43:40 INFO - PROCESS | 3522 | -------- Summary: end -------- 03:43:40 INFO - PROCESS | 3522 | 03:43:40 INFO - TEST-INFO | 3522: exit 0 03:43:40 INFO - TEST-OK | dromaeo_css | took 1120909ms 03:43:40 INFO - TEST-START | kraken 03:43:40 INFO - operating with platform_type : linux_ 03:43:40 INFO - Initialising browser for kraken test... 03:43:41 INFO - TEST-INFO | started process 3829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQvIbEB/profile http://localhost:52222/getInfo.html) 03:43:45 INFO - PROCESS | 3829 | __metrics Screen width/height:1600/1200 03:43:45 INFO - PROCESS | 3829 | colorDepth:24 03:43:45 INFO - PROCESS | 3829 | Browser inner width/height: 1024/697 03:43:45 INFO - PROCESS | 3829 | __metrics 03:43:45 INFO - PROCESS | 3829 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:43:45 INFO - PROCESS | 3829 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:43:46 INFO - PROCESS | 3829 | console.error: PushService: 03:43:46 INFO - PROCESS | 3829 | stateChangeProcessEnqueue: Error transitioning state 03:43:46 INFO - PROCESS | 3829 | UnknownError 03:43:46 INFO - TEST-INFO | 3829: exit 0 03:43:46 INFO - Browser initialized. 03:43:46 INFO - Running cycle 1/1 for kraken test... 03:43:46 INFO - TEST-INFO | started process 3912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQvIbEB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:43:59 INFO - PROCESS | 3912 | RSS: Main: 171593728 03:43:59 INFO - PROCESS | 3912 | 03:44:01 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52222/tests/kraken/driver.html?testName=audio-beat-detection) 03:44:02 INFO - PROCESS | 3912 | RSS: Main: 229048320 03:44:02 INFO - PROCESS | 3912 | 03:44:05 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52222/tests/kraken/driver.html?testName=audio-dft) 03:44:05 INFO - PROCESS | 3912 | RSS: Main: 216129536 03:44:05 INFO - PROCESS | 3912 | 03:44:08 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52222/tests/kraken/driver.html?testName=audio-fft) 03:44:09 INFO - PROCESS | 3912 | RSS: Main: 297168896 03:44:09 INFO - PROCESS | 3912 | 03:44:11 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52222/tests/kraken/driver.html?testName=audio-oscillator) 03:44:12 INFO - PROCESS | 3912 | RSS: Main: 208666624 03:44:12 INFO - PROCESS | 3912 | 03:44:14 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52222/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:44:14 INFO - PROCESS | 3912 | RSS: Main: 211566592 03:44:14 INFO - PROCESS | 3912 | 03:44:17 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52222/tests/kraken/driver.html?testName=imaging-darkroom) 03:44:18 INFO - PROCESS | 3912 | RSS: Main: 247873536 03:44:18 INFO - PROCESS | 3912 | 03:44:21 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52222/tests/kraken/driver.html?testName=imaging-desaturate) 03:44:22 INFO - PROCESS | 3912 | RSS: Main: 247037952 03:44:22 INFO - PROCESS | 3912 | 03:44:24 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52222/tests/kraken/driver.html?testName=json-parse-financial) 03:44:25 INFO - PROCESS | 3912 | RSS: Main: 245878784 03:44:25 INFO - PROCESS | 3912 | 03:44:27 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52222/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:44:27 INFO - PROCESS | 3912 | RSS: Main: 208805888 03:44:27 INFO - PROCESS | 3912 | 03:44:29 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:44:30 INFO - PROCESS | 3912 | RSS: Main: 215863296 03:44:30 INFO - PROCESS | 3912 | 03:44:32 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:44:33 INFO - PROCESS | 3912 | RSS: Main: 225648640 03:44:33 INFO - PROCESS | 3912 | 03:44:35 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:44:36 INFO - PROCESS | 3912 | RSS: Main: 235229184 03:44:36 INFO - PROCESS | 3912 | 03:44:39 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:44:40 INFO - PROCESS | 3912 | RSS: Main: 231280640 03:44:40 INFO - PROCESS | 3912 | 03:44:41 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52222/tests/kraken/driver.html?testName=ai-astar) 03:44:41 INFO - PROCESS | 3912 | RSS: Main: 281784320 03:44:41 INFO - PROCESS | 3912 | 03:44:41 INFO - PROCESS | 3912 | __start_tp_report 03:44:41 INFO - PROCESS | 3912 | _x_x_mozilla_page_load 03:44:41 INFO - PROCESS | 3912 | _x_x_mozilla_page_load_details 03:44:41 INFO - PROCESS | 3912 | |i|pagename|runs| 03:44:41 INFO - PROCESS | 3912 | |0;ai-astar;102;111;111;110;112;112;111;114;111;112 03:44:41 INFO - PROCESS | 3912 | |1;audio-beat-detection;148;123;123;151;126;122;120;121;155;122 03:44:41 INFO - PROCESS | 3912 | |2;audio-dft;161;161;161;160;162;160;161;160;162;163 03:44:41 INFO - PROCESS | 3912 | |3;audio-fft;76;76;75;110;76;77;75;75;100;76 03:44:41 INFO - PROCESS | 3912 | |4;audio-oscillator;83;82;126;84;85;84;109;83;83;110 03:44:41 INFO - PROCESS | 3912 | |5;imaging-gaussian-blur;117;117;116;117;117;117;116;117;117;117 03:44:41 INFO - PROCESS | 3912 | |6;imaging-darkroom;146;147;145;145;145;147;146;146;145;144 03:44:41 INFO - PROCESS | 3912 | |7;imaging-desaturate;85;84;85;84;84;84;84;84;85;84 03:44:41 INFO - PROCESS | 3912 | |8;json-parse-financial;55;53;54;54;55;55;55;55;54;54 03:44:41 INFO - PROCESS | 3912 | |9;json-stringify-tinderbox;60;60;58;58;60;63;60;59;60;60 03:44:41 INFO - PROCESS | 3912 | |10;stanford-crypto-aes;80;80;88;86;79;82;78;78;78;79 03:44:41 INFO - PROCESS | 3912 | |11;stanford-crypto-ccm;149;132;140;127;141;129;131;133;170;133 03:44:41 INFO - PROCESS | 3912 | |12;stanford-crypto-pbkdf2;167;167;165;181;173;173;165;168;167;177 03:44:41 INFO - PROCESS | 3912 | |13;stanford-crypto-sha256-iterative;65;66;68;66;69;66;68;67;65;66 03:44:41 INFO - PROCESS | 3912 | __end_tp_report 03:44:41 INFO - PROCESS | 3912 | __start_cc_report 03:44:41 INFO - PROCESS | 3912 | _x_x_mozilla_cycle_collect,1729 03:44:41 INFO - PROCESS | 3912 | __end_cc_report 03:44:41 INFO - PROCESS | 3912 | __startTimestamp1476614681984__endTimestamp 03:44:41 INFO - PROCESS | 3912 | 03:44:41 INFO - PROCESS | 3912 | ------- Summary: start ------- 03:44:41 INFO - PROCESS | 3912 | Number of tests: 14 03:44:41 INFO - PROCESS | 3912 | 03:44:41 INFO - PROCESS | 3912 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:3.20 (2.9%) stddev-sans-first:1.13 03:44:41 INFO - PROCESS | 3912 | Values: 102.0 111.0 111.0 110.0 112.0 112.0 111.0 114.0 111.0 112.0 03:44:41 INFO - PROCESS | 3912 | 03:44:41 INFO - PROCESS | 3912 | [#1] audio-beat-detection Cycles:10 Average:131.10 Median:124.50 stddev:14.15 (11.4%) stddev-sans-first:13.62 03:44:41 INFO - PROCESS | 3912 | Values: 148.0 123.0 123.0 151.0 126.0 122.0 120.0 121.0 155.0 122.0 03:44:41 INFO - PROCESS | 3912 | 03:44:41 INFO - PROCESS | 3912 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 03:44:41 INFO - PROCESS | 3912 | Values: 161.0 161.0 161.0 160.0 162.0 160.0 161.0 160.0 162.0 163.0 03:44:41 INFO - PROCESS | 3912 | 03:44:41 INFO - PROCESS | 3912 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:12.57 (16.5%) stddev-sans-first:13.17 03:44:41 INFO - PROCESS | 3912 | Values: 76.0 76.0 75.0 110.0 76.0 77.0 75.0 75.0 100.0 76.0 03:44:41 INFO - PROCESS | 3912 | 03:44:41 INFO - PROCESS | 3912 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:83.00 stddev:15.92 (19.2%) stddev-sans-first:16.48 03:44:41 INFO - PROCESS | 3912 | Values: 83.0 82.0 126.0 84.0 85.0 84.0 109.0 83.0 83.0 110.0 03:44:41 INFO - PROCESS | 3912 | 03:44:41 INFO - PROCESS | 3912 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:44:41 INFO - PROCESS | 3912 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 03:44:41 INFO - PROCESS | 3912 | 03:44:41 INFO - PROCESS | 3912 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 03:44:41 INFO - PROCESS | 3912 | Values: 146.0 147.0 145.0 145.0 145.0 147.0 146.0 146.0 145.0 144.0 03:44:41 INFO - PROCESS | 3912 | 03:44:41 INFO - PROCESS | 3912 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 03:44:41 INFO - PROCESS | 3912 | Values: 85.0 84.0 85.0 84.0 84.0 84.0 84.0 84.0 85.0 84.0 03:44:41 INFO - PROCESS | 3912 | 03:44:41 INFO - PROCESS | 3912 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 03:44:41 INFO - PROCESS | 3912 | Values: 55.0 53.0 54.0 54.0 55.0 55.0 55.0 55.0 54.0 54.0 03:44:41 INFO - PROCESS | 3912 | 03:44:41 INFO - PROCESS | 3912 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:1.40 (2.3%) stddev-sans-first:1.48 03:44:41 INFO - PROCESS | 3912 | Values: 60.0 60.0 58.0 58.0 60.0 63.0 60.0 59.0 60.0 60.0 03:44:41 INFO - PROCESS | 3912 | 03:44:41 INFO - PROCESS | 3912 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.00 stddev:3.52 (4.4%) stddev-sans-first:3.72 03:44:41 INFO - PROCESS | 3912 | Values: 80.0 80.0 88.0 86.0 79.0 82.0 78.0 78.0 78.0 79.0 03:44:41 INFO - PROCESS | 3912 | 03:44:41 INFO - PROCESS | 3912 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:136.50 stddev:12.88 (9.4%) stddev-sans-first:13.09 03:44:41 INFO - PROCESS | 3912 | Values: 149.0 132.0 140.0 127.0 141.0 129.0 131.0 133.0 170.0 133.0 03:44:41 INFO - PROCESS | 3912 | 03:44:41 INFO - PROCESS | 3912 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.30 Median:170.50 stddev:5.46 (3.2%) stddev-sans-first:5.66 03:44:41 INFO - PROCESS | 3912 | Values: 167.0 167.0 165.0 181.0 173.0 173.0 165.0 168.0 167.0 177.0 03:44:41 INFO - PROCESS | 3912 | 03:44:42 INFO - PROCESS | 3912 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:1.35 (2.0%) stddev-sans-first:1.30 03:44:42 INFO - PROCESS | 3912 | Values: 65.0 66.0 68.0 66.0 69.0 66.0 68.0 67.0 65.0 66.0 03:44:42 INFO - PROCESS | 3912 | -------- Summary: end -------- 03:44:42 INFO - PROCESS | 3912 | 03:44:43 INFO - TEST-INFO | 3912: exit 0 03:44:43 INFO - TEST-OK | kraken | took 62251ms 03:44:43 INFO - SUITE-END | took 1183s 03:44:43 INFO - Completed test suite (00:19:43) 03:44:43 INFO - javascript benchmark 03:44:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3048.4055609156217, 3065.1264389648954, 3100.906972790816, 3107.176598201477, 3112.299732560174, 5178.2232665100255, 5238.083335416296, 5305.151175811871, 5382.730863456826, 5415.458454154587, 5269.394019687737, 5311.49540793624, 5351.411344752074, 5355.812546560871, 5439.4832490913395, 4858.587020103296, 4887.095887260851, 4887.975560122194, 4952.257161425797, 4954.925676114861, 4916.70499770015, 4926.113299606088, 4977.850664480054, 4978.925316120261, 5003.374578177728, 4965.354503914504, 5012.072766538184, 5019.54824065834, 5061.873453163664, 5084.186530155176, 4743.667943243974, 4767.952320476786, 4781.832635857728, 4842.0, 4892.2661600760175, 4846.0550192712435, 4848.175810112254, 4880.585150262232, 4904.926426103611, 4949.876253093666, 5313.378469335202, 5331.600129990227, 5335.413104558495, 5369.24830523727, 5431.728413579305, 5507.972460137674, 5556.888862222733, 5698.572607054488, 5715.5427565794635, 5729.484346408802, 5764.423557644202, 5804.941950580483, 5807.128930660435, 5814.738336774855, 5879.0, 5435.537979271767, 5437.34751829783, 5439.564834813205, 5441.673499590037, 5443.945560544384, 5656.745446454919, 5891.852703682443, 5892.911606325909, 5894.646321220741, 5901.970490147522, 5526.668399896019, 5545.140503222007, 5623.100303951348, 5693.971530142323, 5694.231278777394, 5670.603057785916, 5717.628354156966, 5722.198892155018, 5725.627834190765, 5818.0, 5719.656820590778, 5719.971400142973, 5720.313562372458, 5731.312242530923, 5804.6807425592, 5451.373092094381, 5452.236686863842, 5509.090999985037, 5598.076317407664, 5729.341125770507, 4287.056847493546, 4296.849610263688, 4297.39836422901, 4298.656107511391, 4299.1831552005015, 3886.203328317688, 3900.921981560353, 3906.2968665639887, 3908.1988192420486, 3919.451276821247, 5291.126964050965, 5295.338082739658, 5299.973500132552, 5301.416844147141, 5304.336957880265, 5561.054620714407, 5601.80393686219, 5604.859878502988, 5617.38208797032, 5618.0449323615085, 5281.867953301121, 5308.150695888717, 5312.787488500417, 5314.468553144655, 5327.81352652663, 4892.486288939681, 4896.632752543503, 4909.116359055404, 4926.655134140576, 4931.876703082452, 5935.376785437467, 5937.851553711192, 5938.8812223755285, 5942.108683697394, 5944.227250457413, 5494.917576236279, 5545.0, 5749.338826035059, 5765.91351129725, 5772.6536407815665, 5886.852828679317, 5949.2266005419015, 5957.791477298274, 5998.820035398945, 6057.939420605914, 5687.800926967537, 5697.658140511582, 5702.144678298288, 5707.143928410605, 5708.115242137475, 5536.833894983157, 5802.796902108406, 5803.274590676166, 5813.215215945793, 5818.76724930998, 5462.235287059894, 5480.671159730429, 5503.862403439946, 5524.088525393265, 5610.4670056344585, 5493.697846618475, 5502.147167189092, 5511.614187007031, 5514.310711161105, 5514.338279406497, 5459.645123066988, 5478.287822583039, 5489.890202196014, 5499.477549632778, 5546.584006199632, 5468.699221542854, 5503.972480137573, 5663.263775709132, 5700.885982280248, 5708.942910571007, 5566.081596536526, 5599.524040456607, 5600.103983362643, 5603.747831347518, 5630.60585758993], "value": 5266.575842911625, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.3848097575196, 600.3126420248815, 608.8356143841163, 626.6115008694608, 640.5004096804494, 30604.54093188601, 42979.78510107449, 43130.784346078224, 43422.13155736883, 43463.78268108663, 43426.56573434272, 43815.34276985848, 43840.780796096056, 43856.78071609638, 43897.0, 8045.517268963852, 8858.601362938683, 8933.46399216049, 9004.23464005557, 9027.638894444248, 8054.154313797055, 10547.261691681548, 10734.78530429391, 10774.515146818372, 10974.176936729737, 10803.351798892052, 10832.079273261783, 10866.67399978002, 10874.45627718615, 10875.673729788079, 8054.879176812353, 8229.341652667772, 10647.361158330486, 10717.464126793708, 10727.356358618508, 10294.639687610897, 10643.30818496803, 10655.30740501865, 10950.835737463944, 10961.177911656578, 40505.79747101275, 40907.181856363, 40909.38635920463, 40912.0, 40981.0, 3071.6467606225347, 3130.076627394924, 3134.2634480896972, 3275.0, 3567.357875582394, 31007.0, 31630.0, 31761.523577146363, 31771.205719856956, 32231.0, 4300.0, 4320.552614874021, 4335.089631177457, 4397.846075387346, 4461.977690111561, 304994.0, 306223.0, 306872.9999999978, 307469.0, 308175.0, 34118.31763364719, 56935.71532142313, 57202.7139864298, 57227.42772572304, 57289.0, 33875.491867622004, 35741.28517429637, 35937.8203108988, 36075.0, 36101.0, 12947.0, 13192.802107968388, 13220.471181152838, 13232.0, 13234.470621175045, 9572.329936904489, 9667.371620844622, 10571.577136914591, 10697.786044279072, 10843.783124337628, 8079.2324729151815, 8101.189881011852, 8116.350691944748, 8238.340932725368, 8260.793480163044, 3138.5606015157896, 3148.9055328340187, 3170.334229811719, 3178.173674844557, 3233.0462513558555, 957.6791774755395, 973.7176218896441, 1036.9325993810378, 1060.931039482431, 1078.5146683992234, 31361.0, 31713.841430792698, 31788.364232715216, 31870.362592748013, 31908.521372179435, 1046.08467590858, 1069.550788668761, 1110.5058249079243, 1122.2144498850837, 1124.0670243697875, 15862.841371586137, 16737.581560461087, 16782.496525104267, 16799.0, 16937.32250709958, 506524.0, 510447.0, 512695.0, 512825.0, 512988.0, 55608.44391556113, 56331.0, 56402.71798640981, 56409.0, 56420.153697694564, 1148.1388958281289, 1205.9276443413423, 1268.835051443325, 1272.1222356573935, 1294.5792617399195, 27978.440431190855, 32070.83964580162, 32099.839500802347, 32330.676693232766, 32372.514412284305, 47841.0, 48494.515054849, 48557.0, 48614.0, 48619.756901216686, 346038.0, 346901.0, 347569.0, 347628.0, 348718.0, 26738.866305668347, 27127.321816953943, 27147.86426067857, 27665.446691066467, 28719.712802871705, 45663.0, 45745.0, 46162.307565385876, 46190.53809461863, 46216.537834621224, 38616.6138338613, 40911.38632920568, 43172.78413607912, 43842.780786097144, 44958.0, 39730.801345994245, 39910.40134398045, 40298.395524066575, 40623.07279129345, 40871.38692919549, 39925.80037099796, 40348.0, 40478.79760601178, 41027.794861025504, 41090.1781964365, 34052.82973585116, 36634.26731465409, 37327.626723732414, 37429.0, 37546.0, 27980.44039119247, 28134.577981330705, 28435.715642843308, 28497.572536411557, 28512.287192820346], "value": 18480.456090055282, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.6439524870376, 375.35064338694076, 377.72426128925883, 390.3870922651437, 407.1815650542409, 14550.345234464461, 14726.926365368172, 18164.349776895124, 18552.814471855276, 18608.441746747587, 17409.30362785487, 18058.0, 18212.544686382847, 18235.0, 18276.634467310647, 4018.9397159042637, 5358.59810514212, 5579.442055794429, 5581.609287349887, 5583.5254003409755, 4202.411662367271, 5983.252093488314, 6188.938110618881, 6276.68616569172, 6386.840328991766, 6109.450149486545, 6234.189555357797, 6283.151774510428, 6334.461570766491, 6345.650989195616, 6241.531885108612, 6248.0, 6267.592606480564, 6283.560150789446, 6283.905741413837, 5334.67991920486, 5376.704281264529, 5405.18922161675, 5429.126951201829, 5462.6995515246645, 22052.88973555138, 22381.0, 22389.664155037688, 22500.324990250156, 22560.43598910024, 2016.7680716717618, 2070.234013415031, 2073.5541858500496, 2075.9065842037144, 2736.3843135294596, 9223.723288301362, 9383.906160938372, 9420.717378478588, 9506.574013897902, 10233.897661023444, 1925.951851203717, 1932.391296741522, 2012.3258708332726, 2031.207828946712, 2045.6522391193532, 79304.60347698224, 81011.5949420255, 83538.0, 87497.0, 87970.56014719949, 9533.427994320364, 9828.803423931482, 10047.799044019079, 10290.0, 10751.892481075245, 15027.849721502864, 15044.172570508508, 15059.623509412133, 15061.548153555412, 15067.623309417133, 7100.893486597705, 7230.13238411394, 7393.55638661682, 7465.962670186723, 7495.400367970549, 7004.894926576106, 7024.1571011478945, 7086.751963681247, 7258.782236532912, 7298.160711518137, 4473.932891006638, 4632.305154226893, 4642.257238841769, 4690.437147542317, 4692.41344831896, 1850.3893715073993, 1898.506388339042, 1943.6209939061748, 1959.549303660166, 1967.6163148185967, 950.7195377363694, 962.5235508423375, 966.8598053282235, 969.9612015519441, 1004.3973615830444, 16997.830021699872, 18280.542986425447, 18552.07239638013, 18720.53198670044, 19070.2371905125, 917.2707697380598, 967.1682353176262, 967.8935317115112, 1016.913562347194, 1037.4708898461838, 9591.518244197363, 10309.690709278733, 10426.27016108865, 10439.164866810637, 10520.684379468628, 336946.0, 339222.0, 344689.0, 442884.0, 447975.0, 90266.54866725755, 93751.53124234335, 94315.52842235882, 94908.0, 95002.52498737462, 980.6469670918464, 989.618996686281, 1038.766277587552, 1083.1443159903588, 1096.780643871229, 16138.838611614203, 16889.40887068996, 16955.49133525996, 17038.0, 17323.393681221096, 38835.0, 39339.65612922933, 39983.40024899687, 40175.1964960705, 40289.395659064554, 54375.72812135914, 56212.43787562072, 56591.43408565861, 56659.0, 57433.138502921654, 8108.675652973815, 8163.79590510242, 8242.17578242195, 8318.70884519039, 8355.373346998878, 11479.483423246142, 12516.624501264976, 12576.245425274146, 12766.61700148997, 13049.478020879058, 10922.781544369227, 11145.49845256949, 11281.774364512828, 11471.483783229607, 11518.502594662641, 11168.944155279496, 11184.776304474028, 11500.252483588874, 11558.537658493902, 11585.478653460446, 10697.197710171924, 11109.0, 11313.20807543464, 11353.829692554453, 11492.712682183012, 8076.800063966822, 8248.958755206186, 8255.133211012757, 8275.62759675828, 8417.158284171534, 8557.015943166616, 11043.337399756041, 11132.165087618623, 11212.103031757602, 11469.598564050219], "value": 8875.721007313474, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.1221187910041, 1451.6516036151327, 1478.3495262084684, 1597.273240675492, 1798.7122060470326, 7754.961225193873, 8653.264472519835, 9015.0, 9018.413803102794, 9247.398919070272, 8938.419002764816, 8968.327375446836, 9036.50299233542, 9046.819063618741, 9060.229880460152, 2233.9888300558514, 2252.8648281103106, 2259.649754288088, 2262.2760716570706, 2262.45701031752, 2219.0679914435977, 2239.992003598379, 2283.075354481438, 2287.977120228793, 2288.8397812153157, 2229.2754854672216, 2236.3738153317017, 2236.4856083100894, 2237.6755370471274, 2272.9545409091807, 2176.662617294322, 2178.5207254404004, 2178.6623073423566, 2195.1877805212093, 2196.791304826039, 2159.050017992094, 2162.4701948022835, 2166.36439488187, 2167.100653228924, 2169.956600867974, 8739.126087391274, 8920.910790892072, 8941.150590693873, 8943.060978597283, 8959.865602015974, 5117.334746482933, 5272.156454967225, 5291.232771248186, 5384.353877534721, 5388.030154572176, 3130.624325081005, 3290.9835450822593, 3356.63077061523, 3368.949465758016, 3373.2241584435474, 1041.739565108723, 1056.6618682021756, 1060.9787804243872, 1073.7154654016692, 1080.783843231357, 12747.936260318731, 12793.680157996032, 12857.807132893107, 12871.806922896165, 12884.420201090974, 4323.740575565476, 4333.8699839004885, 4463.4420697412825, 4480.372747815309, 4485.0805584855025, 10051.396916185053, 10054.949725251474, 10057.446840423701, 10064.748381290527, 10070.74823129413, 5264.105102132647, 5267.420583735786, 5267.710275934784, 5270.525652691276, 5272.551833094153, 3951.881443556698, 4093.7134400592267, 4237.173751118502, 4915.827946021872, 4918.803247870117, 3607.8196090195383, 3661.7436779425184, 3694.113412780913, 3771.2080463103057, 3779.5842457329672, 1016.4714348538866, 1070.5664205996584, 1073.431081526792, 1077.8975997280245, 1088.8040152772578, 732.3774791427351, 893.5398269891011, 895.1853813030242, 907.9591418386188, 911.9224865886341, 5468.507834294853, 5488.286522752017, 5596.225963456478, 5689.544836413077, 5732.34078081026, 412.4967539601681, 414.9813258403379, 440.8082484119418, 441.13097198518864, 442.52870692712156, 3662.6520480554304, 3771.981140094282, 3773.6792372648633, 3791.3175628387157, 3791.7156213284115, 10940.945295273472, 11355.772884542263, 11396.715082123013, 11490.712732181595, 11496.885031149748, 10994.450277486254, 11430.314181149157, 11432.94283528577, 11440.885591143982, 11440.942795286137, 8236.711715089943, 8417.242448179693, 8426.53654049021, 8426.873596896052, 8435.873461898076, 5341.572674185978, 5433.8369848904595, 5451.1005684063275, 5495.642783219078, 5584.022796010763, 10112.878475619225, 10272.794544109225, 10353.74115647115, 10410.0, 10443.94778026105, 9322.673706420243, 10509.842352364567, 10540.209484288862, 10561.207909406672, 10646.946765266124, 6783.660816959034, 7132.572045677276, 7196.820079498055, 7311.159216689936, 7434.107907051189, 8561.529115898686, 8623.56882155877, 8640.697575584825, 8717.128287171232, 8780.868286975829, 7633.084029916446, 7645.120811106794, 7683.500572462772, 7684.154742978156, 7733.613319333898, 7777.300042996158, 7784.571848548384, 7820.296173344426, 7839.25527074927, 7892.210778922062, 6895.207051188977, 6912.965435172792, 6928.307169283032, 6948.027276181439, 6953.130858642669, 4883.706977581356, 4915.778789954389, 4991.425986011655, 4991.700497970133, 5075.467075956972, 4886.975565122294, 4898.975505122452, 5069.340985671839, 5108.872278193075, 5146.511081447256], "value": 4426.029069819124, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.13085593782245, 302.4253917556643, 311.18935173872063, 315.7174328975568, 317.65058435720726, 5227.581793456519, 5279.260903473512, 5285.339332583427, 5291.788328466857, 5292.417834038262, 5252.290940723001, 5254.211868219769, 5257.290265814124, 5259.815906443275, 5289.391719952207, 3901.4928059352314, 4022.698297627675, 4023.1551374211303, 4024.436578878959, 4026.335654616985, 3658.042947023343, 3998.0204849811835, 4037.9596204037875, 4082.6937979651498, 4083.12212874232, 4030.435738996543, 4041.4746083009168, 4043.6158564936286, 4045.554988951213, 4057.229126465962, 4040.0707837197315, 4050.574689657573, 4051.5948405159543, 4053.9865033741567, 4056.8782936511802, 3334.149791803099, 3442.9311413771584, 3458.9308213835584, 3541.29174165168, 3561.4123669594487, 5091.0, 5092.0, 5097.464766199532, 5106.821261255838, 5107.821226257063, 4572.839950601746, 4579.603221017588, 4583.0, 4586.770661466913, 4596.5863072323655, 5324.361076670785, 5404.864978354551, 5427.348718153808, 5446.455354464521, 5448.564114870801, 3880.3403421418143, 3885.2423777363424, 3891.210043380049, 3892.2799282132896, 3915.960840391588, 5355.634313250135, 5541.445855414467, 5634.943650563483, 5664.518515926151, 5673.290838645128, 3880.0881792778673, 3955.288048151303, 3971.404289356562, 3979.1245925896255, 3983.183447393277, 4000.9399859002137, 4006.8797936061965, 4008.6793056555407, 4032.697547683935, 4038.818253178614, 4493.59557639814, 4607.838725644587, 4620.907581848344, 4621.653375996813, 4634.930476042862, 5481.972590137104, 5511.862203444865, 5513.751881165357, 5532.612717109763, 5542.0, 1384.5223397927698, 1397.8881689464818, 1401.187311359409, 1402.975827645804, 1409.7532931736905, 862.8317478091838, 904.5070436612062, 917.9908200917905, 919.5034681272039, 922.3128769066954, 4756.500567440438, 4767.475577686451, 4774.880627984328, 4784.928226076611, 4792.0895029944195, 5015.774290156952, 5020.397552293675, 5044.268581055726, 5053.620978426633, 5080.644354895196, 4597.276575353439, 4654.371659825948, 4767.0, 4777.518969119584, 4790.233562630032, 2644.7751941085226, 2650.721674224217, 2659.8138130331076, 2669.546177149889, 2672.8797204125863, 5070.492950704974, 5086.237064440364, 5089.440161582297, 5103.642745007814, 5118.769655365518, 5005.6996580205305, 5009.393236869448, 5039.773210205476, 5367.275417818622, 5835.649861008353, 5826.426864746495, 5894.0, 5897.852553686106, 5898.262717160355, 5918.674472903946, 5692.6299790513485, 5715.31416230055, 5719.656820590778, 5731.455511726379, 5736.196932429547, 5470.835874923759, 5567.582431317586, 5660.603757736919, 5661.377248502579, 5670.858228544319, 5514.310711161105, 5672.801451949162, 5744.4829965303325, 5867.32525759526, 5887.558433117448, 3909.8436062558317, 3925.371940489508, 3947.585503522089, 3950.0, 3957.8614748483665, 5667.518260947701, 5669.376368599534, 5682.77268909239, 5690.9756243874845, 5695.487406133302, 5370.946290537201, 5546.500814926676, 5549.278593782782, 5559.275954782209, 5586.692731899622, 5519.917201241904, 5536.944630553643, 5557.3331200256225, 5560.944390556043, 5566.0, 5363.436839131991, 5546.195801608825, 5546.861328466821, 5547.0, 5556.194351819045, 5550.198114291723, 5587.804426845203, 5595.328560572757, 5597.748101335531, 5598.440155984369, 5449.945500544944, 5462.535684466706, 5469.156038859691, 5474.534664553557, 5479.205515200353], "value": 4094.7215342607456, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.400235797214, 704.4329314901502, 730.7661548304542, 776.4254451705735, 833.9583020848958, 15470.535883923472, 15677.529674109766, 16018.679626407466, 16030.198490075509, 16041.278142483587, 15747.527574172764, 15787.368505259805, 15848.76226856598, 15852.841471585281, 15867.127307998084, 668.6890595872918, 678.3453966921944, 802.430274505102, 824.3446460064233, 827.6565225431439, 796.3788245168778, 798.8641930871737, 815.0097631377874, 819.33633756657, 819.8565251081067, 862.4049405909933, 867.8958524977012, 868.0624925080929, 868.3313848336777, 868.6264906090379, 699.5452955578863, 702.2906864067278, 860.6643409070437, 862.4911302331623, 862.611824678897, 603.3001718007134, 603.5744799916049, 620.3486339343671, 621.2638023941644, 621.9129321894939, 14214.431422743079, 14238.28808559568, 14272.500462483764, 14285.78571321431, 14306.284685765775, 13780.655483612889, 13983.720325593431, 14012.369443375073, 14194.148351098864, 14506.854931450656, 12235.265884046985, 12355.62933112008, 12795.296258705768, 12883.549075782303, 12962.15745976518, 4382.671299652507, 4437.090396468716, 4484.0, 4529.818807247706, 4581.335706322598, 79619.26091825338, 79780.60109699414, 79839.0, 80102.0, 80968.59515702442, 10778.676639700821, 11067.557297708001, 11076.778464430667, 11123.16576256784, 11314.943425282821, 20347.15139880418, 20575.58848823015, 20602.175912963314, 20689.58620827575, 21078.0, 8147.592620368958, 8252.33981281508, 8302.128276530999, 8324.791880203044, 8499.702510412106, 4655.976720116378, 4718.834840780556, 4736.100140973204, 4810.470848206694, 4894.902101957941, 3389.983050084734, 3465.0, 3484.651534846546, 3496.7727097738566, 3505.158761897126, 589.6874656432097, 592.523018969725, 607.2439812433548, 609.4088733928082, 620.3672254300589, 674.7773234832493, 682.2256738601723, 690.9792706218822, 704.8766465868453, 705.6859697434695, 9354.158125768578, 9787.90212097884, 9926.156276716416, 9927.702168934944, 9960.302778805559, 572.01898743654, 599.5293694449836, 698.9440844732511, 716.7312257903286, 746.391690772019, 4660.254359302496, 5015.247712843103, 5040.59675225981, 5072.416672082684, 5080.0, 102517.48741256246, 104487.0, 105758.0, 106397.46801266099, 109813.0, 92268.53865730629, 92756.0, 93880.53059734657, 94030.52984735032, 94410.0, 82563.58718206371, 82923.58538207391, 83005.16994830096, 83250.99999999879, 84195.0, 9376.531173441164, 9690.70927872165, 9694.9030509694, 9698.51507424612, 9759.853602195832, 45717.0, 45858.312125318815, 46678.53321466742, 46877.53122468868, 47638.523614764796, 64145.0, 64265.35734642594, 66811.3318866805, 66914.66542667255, 69788.65105674643, 13170.209787412787, 13654.863451365756, 13757.587272381845, 13766.24285664298, 13934.58196254114, 14539.563813085624, 14551.126932384092, 15268.3892644293, 15600.141992190538, 15611.219439028231, 13436.865631343953, 13998.300084995506, 14235.928820355832, 14851.777223341442, 14940.925295373454, 14307.92846035763, 14472.276386180438, 14881.404743810126, 15056.63091028943, 15704.0, 14156.056349253511, 14620.561383158521, 14715.632109196928, 15015.699686006, 15674.451394201149, 10999.34003959765, 11720.648380548597, 11994.0, 12149.453274602487, 12494.437750301076, 10048.49757512136, 10461.424621645578, 11620.070394368598, 11631.812089231853, 11700.2979821211], "value": 7550.658338478843, "unit": "score"}], "name": "dromaeo_css", "value": 7005.709524690523, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 110.0, 112.0, 112.0, 111.0, 114.0, 111.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 123.0, 151.0, 126.0, 122.0, 120.0, 121.0, 155.0, 122.0], "value": 131.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 162.0, 160.0, 161.0, 160.0, 162.0, 163.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 110.0, 76.0, 77.0, 75.0, 75.0, 100.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 126.0, 84.0, 85.0, 84.0, 109.0, 83.0, 83.0, 110.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 145.0, 145.0, 147.0, 146.0, 146.0, 145.0, 144.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 55.0, 55.0, 55.0, 55.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 58.0, 58.0, 60.0, 63.0, 60.0, 59.0, 60.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 88.0, 86.0, 79.0, 82.0, 78.0, 78.0, 78.0, 79.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 132.0, 140.0, 127.0, 141.0, 129.0, 131.0, 133.0, 170.0, 133.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 165.0, 181.0, 173.0, 173.0, 165.0, 168.0, 167.0, 177.0], "value": 170.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 68.0, 66.0, 69.0, 66.0, 68.0, 67.0, 65.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1494.3999999999996, "alertThreshold": 2.0}]} 03:44:43 INFO - Return code: 0 03:44:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:44:43 INFO - # TBPL SUCCESS # 03:44:43 INFO - Running post-action listener: _resource_record_post_action 03:44:43 INFO - [mozharness: 2016-10-16 10:44:43.788181Z] Finished run-tests step (success) 03:44:43 INFO - Running post-run listener: _resource_record_post_run 03:44:43 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 7913472; Write bytes: 423485440; Read time: 2164; Write time: 400464 03:44:43 INFO - TinderboxPrint: CPU usage
13.1% 03:44:43 INFO - TinderboxPrint: I/O read bytes / time
7,913,472 / 2,164 03:44:43 INFO - TinderboxPrint: I/O write bytes / time
423,485,440 / 400,464 03:44:43 INFO - TinderboxPrint: CPU idle
8,328.9 (86.9%) 03:44:43 INFO - TinderboxPrint: CPU user
1,200.4 (12.5%) 03:44:43 INFO - TinderboxPrint: Swap in / out
0 / 0 03:44:43 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 6393856; Read time: 0; Write time: 432 03:44:43 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 5701632; Write bytes: 379219968; Read time: 1732; Write time: 384360 03:44:44 INFO - Running post-run listener: _upload_blobber_files 03:44:44 INFO - Blob upload gear active. 03:44:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:44:44 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 03:44:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:44:44 INFO - (blobuploader) - INFO - Open directory for files ... 03:44:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:44:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:44:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:45 INFO - (blobuploader) - INFO - Done attempting. 03:44:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:44:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:44:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:46 INFO - (blobuploader) - INFO - Done attempting. 03:44:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:44:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:44:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:49 INFO - (blobuploader) - INFO - Done attempting. 03:44:49 INFO - (blobuploader) - INFO - Iteration through files over. 03:44:49 INFO - Return code: 0 03:44:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:44:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:44:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eb84b94ac06b961ac36fa07b3807b498a3518e6c1630e47899f920382bbc4cdcf560573bca7bd625dbdfafc3ee0215af932d0f9585018b9cc891e98fa60257a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b17e9c9e88cf23d6f000c592016ea6a290c85e92f7c173a11320f9c01af680dea574cf7fc8d23ea9271c9d840004bc6b6630847502f0663f8e6a63b67455b745", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7b2737398c26a4a794fa193a8f82706f55f72c3433c3bfc33e8bd3be1e9ba74262d362ab702c157d0076a49aec7fa3f3a0f49eb08d1bfa96958f98ef88c098cc"} 03:44:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:44:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:44:49 INFO - Contents: 03:44:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eb84b94ac06b961ac36fa07b3807b498a3518e6c1630e47899f920382bbc4cdcf560573bca7bd625dbdfafc3ee0215af932d0f9585018b9cc891e98fa60257a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b17e9c9e88cf23d6f000c592016ea6a290c85e92f7c173a11320f9c01af680dea574cf7fc8d23ea9271c9d840004bc6b6630847502f0663f8e6a63b67455b745", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7b2737398c26a4a794fa193a8f82706f55f72c3433c3bfc33e8bd3be1e9ba74262d362ab702c157d0076a49aec7fa3f3a0f49eb08d1bfa96958f98ef88c098cc"} 03:44:49 INFO - Running post-run listener: copy_logs_to_upload_dir 03:44:49 INFO - Copying logs to upload dir... 03:44:49 INFO - mkdir: /builds/slave/test/build/upload/logs 03:44:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.680016 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-16 03:44:49.666401) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-16 03:44:49.669476) ========= 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=41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eb84b94ac06b961ac36fa07b3807b498a3518e6c1630e47899f920382bbc4cdcf560573bca7bd625dbdfafc3ee0215af932d0f9585018b9cc891e98fa60257a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b17e9c9e88cf23d6f000c592016ea6a290c85e92f7c173a11320f9c01af680dea574cf7fc8d23ea9271c9d840004bc6b6630847502f0663f8e6a63b67455b745", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7b2737398c26a4a794fa193a8f82706f55f72c3433c3bfc33e8bd3be1e9ba74262d362ab702c157d0076a49aec7fa3f3a0f49eb08d1bfa96958f98ef88c098cc"} build_url:https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/AzpHiTGOQ82e-GA0sNyqcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eb84b94ac06b961ac36fa07b3807b498a3518e6c1630e47899f920382bbc4cdcf560573bca7bd625dbdfafc3ee0215af932d0f9585018b9cc891e98fa60257a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b17e9c9e88cf23d6f000c592016ea6a290c85e92f7c173a11320f9c01af680dea574cf7fc8d23ea9271c9d840004bc6b6630847502f0663f8e6a63b67455b745", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7b2737398c26a4a794fa193a8f82706f55f72c3433c3bfc33e8bd3be1e9ba74262d362ab702c157d0076a49aec7fa3f3a0f49eb08d1bfa96958f98ef88c098cc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-16 03:44:49.700160) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 03:44:49.700505) ========= 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=41bf3e9aed84707956354da8000001c5-1476606476.829650-414308496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004357 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 03:44:49.786738) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-16 03:44:49.787429) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-16 03:44:49.790024) ========= ========= Total master_lag: 0.21 =========