builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1480460855.69 results: success (0) buildid: 20161129150102 builduid: 037b67c262b041c6ae3b8b8ba2ce2390 revision: d254eb61360d3c20172eb7aba1154e2779850263 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 15:07:35.687764) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 15:07:35.688290) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 15:07:35.688623) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 15:07:35.704184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:07:35.704486) ========= 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=df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-29 15:07:36-- 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% 42.7M=0s 2016-11-29 15:07:36 (42.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118011 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:07:35.839375) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:07:35.840064) ========= 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=df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015133 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:07:35.892739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 15:07:35.893133) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d254eb61360d3c20172eb7aba1154e2779850263 --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 d254eb61360d3c20172eb7aba1154e2779850263 --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=df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-29 15:07:36,271 truncating revision to first 12 chars 2016-11-29 15:07:36,271 Setting DEBUG logging. 2016-11-29 15:07:36,271 attempt 1/10 2016-11-29 15:07:36,271 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d254eb61360d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 15:07:37,172 unpacking tar archive at: mozilla-inbound-d254eb61360d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.216344 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 15:07:37.127767) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 15:07:37.128154) ========= script_repo_revision: d254eb61360d3c20172eb7aba1154e2779850263 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 15:07:37.131401) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 15:07:37.131777) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 15:07:37.142646) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-11-29 15:07:37.142968) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:07:37 INFO - MultiFileLogger online at 20161129 15:07:37 in /builds/slave/test 15:07:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:07:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:07:37 INFO - {'append_to_log': False, 15:07:37 INFO - 'base_work_dir': '/builds/slave/test', 15:07:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:07:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:07:37 INFO - 'branch': 'Mozilla-Inbound', 15:07:37 INFO - 'buildbot_json_path': 'buildprops.json', 15:07:37 INFO - 'config_files': ('talos/linux_config.py',), 15:07:37 INFO - 'default_actions': ('clobber', 15:07:37 INFO - 'read-buildbot-config', 15:07:37 INFO - 'download-and-extract', 15:07:37 INFO - 'populate-webroot', 15:07:37 INFO - 'create-virtualenv', 15:07:37 INFO - 'install', 15:07:37 INFO - 'run-tests'), 15:07:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:07:37 INFO - 'download_minidump_stackwalk': True, 15:07:37 INFO - 'download_symbols': 'ondemand', 15:07:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:07:37 INFO - 'tooltool.py': '/tools/tooltool.py', 15:07:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:07:37 INFO - '/tools/misc-python/virtualenv.py')}, 15:07:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:07:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:07:37 INFO - 'installer_path': 'installer.exe', 15:07:37 INFO - 'log_level': 'info', 15:07:37 INFO - 'log_name': 'talos', 15:07:37 INFO - 'log_to_console': True, 15:07:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:07:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:07:37 INFO - 'opt_config_files': (), 15:07:37 INFO - 'pip_index': False, 15:07:37 INFO - 'sps_profile': False, 15:07:37 INFO - 'sps_profile_interval': 0, 15:07:37 INFO - 'suite': 'dromaeojs-e10s', 15:07:37 INFO - 'system_bits': '32', 15:07:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:07:37 INFO - 'title': 'talos-linux64-ix-021', 15:07:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:07:37 INFO - 'use_talos_json': True, 15:07:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:07:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:07:37 INFO - 'work_dir': 'build'} 15:07:37 INFO - [mozharness: 2016-11-29 23:07:37.614709Z] Running clobber step. 15:07:37 INFO - Running pre-action listener: _resource_record_pre_action 15:07:37 INFO - Running main action method: clobber 15:07:37 INFO - rmtree: /builds/slave/test/build 15:07:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:07:38 INFO - Running post-action listener: _resource_record_post_action 15:07:38 INFO - [mozharness: 2016-11-29 23:07:38.077410Z] Finished clobber step (success) 15:07:38 INFO - [mozharness: 2016-11-29 23:07:38.077510Z] Running read-buildbot-config step. 15:07:38 INFO - Running pre-action listener: _resource_record_pre_action 15:07:38 INFO - Running main action method: read_buildbot_config 15:07:38 INFO - Using buildbot properties: 15:07:38 INFO - { 15:07:38 INFO - "project": "", 15:07:38 INFO - "product": "firefox", 15:07:38 INFO - "script_repo_revision": "production", 15:07:38 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 15:07:38 INFO - "repository": "", 15:07:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 15:07:38 INFO - "buildid": "20161129150102", 15:07:38 INFO - "stage_platform": "linux64-pgo", 15:07:38 INFO - "basedir": "/builds/slave/test", 15:07:38 INFO - "buildnumber": 2171, 15:07:38 INFO - "platform": "ubuntu64_hw", 15:07:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:07:38 INFO - "slavebuilddir": "test", 15:07:38 INFO - "branch": "mozilla-inbound", 15:07:38 INFO - "revision": "d254eb61360d3c20172eb7aba1154e2779850263", 15:07:38 INFO - "slavename": "talos-linux64-ix-021", 15:07:38 INFO - "builduid": "037b67c262b041c6ae3b8b8ba2ce2390", 15:07:38 INFO - "repo_path": "integration/mozilla-inbound" 15:07:38 INFO - } 15:07:38 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 15:07:38 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 15:07:38 INFO - Running post-action listener: _resource_record_post_action 15:07:38 INFO - [mozharness: 2016-11-29 23:07:38.079889Z] Finished read-buildbot-config step (success) 15:07:38 INFO - [mozharness: 2016-11-29 23:07:38.079977Z] Running download-and-extract step. 15:07:38 INFO - Running pre-action listener: _resource_record_pre_action 15:07:38 INFO - Running main action method: download_and_extract 15:07:38 INFO - mkdir: /builds/slave/test/build/tests 15:07:38 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')]} 15:07:38 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:07:38 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:07:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:07:38 INFO - Downloaded 1361 bytes. 15:07:38 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:07:38 INFO - Using the following test package requirements: 15:07:38 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:07:38 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:07:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:07:38 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:07:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:07:38 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:07:38 INFO - u'jsshell-linux-x86_64.zip'], 15:07:38 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:07:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:07:38 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:07:38 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:07:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:07:38 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:07:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:07:38 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:07:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:07:38 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:07:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:07:38 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:07:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:07:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:07:38 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:07:38 INFO - Http code: 200 15:07:38 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 15:07:38 INFO - x-amz-cf-id: uGEOvmmcWQufeXs-Hh8ZfXHnEmmjbPef-ytZPh2qiFF58b2h_qO-Kg== 15:07:38 INFO - x-amz-replication-status: COMPLETED 15:07:38 INFO - x-amz-version-id: NgAiTSUg5NHjTlSrCie7lvcJ.WvdJU8t 15:07:38 INFO - Expected file size: 21781655 15:07:38 INFO - Obtained file size: 21781655 15:07:42 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:07:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:07:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:07:42 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:07:42 INFO - Http code: 200 15:07:42 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 15:07:42 INFO - x-amz-cf-id: s-nKLpGo_eMOKeHIfIyMUsM3TzAoqd1s8iJi04XMd1FxDjHDzzSdYg== 15:07:42 INFO - x-amz-replication-status: COMPLETED 15:07:42 INFO - x-amz-version-id: NgAiTSUg5NHjTlSrCie7lvcJ.WvdJU8t 15:07:42 INFO - Expected file size: 21781655 15:07:42 INFO - Obtained file size: 21781655 15:07:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 15:07:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:07:47 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:07:47 INFO - Http code: 200 15:07:47 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 15:07:47 INFO - x-amz-cf-id: sCOJ2HlBoBU-xseB7QXlu6b1-5N9NMSLQGPFSEQj4eifDH2JKT1RUg== 15:07:47 INFO - x-amz-replication-status: COMPLETED 15:07:47 INFO - x-amz-version-id: RDqRDktZfsVtVrHlr1W8TlvdGi6tGcpa 15:07:47 INFO - Expected file size: 14409702 15:07:47 INFO - Obtained file size: 14409702 15:07:47 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')]} 15:07:47 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:07:47 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:07:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:07:48 INFO - Downloaded 59787803 bytes. 15:07:48 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:07:48 INFO - mkdir: /builds/slave/test/properties 15:07:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:07:48 INFO - Writing to file /builds/slave/test/properties/build_url 15:07:48 INFO - Contents: 15:07:48 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:07:48 INFO - Running post-action listener: _resource_record_post_action 15:07:48 INFO - Running post-action listener: set_extra_try_arguments 15:07:48 INFO - [mozharness: 2016-11-29 23:07:48.657991Z] Finished download-and-extract step (success) 15:07:48 INFO - [mozharness: 2016-11-29 23:07:48.658091Z] Running populate-webroot step. 15:07:48 INFO - Running pre-action listener: _resource_record_pre_action 15:07:48 INFO - Running main action method: populate_webroot 15:07:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:07:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:07:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:07:48 INFO - '--tppagecycles', 15:07:48 INFO - '7'], 15:07:48 INFO - 'tests': ['tsvgm']}}, 15:07:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:07:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:07:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:07:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:07:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:07:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:07:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:07:48 INFO - 'talos_options': ['--disable-e10s'], 15:07:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:07:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:07:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:07:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:07:48 INFO - 'talos_options': ['--disable-e10s'], 15:07:48 INFO - 'tests': ['damp', 'tps']}, 15:07:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:07:48 INFO - 'tests': ['damp', 'tps']}, 15:07:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:07:48 INFO - 'tests': ['dromaeo_dom']}, 15:07:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:07:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:07:48 INFO - 'tests': ['basic_compositor_video']}, 15:07:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:07:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:07:48 INFO - 'tests': ['a11yr', 15:07:48 INFO - 'ts_paint', 15:07:48 INFO - 'tpaint', 15:07:48 INFO - 'sessionrestore', 15:07:48 INFO - 'sessionrestore_no_auto_restore', 15:07:48 INFO - 'tabpaint']}, 15:07:48 INFO - 'other-e10s': {'tests': ['a11yr', 15:07:48 INFO - 'ts_paint', 15:07:48 INFO - 'tpaint', 15:07:48 INFO - 'sessionrestore', 15:07:48 INFO - 'sessionrestore_no_auto_restore', 15:07:48 INFO - 'tabpaint']}, 15:07:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:07:48 INFO - 'ts_paint', 15:07:48 INFO - 'tpaint', 15:07:48 INFO - 'sessionrestore', 15:07:48 INFO - 'sessionrestore_no_auto_restore', 15:07:48 INFO - 'tabpaint']}, 15:07:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:07:48 INFO - 'ts_paint', 15:07:48 INFO - 'tpaint', 15:07:48 INFO - 'sessionrestore', 15:07:48 INFO - 'sessionrestore_no_auto_restore', 15:07:48 INFO - 'tabpaint']}, 15:07:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:07:48 INFO - 'tests': ['a11yr', 15:07:48 INFO - 'ts_paint', 15:07:48 INFO - 'tpaint', 15:07:48 INFO - 'sessionrestore', 15:07:48 INFO - 'sessionrestore_no_auto_restore', 15:07:48 INFO - 'tabpaint']}, 15:07:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:07:48 INFO - 'tests': ['a11yr', 15:07:48 INFO - 'ts_paint', 15:07:48 INFO - 'tpaint', 15:07:48 INFO - 'sessionrestore', 15:07:48 INFO - 'sessionrestore_no_auto_restore', 15:07:48 INFO - 'tabpaint']}, 15:07:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:07:48 INFO - 'tests': ['tsvgx', 15:07:48 INFO - 'tsvgr_opacity', 15:07:48 INFO - 'tart', 15:07:48 INFO - 'tscrollx', 15:07:48 INFO - 'cart', 15:07:48 INFO - 'tsvg_static']}, 15:07:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:07:48 INFO - 'tsvgr_opacity', 15:07:48 INFO - 'tart', 15:07:48 INFO - 'tscrollx', 15:07:48 INFO - 'cart', 15:07:48 INFO - 'tsvg_static']}, 15:07:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:07:48 INFO - 'talos_options': ['--disable-e10s'], 15:07:48 INFO - 'tests': ['tp5o']}, 15:07:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:07:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:07:48 INFO - 'talos_options': ['--disable-e10s', 15:07:48 INFO - '--xperf_path', 15:07:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:07:48 INFO - 'tests': ['tp5n']}, 15:07:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:07:48 INFO - 'talos_options': ['--xperf_path', 15:07:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:07:48 INFO - 'tests': ['tp5n']}}, 15:07:48 INFO - 'talos.zip': {'path': '', 15:07:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:07:48 INFO - Running post-action listener: _resource_record_post_action 15:07:48 INFO - [mozharness: 2016-11-29 23:07:48.673891Z] Finished populate-webroot step (success) 15:07:48 INFO - [mozharness: 2016-11-29 23:07:48.673978Z] Running create-virtualenv step. 15:07:48 INFO - Running pre-action listener: _resource_record_pre_action 15:07:48 INFO - Running main action method: create_virtualenv 15:07:48 INFO - Creating virtualenv /builds/slave/test/build/venv 15:07:48 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 15:07:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:07:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:07:48 INFO - Using real prefix '/usr' 15:07:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:07:49 INFO - Installing distribute.............................................................................................................................................................................................done. 15:07:51 INFO - Installing pip.................done. 15:07:51 INFO - Return code: 0 15:07:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:07:51 INFO - Reading from file tmpfile_stdout 15:07:51 INFO - Output received: 15:07:51 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) 15:07:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:51 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 0x7ffb7d68fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0fc0>, '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 0x17e1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e2350>, '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': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', '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 15:07:51 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 15:07:51 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 15:07:51 INFO - Using env: {'DISPLAY': ':0', 15:07:51 INFO - 'HOME': '/home/cltbld', 15:07:51 INFO - 'LANG': 'en_US.UTF-8', 15:07:51 INFO - 'LANGUAGE': 'en_US:en', 15:07:51 INFO - 'LOGNAME': 'cltbld', 15:07:51 INFO - 'MAIL': '/var/mail/cltbld', 15:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:51 INFO - 'MOZ_NO_REMOTE': '1', 15:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:07:51 INFO - 'NO_EM_RESTART': '1', 15:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:51 INFO - 'PWD': '/builds/slave/test', 15:07:51 INFO - 'SHELL': '/bin/bash', 15:07:51 INFO - 'SHLVL': '1', 15:07:51 INFO - 'TERM': 'linux', 15:07:51 INFO - 'TMOUT': '86400', 15:07:51 INFO - 'USER': 'cltbld', 15:07:51 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', 15:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:51 INFO - '_': '/tools/buildbot/bin/python'} 15:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:51 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 15:07:51 INFO - Cleaning up... 15:07:51 INFO - Return code: 0 15:07:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:51 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 0x7ffb7d68fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0fc0>, '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 0x17e1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e2350>, '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': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', '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 15:07:51 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 15:07:51 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 15:07:51 INFO - Using env: {'DISPLAY': ':0', 15:07:51 INFO - 'HOME': '/home/cltbld', 15:07:51 INFO - 'LANG': 'en_US.UTF-8', 15:07:51 INFO - 'LANGUAGE': 'en_US:en', 15:07:51 INFO - 'LOGNAME': 'cltbld', 15:07:51 INFO - 'MAIL': '/var/mail/cltbld', 15:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:51 INFO - 'MOZ_NO_REMOTE': '1', 15:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:07:51 INFO - 'NO_EM_RESTART': '1', 15:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:51 INFO - 'PWD': '/builds/slave/test', 15:07:51 INFO - 'SHELL': '/bin/bash', 15:07:51 INFO - 'SHLVL': '1', 15:07:51 INFO - 'TERM': 'linux', 15:07:51 INFO - 'TMOUT': '86400', 15:07:51 INFO - 'USER': 'cltbld', 15:07:51 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', 15:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:51 INFO - '_': '/tools/buildbot/bin/python'} 15:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:51 INFO - Downloading/unpacking psutil>=3.1.1 15:07:51 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 15:07:51 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 15:07:51 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 15:07:51 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 15:07:51 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 15:07:51 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 15:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:07:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:07:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:07:53 INFO - Installing collected packages: psutil 15:07:53 INFO - Running setup.py install for psutil 15:07:54 INFO - building 'psutil._psutil_linux' extension 15:07:54 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 15:07:54 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 15:07:54 INFO - building 'psutil._psutil_posix' extension 15:07:54 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 15:07:54 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 15:07:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:07:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:07:54 INFO - Successfully installed psutil 15:07:54 INFO - Cleaning up... 15:07:54 INFO - Return code: 0 15:07:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:07:54 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')]} 15:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:54 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')]} 15:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:54 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 0x7ffb7d68fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0fc0>, '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 0x17e1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e2350>, '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': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', '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 15:07:54 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 15:07:54 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 15:07:54 INFO - Using env: {'DISPLAY': ':0', 15:07:54 INFO - 'HOME': '/home/cltbld', 15:07:54 INFO - 'LANG': 'en_US.UTF-8', 15:07:54 INFO - 'LANGUAGE': 'en_US:en', 15:07:54 INFO - 'LOGNAME': 'cltbld', 15:07:54 INFO - 'MAIL': '/var/mail/cltbld', 15:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:54 INFO - 'MOZ_NO_REMOTE': '1', 15:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:07:54 INFO - 'NO_EM_RESTART': '1', 15:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:54 INFO - 'PWD': '/builds/slave/test', 15:07:54 INFO - 'SHELL': '/bin/bash', 15:07:54 INFO - 'SHLVL': '1', 15:07:54 INFO - 'TERM': 'linux', 15:07:54 INFO - 'TMOUT': '86400', 15:07:54 INFO - 'USER': 'cltbld', 15:07:54 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', 15:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:54 INFO - '_': '/tools/buildbot/bin/python'} 15:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:07:54 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 15:07:54 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 15:07:54 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 15:07:54 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 15:07:54 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 15:07:54 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 15:07:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:07:56 INFO - Installing collected packages: mozsystemmonitor 15:07:56 INFO - Running setup.py install for mozsystemmonitor 15:07:56 INFO - Successfully installed mozsystemmonitor 15:07:56 INFO - Cleaning up... 15:07:56 INFO - Return code: 0 15:07:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:07:56 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')]} 15:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:56 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')]} 15:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:56 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 0x7ffb7d68fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0fc0>, '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 0x17e1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e2350>, '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': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', '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 15:07:56 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 15:07:56 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 15:07:56 INFO - Using env: {'DISPLAY': ':0', 15:07:56 INFO - 'HOME': '/home/cltbld', 15:07:56 INFO - 'LANG': 'en_US.UTF-8', 15:07:56 INFO - 'LANGUAGE': 'en_US:en', 15:07:56 INFO - 'LOGNAME': 'cltbld', 15:07:56 INFO - 'MAIL': '/var/mail/cltbld', 15:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:56 INFO - 'MOZ_NO_REMOTE': '1', 15:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:07:56 INFO - 'NO_EM_RESTART': '1', 15:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:56 INFO - 'PWD': '/builds/slave/test', 15:07:56 INFO - 'SHELL': '/bin/bash', 15:07:56 INFO - 'SHLVL': '1', 15:07:56 INFO - 'TERM': 'linux', 15:07:56 INFO - 'TMOUT': '86400', 15:07:56 INFO - 'USER': 'cltbld', 15:07:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', 15:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:56 INFO - '_': '/tools/buildbot/bin/python'} 15:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:57 INFO - Downloading/unpacking jsonschema==2.5.1 15:07:57 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 15:07:57 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 15:07:57 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 15:07:57 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 15:07:57 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 15:07:57 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 15:07:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:07:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:07:59 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 15:07:59 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 15:07:59 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 15:07:59 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 15:07:59 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 15:07:59 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 15:07:59 INFO - Downloading functools32-3.2.3-2.tar.gz 15:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:07:59 INFO - warning: no files found matching '*.txt' 15:07:59 INFO - no previously-included directories found matching 'build' 15:07:59 INFO - no previously-included directories found matching 'dist' 15:07:59 INFO - no previously-included directories found matching '.git*' 15:07:59 INFO - Installing collected packages: jsonschema, functools32 15:07:59 INFO - Running setup.py install for functools32 15:07:59 INFO - warning: no files found matching '*.txt' 15:07:59 INFO - no previously-included directories found matching 'build' 15:07:59 INFO - no previously-included directories found matching 'dist' 15:07:59 INFO - no previously-included directories found matching '.git*' 15:07:59 INFO - Successfully installed jsonschema functools32 15:07:59 INFO - Cleaning up... 15:07:59 INFO - Return code: 0 15:07:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:07: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')]} 15:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07: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')]} 15:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:59 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 0x7ffb7d68fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0fc0>, '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 0x17e1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e2350>, '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': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', '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 15:07:59 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 15:07:59 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 15:07:59 INFO - Using env: {'DISPLAY': ':0', 15:07:59 INFO - 'HOME': '/home/cltbld', 15:07:59 INFO - 'LANG': 'en_US.UTF-8', 15:07:59 INFO - 'LANGUAGE': 'en_US:en', 15:07:59 INFO - 'LOGNAME': 'cltbld', 15:07:59 INFO - 'MAIL': '/var/mail/cltbld', 15:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:59 INFO - 'MOZ_NO_REMOTE': '1', 15:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:07:59 INFO - 'NO_EM_RESTART': '1', 15:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:59 INFO - 'PWD': '/builds/slave/test', 15:07:59 INFO - 'SHELL': '/bin/bash', 15:07:59 INFO - 'SHLVL': '1', 15:07:59 INFO - 'TERM': 'linux', 15:07:59 INFO - 'TMOUT': '86400', 15:07:59 INFO - 'USER': 'cltbld', 15:07:59 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', 15:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:59 INFO - '_': '/tools/buildbot/bin/python'} 15:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:07:59 INFO - Cleaning up... 15:07:59 INFO - Return code: 0 15:07:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:07: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')]} 15:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07: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')]} 15:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:59 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 0x7ffb7d68fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0fc0>, '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 0x17e1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e2350>, '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': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', '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 15:07:59 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 15:07:59 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 15:07:59 INFO - Using env: {'DISPLAY': ':0', 15:07:59 INFO - 'HOME': '/home/cltbld', 15:07:59 INFO - 'LANG': 'en_US.UTF-8', 15:07:59 INFO - 'LANGUAGE': 'en_US:en', 15:07:59 INFO - 'LOGNAME': 'cltbld', 15:07:59 INFO - 'MAIL': '/var/mail/cltbld', 15:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:59 INFO - 'MOZ_NO_REMOTE': '1', 15:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:07:59 INFO - 'NO_EM_RESTART': '1', 15:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:59 INFO - 'PWD': '/builds/slave/test', 15:07:59 INFO - 'SHELL': '/bin/bash', 15:07:59 INFO - 'SHLVL': '1', 15:07:59 INFO - 'TERM': 'linux', 15:07:59 INFO - 'TMOUT': '86400', 15:07:59 INFO - 'USER': 'cltbld', 15:07:59 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', 15:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:59 INFO - '_': '/tools/buildbot/bin/python'} 15:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:00 INFO - Downloading/unpacking blobuploader==1.2.4 15:08:00 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 15:08:00 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 15:08:00 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 15:08:00 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 15:08:00 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 15:08:00 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 15:08:01 INFO - Downloading blobuploader-1.2.4.tar.gz 15:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:08:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:08:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:02 INFO - Downloading docopt-0.6.1.tar.gz 15:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:08:02 INFO - Installing collected packages: blobuploader, requests, docopt 15:08:02 INFO - Running setup.py install for blobuploader 15:08:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:08:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:08:02 INFO - Running setup.py install for requests 15:08:03 INFO - Running setup.py install for docopt 15:08:03 INFO - Successfully installed blobuploader requests docopt 15:08:03 INFO - Cleaning up... 15:08:03 INFO - Return code: 0 15:08:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:03 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 0x7ffb7d68fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0fc0>, '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 0x17e1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e2350>, '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': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', '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 15:08:03 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 15:08:03 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 15:08:03 INFO - Using env: {'DISPLAY': ':0', 15:08:03 INFO - 'HOME': '/home/cltbld', 15:08:03 INFO - 'LANG': 'en_US.UTF-8', 15:08:03 INFO - 'LANGUAGE': 'en_US:en', 15:08:03 INFO - 'LOGNAME': 'cltbld', 15:08:03 INFO - 'MAIL': '/var/mail/cltbld', 15:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:03 INFO - 'MOZ_NO_REMOTE': '1', 15:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:03 INFO - 'NO_EM_RESTART': '1', 15:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:03 INFO - 'PWD': '/builds/slave/test', 15:08:03 INFO - 'SHELL': '/bin/bash', 15:08:03 INFO - 'SHLVL': '1', 15:08:03 INFO - 'TERM': 'linux', 15:08:03 INFO - 'TMOUT': '86400', 15:08:03 INFO - 'USER': 'cltbld', 15:08:03 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', 15:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:03 INFO - '_': '/tools/buildbot/bin/python'} 15:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:08:03 INFO - Running setup.py (path:/tmp/pip-Zb2cjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:08:03 INFO - Running setup.py (path:/tmp/pip-0cYNQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:08:03 INFO - Running setup.py (path:/tmp/pip-hai6Zr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:08:03 INFO - Running setup.py (path:/tmp/pip-zNwHMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:08:03 INFO - Running setup.py (path:/tmp/pip-TtFbI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:08:03 INFO - Running setup.py (path:/tmp/pip-88hLU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:08:04 INFO - Running setup.py (path:/tmp/pip-rv4Vb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:08:04 INFO - Running setup.py (path:/tmp/pip-NyfNMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:08:04 INFO - Running setup.py (path:/tmp/pip-YrX1Yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:08:04 INFO - Running setup.py (path:/tmp/pip-pTvw0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:08:04 INFO - Running setup.py (path:/tmp/pip-unPX3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:08:04 INFO - Running setup.py (path:/tmp/pip-x83RG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:08:04 INFO - Running setup.py (path:/tmp/pip-3yTqyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:08:04 INFO - Running setup.py (path:/tmp/pip-84asE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:08:04 INFO - Running setup.py (path:/tmp/pip-kfrQp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:08:04 INFO - Running setup.py (path:/tmp/pip-0k1drJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:08:04 INFO - Running setup.py (path:/tmp/pip-ZP_oJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:08:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:08:04 INFO - Running setup.py install for manifestparser 15:08:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:08:04 INFO - Running setup.py install for mozcrash 15:08:05 INFO - Running setup.py install for mozdebug 15:08:05 INFO - Running setup.py install for mozdevice 15:08:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:08:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:08:05 INFO - Running setup.py install for mozfile 15:08:05 INFO - Running setup.py install for mozhttpd 15:08:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:08:05 INFO - Running setup.py install for mozinfo 15:08:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:08:05 INFO - Running setup.py install for mozInstall 15:08:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:08:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:08:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:08:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:08:05 INFO - Running setup.py install for mozleak 15:08:05 INFO - Running setup.py install for mozlog 15:08:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:08:05 INFO - Running setup.py install for moznetwork 15:08:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:08:05 INFO - Running setup.py install for mozprocess 15:08:06 INFO - Running setup.py install for mozprofile 15:08:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:08:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:08:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:08:06 INFO - Running setup.py install for mozrunner 15:08:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:08:06 INFO - Running setup.py install for mozscreenshot 15:08:06 INFO - Running setup.py install for moztest 15:08:06 INFO - Running setup.py install for mozversion 15:08:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:08:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:08:06 INFO - Cleaning up... 15:08:06 INFO - Return code: 0 15:08:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:08:06 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')]} 15:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:06 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')]} 15:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:06 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 0x7ffb7d68fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0fc0>, '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 0x17e1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e2350>, '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': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', '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 15:08:06 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 15:08:06 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 15:08:06 INFO - Using env: {'DISPLAY': ':0', 15:08:06 INFO - 'HOME': '/home/cltbld', 15:08:06 INFO - 'LANG': 'en_US.UTF-8', 15:08:06 INFO - 'LANGUAGE': 'en_US:en', 15:08:06 INFO - 'LOGNAME': 'cltbld', 15:08:06 INFO - 'MAIL': '/var/mail/cltbld', 15:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:06 INFO - 'MOZ_NO_REMOTE': '1', 15:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:06 INFO - 'NO_EM_RESTART': '1', 15:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:06 INFO - 'PWD': '/builds/slave/test', 15:08:06 INFO - 'SHELL': '/bin/bash', 15:08:06 INFO - 'SHLVL': '1', 15:08:06 INFO - 'TERM': 'linux', 15:08:06 INFO - 'TMOUT': '86400', 15:08:06 INFO - 'USER': 'cltbld', 15:08:06 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', 15:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:06 INFO - '_': '/tools/buildbot/bin/python'} 15:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:08:06 INFO - Running setup.py (path:/tmp/pip-EWOMX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:08:06 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)) 15:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:08:06 INFO - Running setup.py (path:/tmp/pip-TLcTlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:08:07 INFO - Running setup.py (path:/tmp/pip-usDE8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:08:07 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)) 15:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:08:07 INFO - Running setup.py (path:/tmp/pip-9IIUvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:08:07 INFO - Running setup.py (path:/tmp/pip-njZYXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:08:07 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)) 15:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:08:07 INFO - Running setup.py (path:/tmp/pip-x7Mgik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:08:07 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)) 15:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:08:07 INFO - Running setup.py (path:/tmp/pip-kaDIhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:08:07 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)) 15:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:08:07 INFO - Running setup.py (path:/tmp/pip-0AdINY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:08:07 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)) 15:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:08:07 INFO - Running setup.py (path:/tmp/pip-u4Xmk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:08:07 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)) 15:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:08:07 INFO - Running setup.py (path:/tmp/pip-96Jav_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:08:07 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)) 15:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:08:07 INFO - Running setup.py (path:/tmp/pip-jRoKOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:08:07 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)) 15:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:08:07 INFO - Running setup.py (path:/tmp/pip-oHnBnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:08:07 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)) 15:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:08:07 INFO - Running setup.py (path:/tmp/pip-ZAnFF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:08:07 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)) 15:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:08:07 INFO - Running setup.py (path:/tmp/pip-hC8vjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:08:07 INFO - Running setup.py (path:/tmp/pip-_rW4_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:08:07 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)) 15:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:08:07 INFO - Running setup.py (path:/tmp/pip-WdCVLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:08:08 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)) 15:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:08:08 INFO - Running setup.py (path:/tmp/pip-jx9wlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:08:08 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)) 15:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:08:08 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)) 15:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:08:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:10 INFO - Downloading blessings-1.6.tar.gz 15:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:08:10 INFO - Installing collected packages: blessings 15:08:10 INFO - Running setup.py install for blessings 15:08:10 INFO - Successfully installed blessings 15:08:10 INFO - Cleaning up... 15:08:10 INFO - Return code: 0 15:08:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:08:10 INFO - Reading from file tmpfile_stdout 15:08:10 INFO - Current package versions: 15:08:10 INFO - argparse == 1.2.1 15:08:10 INFO - blessings == 1.6 15:08:10 INFO - blobuploader == 1.2.4 15:08:10 INFO - docopt == 0.6.1 15:08:10 INFO - functools32 == 3.2.3-2 15:08:10 INFO - jsonschema == 2.5.1 15:08:10 INFO - manifestparser == 1.1 15:08:10 INFO - mozInstall == 1.12 15:08:10 INFO - mozcrash == 1.0 15:08:10 INFO - mozdebug == 0.1 15:08:10 INFO - mozdevice == 0.49 15:08:10 INFO - mozfile == 1.2 15:08:10 INFO - mozhttpd == 0.7 15:08:10 INFO - mozinfo == 0.9 15:08:10 INFO - mozleak == 0.1 15:08:10 INFO - mozlog == 3.4 15:08:10 INFO - moznetwork == 0.27 15:08:10 INFO - mozprocess == 0.23 15:08:10 INFO - mozprofile == 0.28 15:08:10 INFO - mozrunner == 6.13 15:08:10 INFO - mozscreenshot == 0.1 15:08:10 INFO - mozsystemmonitor == 0.3 15:08:10 INFO - moztest == 0.7 15:08:10 INFO - mozversion == 1.4 15:08:10 INFO - psutil == 3.1.1 15:08:10 INFO - requests == 1.2.3 15:08:10 INFO - wsgiref == 0.1.2 15:08:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:08:10 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')]} 15:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:10 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')]} 15:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:10 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 0x7ffb7d68fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0fc0>, '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 0x17e1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e2350>, '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': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', '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 15:08:10 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 15:08:10 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 15:08:10 INFO - Using env: {'DISPLAY': ':0', 15:08:10 INFO - 'HOME': '/home/cltbld', 15:08:10 INFO - 'LANG': 'en_US.UTF-8', 15:08:10 INFO - 'LANGUAGE': 'en_US:en', 15:08:10 INFO - 'LOGNAME': 'cltbld', 15:08:10 INFO - 'MAIL': '/var/mail/cltbld', 15:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:10 INFO - 'MOZ_NO_REMOTE': '1', 15:08:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:10 INFO - 'NO_EM_RESTART': '1', 15:08:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:10 INFO - 'PWD': '/builds/slave/test', 15:08:10 INFO - 'SHELL': '/bin/bash', 15:08:10 INFO - 'SHLVL': '1', 15:08:10 INFO - 'TERM': 'linux', 15:08:10 INFO - 'TMOUT': '86400', 15:08:10 INFO - 'USER': 'cltbld', 15:08:10 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', 15:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:10 INFO - '_': '/tools/buildbot/bin/python'} 15:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:10 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)) 15:08:10 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)) 15:08:10 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)) 15:08:10 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)) 15:08:10 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)) 15:08:10 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)) 15:08:10 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)) 15:08:10 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)) 15:08:10 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)) 15:08:10 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)) 15:08:10 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)) 15:08:10 INFO - Cleaning up... 15:08:10 INFO - Return code: 0 15:08:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:08:10 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')]} 15:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:10 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')]} 15:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:10 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 0x7ffb7d68fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0fc0>, '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 0x17e1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e2350>, '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': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', '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 15:08:10 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 15:08:10 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 15:08:10 INFO - Using env: {'DISPLAY': ':0', 15:08:10 INFO - 'HOME': '/home/cltbld', 15:08:10 INFO - 'LANG': 'en_US.UTF-8', 15:08:10 INFO - 'LANGUAGE': 'en_US:en', 15:08:10 INFO - 'LOGNAME': 'cltbld', 15:08:10 INFO - 'MAIL': '/var/mail/cltbld', 15:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:10 INFO - 'MOZ_NO_REMOTE': '1', 15:08:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:10 INFO - 'NO_EM_RESTART': '1', 15:08:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:10 INFO - 'PWD': '/builds/slave/test', 15:08:10 INFO - 'SHELL': '/bin/bash', 15:08:10 INFO - 'SHLVL': '1', 15:08:10 INFO - 'TERM': 'linux', 15:08:10 INFO - 'TMOUT': '86400', 15:08:10 INFO - 'USER': 'cltbld', 15:08:10 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', 15:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:10 INFO - '_': '/tools/buildbot/bin/python'} 15:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:08:11 INFO - Cleaning up... 15:08:11 INFO - Return code: 0 15:08:11 INFO - Running post-action listener: _resource_record_post_action 15:08:11 INFO - Running post-action listener: _start_resource_monitoring 15:08:11 INFO - Starting resource monitoring. 15:08:11 INFO - [mozharness: 2016-11-29 23:08:11.072487Z] Finished create-virtualenv step (success) 15:08:11 INFO - [mozharness: 2016-11-29 23:08:11.072962Z] Running install step. 15:08:11 INFO - Running pre-action listener: _resource_record_pre_action 15:08:11 INFO - Running main action method: install 15:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:08:11 INFO - Reading from file tmpfile_stdout 15:08:11 INFO - Detecting whether we're running mozinstall >=1.0... 15:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:08:11 INFO - Reading from file tmpfile_stdout 15:08:11 INFO - Output received: 15:08:11 INFO - Usage: mozinstall [options] installer 15:08:11 INFO - Options: 15:08:11 INFO - -h, --help show this help message and exit 15:08:11 INFO - -d DEST, --destination=DEST 15:08:11 INFO - Directory to install application into. [default: 15:08:11 INFO - "/builds/slave/test"] 15:08:11 INFO - --app=APP Application being installed. [default: firefox] 15:08:11 INFO - mkdir: /builds/slave/test/build/application 15:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:08:28 INFO - Reading from file tmpfile_stdout 15:08:28 INFO - Output received: 15:08:28 INFO - /builds/slave/test/build/application/firefox/firefox 15:08:28 INFO - Running post-action listener: _resource_record_post_action 15:08:28 INFO - [mozharness: 2016-11-29 23:08:28.337517Z] Finished install step (success) 15:08:28 INFO - [mozharness: 2016-11-29 23:08:28.337785Z] Running run-tests step. 15:08:28 INFO - Running pre-action listener: _resource_record_pre_action 15:08:28 INFO - Running main action method: run_tests 15:08:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:08:28 INFO - Python 2.7.3 15:08:28 INFO - Return code: 0 15:08:28 INFO - grabbing minidump binary from tooltool 15:08: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')]} 15:08:28 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 0x17e0fc0>, '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 0x17e1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e2350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:08:28 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 15:08:28 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 15:08:28 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 15:08:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:08:28 INFO - Return code: 0 15:08:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:08:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:08:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:08:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:08:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:08:28 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:08:28 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:08:28 INFO - Using env: {'DISPLAY': ':0', 15:08:28 INFO - 'HOME': '/home/cltbld', 15:08:28 INFO - 'LANG': 'en_US.UTF-8', 15:08:28 INFO - 'LANGUAGE': 'en_US:en', 15:08:28 INFO - 'LOGNAME': 'cltbld', 15:08:28 INFO - 'MAIL': '/var/mail/cltbld', 15:08:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:08:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:28 INFO - 'MOZ_NO_REMOTE': '1', 15:08:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:08:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:28 INFO - 'NO_EM_RESTART': '1', 15:08:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:28 INFO - 'PWD': '/builds/slave/test', 15:08:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:08:28 INFO - 'SHELL': '/bin/bash', 15:08:28 INFO - 'SHLVL': '1', 15:08:28 INFO - 'TERM': 'linux', 15:08:28 INFO - 'TMOUT': '86400', 15:08:28 INFO - 'USER': 'cltbld', 15:08:28 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250', 15:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:28 INFO - '_': '/tools/buildbot/bin/python'} 15:08:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:08:28 INFO - mozversion application_buildid: 20161129121152 15:08:28 INFO - mozversion application_changeset: d254eb61360d3c20172eb7aba1154e2779850263 15:08:28 INFO - mozversion application_display_name: Nightly 15:08:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:08:28 INFO - mozversion application_name: Firefox 15:08:28 INFO - mozversion application_remotingname: firefox 15:08:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:08:28 INFO - mozversion application_vendor: Mozilla 15:08:28 INFO - mozversion application_version: 53.0a1 15:08:28 INFO - mozversion platform_buildid: 20161129121152 15:08:28 INFO - mozversion platform_changeset: d254eb61360d3c20172eb7aba1154e2779850263 15:08:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:08:28 INFO - mozversion platform_version: 53.0a1 15:08:28 INFO - using testdate: 1480460908 15:08:28 INFO - actual date: 1480460908 15:08:28 INFO - starting webserver on 'localhost:47295' 15:08:28 INFO - SUITE-START | Running 2 tests 15:08:28 INFO - TEST-START | dromaeo_css 15:08:28 INFO - operating with platform_type : linux_ 15:08:28 INFO - Initialising browser for dromaeo_css test... 15:08:28 INFO - TEST-INFO | started process 17543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMursCe/profile http://localhost:47295/getInfo.html) 15:08:33 INFO - PROCESS | 17543 | __metrics Screen width/height:1600/1200 15:08:33 INFO - PROCESS | 17543 | colorDepth:24 15:08:33 INFO - PROCESS | 17543 | Browser inner width/height: 1024/697 15:08:33 INFO - PROCESS | 17543 | __metrics 15:08:34 ERROR - PROCESS | 17543 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 15:08:35 INFO - TEST-INFO | 17543: exit 0 15:08:35 INFO - Browser initialized. 15:08:35 INFO - Running cycle 1/1 for dromaeo_css test... 15:08:35 INFO - TEST-INFO | started process 17666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMursCe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:08:47 INFO - PROCESS | 17666 | RSS: Main: 186523648 15:08:47 INFO - PROCESS | 17666 | 15:09:37 INFO - PROCESS | 17666 | 1480460977612 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] 15:11:49 INFO - PROCESS | 17666 | Cycle 1(1): loaded http://localhost:47295/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47295/tests/dromaeo/cssquery-ext.html) 15:11:50 INFO - PROCESS | 17666 | RSS: Main: 198541312 15:11:50 INFO - PROCESS | 17666 | 15:14:53 INFO - PROCESS | 17666 | Cycle 1(1): loaded http://localhost:47295/tests/dromaeo/cssquery-ext.html (next: http://localhost:47295/tests/dromaeo/cssquery-jquery.html) 15:14:54 INFO - PROCESS | 17666 | RSS: Main: 197210112 15:14:54 INFO - PROCESS | 17666 | 15:17:56 INFO - PROCESS | 17666 | Cycle 1(1): loaded http://localhost:47295/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47295/tests/dromaeo/cssquery-mootools.html) 15:17:56 INFO - PROCESS | 17666 | RSS: Main: 199528448 15:17:56 INFO - PROCESS | 17666 | 15:20:58 INFO - PROCESS | 17666 | Cycle 1(1): loaded http://localhost:47295/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47295/tests/dromaeo/cssquery-prototype.html) 15:20:59 INFO - PROCESS | 17666 | RSS: Main: 195964928 15:20:59 INFO - PROCESS | 17666 | 15:24:01 INFO - PROCESS | 17666 | Cycle 1(1): loaded http://localhost:47295/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47295/tests/dromaeo/cssquery-yui.html) 15:24:02 INFO - PROCESS | 17666 | RSS: Main: 199909376 15:24:02 INFO - PROCESS | 17666 | 15:27:05 INFO - PROCESS | 17666 | Cycle 1(1): loaded http://localhost:47295/tests/dromaeo/cssquery-yui.html (next: http://localhost:47295/tests/dromaeo/cssquery-dojo.html) 15:27:05 INFO - PROCESS | 17666 | RSS: Main: 199675904 15:27:05 INFO - PROCESS | 17666 | 15:27:05 INFO - PROCESS | 17666 | __start_tp_report 15:27:05 INFO - PROCESS | 17666 | _x_x_mozilla_page_load 15:27:05 INFO - PROCESS | 17666 | _x_x_mozilla_page_load_details 15:27:05 INFO - PROCESS | 17666 | |i|pagename|runs| 15:27:05 INFO - PROCESS | 17666 | |0;dojo.html;3138.6547479777228;3149.5118256670225;3154.921126971824;3157.289609837787;3184.697453741895;5360.437154098822;5447.237386765856;5454.045542030144;5479.534239589635;5505.311836020497;5394.083005888999;5409.864753381167;5484.698341591211;5496.983058134248;5546.389897111325;4882.536159064901;4978.5270399312;4979.153543897528;5027.346444962168;5042.445331013586;4921.2618107284015;5056.469070747574;5090.643654944155;5119.436861945183;5144.717040562768;4924.876878078041;5035.144025515671;5046.697198168122;5100.362454693163;5102.081625307444;4943.802247910079;4963.305137280748;5005.849824505271;5018.623603229736;5025.522575355372;4957.603391728653;4976.850694479172;5041.9747901260625;5049.949500504985;5063.291139240509;5413.512783849473;5472.288602481652;5474.206240095204;5486.945130548684;5506.504414602705;5699.088145896678;5898.085796701518;5900.822975310747;5905.055191169392;5946.732397042144;5832.387599302097;5901.940980590182;5927.911081333784;5932.762689492458;5976.910346344808;5597.384287728347;5605.775768969277;5606.439356064402;5625.240592519998;5640.576956728261;6087.878242435127;6098.298695650057;6136.938630613726;6138.570300078952;6161.106639537242;5661.377248502661;5704.030314846486;5855.824325270249;5907.172995780594;5912.408759124053;5800.970995145081;5809.651420914759;5810.157527158538;5912.142739302863;5928;5638.182463542763;5706.857328566819;5823.505002074871;5856.648601083949;5857.589968702235;5870.853228669232;5876.030454974967;5913.615614985099;5918.674472904032;5923.703814809242;4490.50604433512;4517.119161763425;4545.250033744395;4546.65900057497;4575.954240457553;3935.58676338986;3948.881533553998;3974.682025437958;3992.3811809169624;4056.756594604274;5516.365617953907;5539;5544.390117087117;5547.11246200614;5583.944160558423;5818.650880947157;5823.883522329615;5833.591648584558;5834.241548598655;5834.649921004753;5528.44715528452;5536.584756143306;5550.69471179089;5595.944040559623;5596.468335508121;5091.134507133796;5096.61775366849;5128.564072053842;5139.511746384088;5148.892988007597;6072.848178795565;6073.939260607337;6089.817305480843;6173.290071641639;6186.566940314135;5965.761369545169;5970.0746384310505;5977.103434484862;5991.041433370639;6023.247094113236;5935.40645935403;6112;6112.899678057992;6120.663363515049;6169.660668663267;5727.828165155052;5735.426457354231;5760.567957403296;5783.392743761844;5874.295084589877;5936.347001829881;5939.406059394026;5939.970300148471;5940.524758019435;5949.25634295713;5768.134779783066;5824.475797178275;5832.445917637818;5834.504067154339;5842.065269556851;5679.8864022720145;5743.224664670383;5751.482366587027;5798.94201057984;5818.854528636818;5664.178694089252;5693.829185124453;5706.4864162225595;5758.366579676316;5785.161151633074;5820.970895145497;5825.3883342248455;5826.7086645666695;5827.854303642443;5872.1778950947755;5640.605157638925;5668.433156684298;5679.204911312337;5690.174924635988;5696.430356964271 15:27:05 INFO - PROCESS | 17666 | |1;ext.html;566.1762136091986;589.2192844481061;594.7620951619351;594.8334466349423;596.8388535095521;38068.23863522728;40022.59977400229;40040.79979600102;43083.78458107713;43114.35328470075;42850.785746071226;43271.350929736;43279.78360108203;43326.35010474837;43399.13201735963;8561.0582835888;8592.269657079156;8698;8702.695405660803;10103.292769506137;10089.344192627455;10362.896371036306;10368.896311036868;10393.376397416141;10405.167586593054;10271.948640256789;10275.537600807944;10321.277510574262;10434.113100386476;10437.530311135979;10334.7416314592;10390.376577405343;10432.947835260775;10444.738881527946;10453.895461045367;10160.288779785418;10267.127294180003;10307.79384412315;10312.226583006304;10330.690079297634;41327;41451.37822932658;41509.37735933963;41544.37683434751;41548;3355.664612719871;3739.719521035933;3883.3010058189516;3908.472356231901;4027.9597204027878;30664.693353066406;30714.53928191079;30723.539146912815;30913.69086309153;32360.676393236;4065.7560546367017;4141.689373296985;4175.164967006611;4322.935155972663;4334.826606935719;346191;347653;348123;350024.2498787515;350070;58218.417815821296;58550.41449585535;58981;59004;59064.7046764772;61019.389806102256;61408;61415.38584614186;61494.38505614976;61791.382086178564;17102.743458848126;17384.130793460277;17400.47798566045;17503.212355443782;17516.82483175152;12277.631671049883;12445.75108497825;12858.935705321413;13102.934485327512;13286.136401133896;18618.53453663642;18699.34552290663;18772.71840922387;18854.3400980965;19090;6826.24911259761;6833.296028252441;7129.89305160423;7169.96415017932;7204.819879503054;915.4370062411568;928.4150984879483;1053.6101642392211;1144.9942750286195;1157.7106819234716;30447.543286850716;34181.31637367288;34221.82889085588;35827.4625880612;36526.45210321794;1113.8106521891298;1164.2956011612853;1178.3813497913663;1230.0958795285458;1234.4818660587162;15163.848361516464;16800.582919853536;16830.410935617194;16856.57858553546;16912.408065717886;460623;468304;471196;472784;475716;53831.46168538343;54543.72728136334;54866;54909.1763623546;55300.72349638226;1383.9861601383857;1390.1242217402971;1414.4766436418386;1415.242845077899;1426.1015560197009;29291.85354073216;30647.467626618134;30861.845690771403;31170.376592468478;31479.527807082453;49928.251076234614;50524;50554.241686374;50634;50690.239646404596;433648;434125;436256;436369;437424;40088.59911400965;40951;41006.79496602498;41066.384004239364;41542.58457415508;45272.54727452815;45438.54561454343;46276.30585541152;47101.7644911787;47164;38209.2358152841;38991.610083899934;39320.09866327171;40328.7983560092;40740.796296019515;39111.804440978754;39921;40198.99405213449;40466.59533404628;40860.38709419421;38798.76216710708;39698.759041938916;39859.80070099747;40614.39078413767;41041.17917641571;33105.83447082749;35429.46855797217;35925.28149437049;36127.45808812817;36265.63734362623;27350.5897411535;27352.589711154746;27455.313617159733;27476.17571472859;27756.861215693792 15:27:05 INFO - PROCESS | 17666 | |2;jquery.html;387.4749714137342;388.355330151948;406.9287874621941;408.96523795477384;415.98960025999344;17603.911980440094;18970;19318;19452.319168829094;19743.5064123397;19153.23387064516;19448.4165475036;19806.603867922633;19923;20088.196472141095;5508.256385387971;5560.193771903072;5651.491365777079;5686.829395118153;5687.4312568743;5548.167774833767;5604.2154098426045;5609.943900561003;5620.971895140518;5667.716614169275;5618.185363122345;5660.150977353389;5922.230110085704;5924.703764811764;6023.006203976361;5803.738831752581;5948.196993405878;5957.85105372367;5967.940320596782;5984.192134061911;5740.684262365568;5789.2763404574425;5789.88420231593;5794.5943783935145;5794.5943783935145;13922.37349319273;14126.576202713832;22340.776592234033;22490.10039598414;22579.209727659618;2348.1429278313294;2355.552445035438;2446.192756390387;2458.4714286428502;2858.7284208000415;10130.189584833195;10348;10379.636712715093;10944.835827462515;10975.341479511255;1765.885217460861;1778.413123669186;1882.2282864025683;1913.9951525449112;1991.074150520015;81161;84544.99999999939;84845;85025;87561.56219218927;10911.727206819734;11004.39475828837;11110.944445277722;11163.162762792823;11507.482163302671;15716.528504144893;15795.21023948798;15885.602859928595;15935.12356820386;16004.279807408695;7595;7848.372130229568;7861.764147075597;7879.0939042010905;8097.473664211808;7400.851982960311;7426.777196684108;7443.144038435649;7593.772186834404;7671.309582137523;4749.121412538622;4813.687110337817;4833.202521583969;4840.128776820206;4942.946783637454;1954.79474655162;1973.4770285874256;1979.7228388025687;1993.9700904486444;2008.5581172142106;838.5220424358057;908.922741566961;959.9568019439142;983.1839573154265;1008.4151192308443;18041.458756237334;18524.44426667175;19566.70649940252;19994.500137496678;20291.797082029287;935.4761333653177;939.2767568971854;963.5856581669949;986.1519093579516;1000.3697670467704;10506.212034097472;10917.434845800137;11071.114310855111;11138.888611113947;11148.219624626197;431495;436181;436792;443249;444680;88585;91581;91667.5416622926;92930.53534732418;92987;996.352370958868;1007.8135544924213;1016.1718199667248;1032.7160030991388;1047.858539097212;16510.504684859472;16934.49196524106;17275.222614982104;17579.384721534683;17950.281988720304;40633.79683101566;41952.790236048626;42047.36928946007;42282.57717422787;42352;51560.22659660033;56096.439035610754;56291.43708562862;57515.42484575268;57855.421445785;8345.374096942875;8447.788805279917;8504.149585041694;8591.570421478777;8702.956485217534;11606.70983225426;12942.741145177231;12969.351532423152;12993.675158121123;13116.278604676834;11211.71970700739;11337.489812958602;12078.33569153705;12081.335526546125;12091.334976576372;11067.833982490109;11083.224174307721;11139.33164010162;11200.607978720705;11978.520859165536;11394.715132121763;11617.593384231512;11813.586524471602;11931.4034298283;12427.813582796447;8508.106648802035;8649.610767515604;8680.218780309802;8861.778455538406;8893.06622804622;11274.436278185894;11456.427178641201;11734.471948762497;11744.530218791495;11804.527818887493 15:27:05 INFO - PROCESS | 17666 | |3;mootools.html;1408.4014293925081;1433.6917562724016;1512.3874830693574;1663.542525805404;1692.8137904830473;7184.3174898384705;7336.266373362661;7904.6442910069045;8362.623681934312;8367.49795012299;7936.365090792737;8200.138985406536;8200.548969806658;8400.579971001456;8416.705415310465;2261.310300358394;2298.092253559843;2305.170138750057;2305.8385912986096;2307.711536057993;2325.988370058147;2333.53329334133;2372.6678265042906;2395.8562486250794;2396.8322217444784;2259.423846919033;2262.4117729390396;2289.347535952254;2302.251768175341;2304.850184737995;2229.6432570788756;2257.480779420734;2263.343630347197;2266.8639881607155;2289.9084036638596;2296.2651951375565;2303.5968705476644;2311.4914718761847;2338.216697406354;2339.181286549711;8274.379421543408;8293.543855087968;8303.211194936472;8389.538575378352;8437.95781021091;5096.082705113078;5197.142471492237;5217.608679349064;5232.790688372461;5241.606879484016;3112.688731126892;3144.3082521845386;3404.114930118162;3411.710004649608;3414.5219669246326;1006.9395836249848;1026.4611079183414;1061.8194906865851;1066.3015724700333;1086.3264775838952;11512.712182195428;11608.767824643544;11693.532258709727;11703.122265830012;11735.23720958135;4389.990302230505;4638.768061596907;4706.987997580468;4771.498992605796;4774.809007639725;9677;9741.853872191923;9753.804923901482;9774.631551582785;9784;5223.973880130651;5235.110031294689;5242.475752424727;5247.973760131251;5281.577473802086;4713.481517033124;4863.562279394871;4882.414110306715;4924.507549245119;4969.577585905238;3629.7840223525413;3668.761530500509;3703;3761.887143385703;3781.9243615127543;1154.18629865946;1165.2833507392893;1175.6649354933802;1176.917615766888;1186.6084192216547;826.01703972274;860.4020205956925;900.9729708108767;913.2555484722249;927.3832901120815;5245.501677340647;5285.656432331886;5396.163594642837;5451.373092094381;5469.507744303032;430.03457238499146;433.65741064559273;440.43184292262623;446.4999200895018;457.3163121133926;3631.4008188649104;3632.219072899339;3650.653187947141;3652.141746689526;3722.5346831646043;10009.449480278508;10127;10436.478176091165;10474.790504189874;10499.475026248658;10382.117520010883;10422.530986105643;10474.057334839748;10556.736081597868;10558.208134389952;7837.451378403457;7840.215978402228;7872.094709108412;7944.880826787603;7957.482763620231;5384.488473595002;5394.622376433612;5421.430749771217;5529.419410961791;5651.265335506358;9359.532023398666;9407.85888211691;9412.529373531434;9547.283953703361;9567.61729530811;9136.771580710536;9313.44119352841;9394.154526092685;9472.810543788948;9642.855357169788;7225.385842203472;7476.70093196266;7498;7555.848883022419;7671.654775535003;8274.917250827655;8320.916790832014;8324.625391857502;8331.291840193651;8338.207870252316;7184.209736928829;7232.349088582053;7327.523710958771;7374.188839227788;7579.204183560647;7235;7284.38082762971;7295.343419092307;7433.553986760596;7493.288137626917;6687;6749.966250168718;6750.426213771884;6762.087118239171;6783.152105986752;4588.954110458986;4678.906421871611;4706.788194531323;4934.333864928189;4982.451930287738;4779.928301075417;4814.061258054646;4890.55984961341;4953.950460495349;5008.899822003466 15:27:05 INFO - PROCESS | 17666 | |4;prototype.html;327.4772308764246;340.39070064584394;349.28048220665414;349.6486031538304;351.69578314757734;5422.421202006676;5424.887897980914;5439.5920305977015;5534.114541673333;5534.335879694432;5375.3280839895015;5396.730163491829;5416.945830541694;5437.238786569884;5500.0299838087385;4320.0063985283405;4326.242907491192;4331.155424692186;4345.565443455653;4358.302671572549;3904.97364542479;4166.500019997605;4245.681573881971;4250.404943307939;4270.188664153801;4218.493780746315;4222.725522841021;4223.97888010561;4234.597713217239;4245.936310955338;4243.830246790125;4272.743635381871;4273.358996150571;4300.182965236595;4312.28847240205;3722.4788529605876;3727.5713292971386;3759.2105657811617;3812.618738126165;3814.389697648363;5313.804394011355;5332.146856502941;5339.813106541253;5344.465553444663;5382.757775900094;4897.216445368759;4906.533879281463;4910.852674419737;4914.827981020683;4941.505849415065;5412.431694672042;5615.596100974756;5695.914561281584;5745.2818397700285;5791.942080579182;4061.7969101544804;4077.368007958771;4077.7961101944784;4148.854790082363;4148.92128046707;5788.466056495032;5814.133601155185;5981.910271345933;5986.880262394728;6000.75996960121;4146.315857883415;4156.711419459916;4162.542120366757;4168.166366726667;4186.099988502426;4212.178625168124;4239.703220774516;4251.893702657397;4278.465191851019;4285.807138678767;4616.991608650248;4801.351817504662;4828.465055845709;4834.516548345207;4857.4171099467585;5705.343885453143;5737.196792449061;5740.368559458456;5751.245870009687;5761.135829625506;1408.485902645527;1415.4550498058322;1422.8363738170035;1436.6695659998259;1441.8269807623153;948.7153853843819;983.6114734679761;992.846108853129;994.418265314799;994.4778991029767;5251.398323511366;5278.577713782888;5301.867453313698;5389.973050134724;5394.62237643369;5716.657000579895;5759.452851979056;5765.394633563499;5794.942050579524;5799.94200057994;5238.423773384925;5297.496737809902;5344.225087362311;5560.694161821058;5561.610687251934;3031.9545206821917;3037.331787006855;3046.6496352919253;3060.3420264642764;3062.6111632926354;5629.971850140723;5885.028970219952;5937.762489500372;5962.970185149046;5998.86021655884;5751.59738818287;5756.42435756421;5760.95486102436;5834.737436815269;5839.445252700986;5745.425457454221;5841.349156777014;5879.412058794172;5886.823395298148;5920.703964801656;5606.131049687305;5704.229928959703;5717.5425965921795;5854.590178687451;5897.557683173865;5839.649621022582;5867.647941123546;5898.761260135419;5907.645541267538;5955.91066134017;5892.026171232685;6105.175801266772;6107.457674548662;6108.267007959073;6154.846128846635;4187.341038440673;4233.724807887601;4237.813412244576;4240.872773816791;4249.745015299092;5651.717414129359;5928.703564821655;5938.2280303560265;6017.578769486094;6035;5733.082706766897;5760.683162426107;5792.82621521355;5803.622764520462;5808.82573522795;5784;5793.391693872083;5795.565332600157;5832.600175957825;5842.38654941242;5464.672119672832;5702.800401985911;5736.541076713769;5737.483626473638;5797.362290148165;5724.627899186539;5773.971130144322;5807.448292412214;5831.446012628793;5856.707164641665;5533.039823694304;5634.718264086861;5649.802256920988;5710.2576665033275;5725.425507985337 15:27:05 INFO - PROCESS | 17666 | |5;yui.html;780.8204113053997;789.1201310538751;801.4389927051066;820.671731307477;832.8001279692876;14569.781453278196;16418.83581164188;16422.50732478026;16698.916505417485;16712.83287167128;14686.192259425727;14981;15000;15053.247337633102;15208.69582608347;798.5687728626534;809.7287408718087;812.358236992775;812.4800127918137;813.8860559521672;787.4645241235958;800.1118758178417;809.9190080991913;811.1766556944706;811.6834434570522;858.4505916213598;867.3408209760596;870.0038455967913;870.0951010948637;871.1984973824098;852.9402941794077;857.536930057768;861.0184389795606;861.0399404663817;861.8017855893117;623.1618473153601;630.2468550082654;630.486153784664;631.4916492223758;631.9115323854664;16145.596360090974;16203.1088290144;16249.350025998945;16508.75236871448;16525.504234872853;14637;15063.849361506354;15074.472393466285;15116;15132.546023619308;11058.22592418531;11211.495482703216;11252.54989800407;11590.478428470738;11973;4347.217500849846;4366.912661746779;4370.497392799805;4374.475062992461;4382.758948257844;78747.21252787457;79302;80564.19435805625;81063.9999999994;81382;10941.945290273658;10966.396848173426;11062.668119956414;11190.608328708457;11541.942290288494;20027.499312517302;20089.799102009085;20097.497562561053;20115.597688046157;20118.19527218924;7992.800179995546;8003.4797738146835;8130.471519351341;8247.381446391424;8400.453970491899;4386.166628340605;4639.257718765049;4682.765861706901;4736.95263047372;4787.760611969387;3536.5225694531423;3573.446115852047;3632.473291372789;3651.2879988402005;3655.5430571178604;602.704674709398;612.7579606055583;615.1265203411167;619.0497586205154;636.3413866647998;534.5322842512801;652.3997921911853;655.4657953767664;673.2123415603755;675.9932400676029;8902.688405905763;9095.909040909639;9288.303377246733;9296.953515232515;9622.9037709622;565.9527943919155;579.9130130480378;607.1560530862105;655.9212894452696;699.4474365251394;3928.5482169550296;4182.477190351206;4259.339802330644;4262.296721041055;4286.657067434598;65077.349226507125;66134.66932665306;68384.6580767093;86118.56940715382;88021.5598922014;71807;72361;72545.63727181435;72624;73177;66502.33497665059;68077;68277.65861170762;68480.99999999901;69868;8457.492550446992;8545.529995850287;8635.95682021611;8636.309095272489;8644.394892357475;46255.53744462647;46980.7650961743;47017;47369;48644.756776215894;50532.24201637052;52365;53247.20129198143;56088.43911560995;56732;12908.677283067998;13228.07403481747;13257.270850103338;13377.598672039854;13384.19694818314;14460.493882714054;14549.709005819612;14554.41782328695;14907.850921490646;14953.626159346104;13702;13974.371153298329;14145.080569762933;14427.639309017359;14470;13798.586042418743;14054.426455390925;14370.640733981734;14845.628859278604;14992.550223493312;12444.68888277764;12500.187487813264;12852.164609300366;13079.869201307865;13180.783956425661;10407.375557466576;10788.946055269673;11258.66224013281;11341.716457088638;11794.410279486163;10860.185486088732;11397.601083962021;11399.202055856342;11908;12040.518379265082 15:27:05 INFO - PROCESS | 17666 | __end_tp_report 15:27:05 INFO - PROCESS | 17666 | __start_cc_report 15:27:05 INFO - PROCESS | 17666 | _x_x_mozilla_cycle_collect,328 15:27:05 INFO - PROCESS | 17666 | __end_cc_report 15:27:05 INFO - PROCESS | 17666 | __startTimestamp1480462025890__endTimestamp 15:27:05 INFO - PROCESS | 17666 | 15:27:05 INFO - PROCESS | 17666 | ------- Summary: start ------- 15:27:05 INFO - PROCESS | 17666 | Number of tests: 6 15:27:05 INFO - PROCESS | 17666 | 15:27:05 INFO - PROCESS | 17666 | [#0] dojo.html Cycles:165 Average:5478.83 Median:5690.17 stddev:629.00 (11.1%) stddev-sans-first:603.54 15:27:05 INFO - PROCESS | 17666 | Values: 3138.7 3149.5 3154.9 3157.3 3184.7 5360.4 5447.2 5454.0 5479.5 5505.3 5394.1 5409.9 5484.7 5497.0 5546.4 4882.5 4978.5 4979.2 5027.3 5042.4 4921.3 5056.5 5090.6 5119.4 5144.7 4924.9 5035.1 5046.7 5100.4 5102.1 4943.8 4963.3 5005.8 5018.6 5025.5 4957.6 4976.9 5042.0 5049.9 5063.3 5413.5 5472.3 5474.2 5486.9 5506.5 5699.1 5898.1 5900.8 5905.1 5946.7 5832.4 5901.9 5927.9 5932.8 5976.9 5597.4 5605.8 5606.4 5625.2 5640.6 6087.9 6098.3 6136.9 6138.6 6161.1 5661.4 5704.0 5855.8 5907.2 5912.4 5801.0 5809.7 5810.2 5912.1 5928.0 5638.2 5706.9 5823.5 5856.6 5857.6 5870.9 5876.0 5913.6 5918.7 5923.7 4490.5 4517.1 4545.3 4546.7 4576.0 3935.6 3948.9 3974.7 3992.4 4056.8 5516.4 5539.0 5544.4 5547.1 5583.9 5818.7 5823.9 5833.6 5834.2 5834.6 5528.4 5536.6 5550.7 5595.9 5596.5 5091.1 5096.6 5128.6 5139.5 5148.9 6072.8 6073.9 6089.8 6173.3 6186.6 5965.8 5970.1 5977.1 5991.0 6023.2 5935.4 6112.0 6112.9 6120.7 6169.7 5727.8 5735.4 5760.6 5783.4 5874.3 5936.3 5939.4 5940.0 5940.5 5949.3 5768.1 5824.5 5832.4 5834.5 5842.1 5679.9 5743.2 5751.5 5798.9 5818.9 5664.2 5693.8 5706.5 5758.4 5785.2 5821.0 5825.4 5826.7 5827.9 5872.2 5640.6 5668.4 5679.2 5690.2 5696.4 15:27:05 INFO - PROCESS | 17666 | 15:27:05 INFO - PROCESS | 17666 | [#1] ext.html Cycles:180 Average:58480.91 Median:21450.04 stddev:111120.99 (518.0%) stddev-sans-first:111347.64 15:27:05 INFO - PROCESS | 17666 | Values: 566.2 589.2 594.8 594.8 596.8 38068.2 40022.6 40040.8 43083.8 43114.4 42850.8 43271.4 43279.8 43326.4 43399.1 8561.1 8592.3 8698.0 8702.7 10103.3 10089.3 10362.9 10368.9 10393.4 10405.2 10271.9 10275.5 10321.3 10434.1 10437.5 10334.7 10390.4 10432.9 10444.7 10453.9 10160.3 10267.1 10307.8 10312.2 10330.7 41327.0 41451.4 41509.4 41544.4 41548.0 3355.7 3739.7 3883.3 3908.5 4028.0 30664.7 30714.5 30723.5 30913.7 32360.7 4065.8 4141.7 4175.2 4322.9 4334.8 346191.0 347653.0 348123.0 350024.2 350070.0 58218.4 58550.4 58981.0 59004.0 59064.7 61019.4 61408.0 61415.4 61494.4 61791.4 17102.7 17384.1 17400.5 17503.2 17516.8 12277.6 12445.8 12858.9 13102.9 13286.1 18618.5 18699.3 18772.7 18854.3 19090.0 6826.2 6833.3 7129.9 7170.0 7204.8 915.4 928.4 1053.6 1145.0 1157.7 30447.5 34181.3 34221.8 35827.5 36526.5 1113.8 1164.3 1178.4 1230.1 1234.5 15163.8 16800.6 16830.4 16856.6 16912.4 460623.0 468304.0 471196.0 472784.0 475716.0 53831.5 54543.7 54866.0 54909.2 55300.7 1384.0 1390.1 1414.5 1415.2 1426.1 29291.9 30647.5 30861.8 31170.4 31479.5 49928.3 50524.0 50554.2 50634.0 50690.2 433648.0 434125.0 436256.0 436369.0 437424.0 40088.6 40951.0 41006.8 41066.4 41542.6 45272.5 45438.5 46276.3 47101.8 47164.0 38209.2 38991.6 39320.1 40328.8 40740.8 39111.8 39921.0 40199.0 40466.6 40860.4 38798.8 39698.8 39859.8 40614.4 41041.2 33105.8 35429.5 35925.3 36127.5 36265.6 27350.6 27352.6 27455.3 27476.2 27756.9 15:27:05 INFO - PROCESS | 17666 | 15:27:05 INFO - PROCESS | 17666 | [#2] jquery.html Cycles:180 Average:27508.82 Median:1623.10 stddev:72670.24 (4477.2%) stddev-sans-first:72845.56 15:27:05 INFO - PROCESS | 17666 | Values: 387.5 388.4 406.9 409.0 416.0 17603.9 18970.0 19318.0 19452.3 19743.5 19153.2 19448.4 19806.6 19923.0 20088.2 5508.3 5560.2 5651.5 5686.8 5687.4 5548.2 5604.2 5609.9 5621.0 5667.7 5618.2 5660.2 5922.2 5924.7 6023.0 5803.7 5948.2 5957.9 5967.9 5984.2 5740.7 5789.3 5789.9 5794.6 5794.6 13922.4 14126.6 22340.8 22490.1 22579.2 2348.1 2355.6 2446.2 2458.5 2858.7 10130.2 10348.0 10379.6 10944.8 10975.3 1765.9 1778.4 1882.2 1914.0 1991.1 81161.0 84545.0 84845.0 85025.0 87561.6 10911.7 11004.4 11110.9 11163.2 11507.5 15716.5 15795.2 15885.6 15935.1 16004.3 7595.0 7848.4 7861.8 7879.1 8097.5 7400.9 7426.8 7443.1 7593.8 7671.3 4749.1 4813.7 4833.2 4840.1 4942.9 1954.8 1973.5 1979.7 1994.0 2008.6 838.5 908.9 960.0 983.2 1008.4 18041.5 18524.4 19566.7 19994.5 20291.8 935.5 939.3 963.6 986.2 1000.4 10506.2 10917.4 11071.1 11138.9 11148.2 431495.0 436181.0 436792.0 443249.0 444680.0 88585.0 91581.0 91667.5 92930.5 92987.0 996.4 1007.8 1016.2 1032.7 1047.9 16510.5 16934.5 17275.2 17579.4 17950.3 40633.8 41952.8 42047.4 42282.6 42352.0 51560.2 56096.4 56291.4 57515.4 57855.4 8345.4 8447.8 8504.1 8591.6 8703.0 11606.7 12942.7 12969.4 12993.7 13116.3 11211.7 11337.5 12078.3 12081.3 12091.3 11067.8 11083.2 11139.3 11200.6 11978.5 11394.7 11617.6 11813.6 11931.4 12427.8 8508.1 8649.6 8680.2 8861.8 8893.1 11274.4 11456.4 11734.5 11744.5 11804.5 15:27:05 INFO - PROCESS | 17666 | 15:27:05 INFO - PROCESS | 17666 | [#3] mootools.html Cycles:180 Average:5509.12 Median:4944.14 stddev:3116.99 (63.0%) stddev-sans-first:3110.50 15:27:05 INFO - PROCESS | 17666 | Values: 1408.4 1433.7 1512.4 1663.5 1692.8 7184.3 7336.3 7904.6 8362.6 8367.5 7936.4 8200.1 8200.5 8400.6 8416.7 2261.3 2298.1 2305.2 2305.8 2307.7 2326.0 2333.5 2372.7 2395.9 2396.8 2259.4 2262.4 2289.3 2302.3 2304.9 2229.6 2257.5 2263.3 2266.9 2289.9 2296.3 2303.6 2311.5 2338.2 2339.2 8274.4 8293.5 8303.2 8389.5 8438.0 5096.1 5197.1 5217.6 5232.8 5241.6 3112.7 3144.3 3404.1 3411.7 3414.5 1006.9 1026.5 1061.8 1066.3 1086.3 11512.7 11608.8 11693.5 11703.1 11735.2 4390.0 4638.8 4707.0 4771.5 4774.8 9677.0 9741.9 9753.8 9774.6 9784.0 5224.0 5235.1 5242.5 5248.0 5281.6 4713.5 4863.6 4882.4 4924.5 4969.6 3629.8 3668.8 3703.0 3761.9 3781.9 1154.2 1165.3 1175.7 1176.9 1186.6 826.0 860.4 901.0 913.3 927.4 5245.5 5285.7 5396.2 5451.4 5469.5 430.0 433.7 440.4 446.5 457.3 3631.4 3632.2 3650.7 3652.1 3722.5 10009.4 10127.0 10436.5 10474.8 10499.5 10382.1 10422.5 10474.1 10556.7 10558.2 7837.5 7840.2 7872.1 7944.9 7957.5 5384.5 5394.6 5421.4 5529.4 5651.3 9359.5 9407.9 9412.5 9547.3 9567.6 9136.8 9313.4 9394.2 9472.8 9642.9 7225.4 7476.7 7498.0 7555.8 7671.7 8274.9 8320.9 8324.6 8331.3 8338.2 7184.2 7232.3 7327.5 7374.2 7579.2 7235.0 7284.4 7295.3 7433.6 7493.3 6687.0 6750.0 6750.4 6762.1 6783.2 4589.0 4678.9 4706.8 4934.3 4982.5 4779.9 4814.1 4890.6 4954.0 5008.9 15:27:05 INFO - PROCESS | 17666 | 15:27:05 INFO - PROCESS | 17666 | [#4] prototype.html Cycles:180 Average:4804.41 Median:5452.13 stddev:1409.73 (25.9%) stddev-sans-first:1373.05 15:27:05 INFO - PROCESS | 17666 | Values: 327.5 340.4 349.3 349.6 351.7 5422.4 5424.9 5439.6 5534.1 5534.3 5375.3 5396.7 5416.9 5437.2 5500.0 4320.0 4326.2 4331.2 4345.6 4358.3 3905.0 4166.5 4245.7 4250.4 4270.2 4218.5 4222.7 4224.0 4234.6 4245.9 4243.8 4272.7 4273.4 4300.2 4312.3 3722.5 3727.6 3759.2 3812.6 3814.4 5313.8 5332.1 5339.8 5344.5 5382.8 4897.2 4906.5 4910.9 4914.8 4941.5 5412.4 5615.6 5695.9 5745.3 5791.9 4061.8 4077.4 4077.8 4148.9 4148.9 5788.5 5814.1 5981.9 5986.9 6000.8 4146.3 4156.7 4162.5 4168.2 4186.1 4212.2 4239.7 4251.9 4278.5 4285.8 4617.0 4801.4 4828.5 4834.5 4857.4 5705.3 5737.2 5740.4 5751.2 5761.1 1408.5 1415.5 1422.8 1436.7 1441.8 948.7 983.6 992.8 994.4 994.5 5251.4 5278.6 5301.9 5390.0 5394.6 5716.7 5759.5 5765.4 5794.9 5799.9 5238.4 5297.5 5344.2 5560.7 5561.6 3032.0 3037.3 3046.6 3060.3 3062.6 5630.0 5885.0 5937.8 5963.0 5998.9 5751.6 5756.4 5761.0 5834.7 5839.4 5745.4 5841.3 5879.4 5886.8 5920.7 5606.1 5704.2 5717.5 5854.6 5897.6 5839.6 5867.6 5898.8 5907.6 5955.9 5892.0 6105.2 6107.5 6108.3 6154.8 4187.3 4233.7 4237.8 4240.9 4249.7 5651.7 5928.7 5938.2 6017.6 6035.0 5733.1 5760.7 5792.8 5803.6 5808.8 5784.0 5793.4 5795.6 5832.6 5842.4 5464.7 5702.8 5736.5 5737.5 5797.4 5724.6 5774.0 5807.4 5831.4 5856.7 5533.0 5634.7 5649.8 5710.3 5725.4 15:27:05 INFO - PROCESS | 17666 | 15:27:05 INFO - PROCESS | 17666 | [#5] yui.html Cycles:180 Average:17867.85 Median:25876.98 stddev:22938.62 (88.6%) stddev-sans-first:22967.08 15:27:05 INFO - PROCESS | 17666 | Values: 780.8 789.1 801.4 820.7 832.8 14569.8 16418.8 16422.5 16698.9 16712.8 14686.2 14981.0 15000.0 15053.2 15208.7 798.6 809.7 812.4 812.5 813.9 787.5 800.1 809.9 811.2 811.7 858.5 867.3 870.0 870.1 871.2 852.9 857.5 861.0 861.0 861.8 623.2 630.2 630.5 631.5 631.9 16145.6 16203.1 16249.4 16508.8 16525.5 14637.0 15063.8 15074.5 15116.0 15132.5 11058.2 11211.5 11252.5 11590.5 11973.0 4347.2 4366.9 4370.5 4374.5 4382.8 78747.2 79302.0 80564.2 81064.0 81382.0 10941.9 10966.4 11062.7 11190.6 11541.9 20027.5 20089.8 20097.5 20115.6 20118.2 7992.8 8003.5 8130.5 8247.4 8400.5 4386.2 4639.3 4682.8 4737.0 4787.8 3536.5 3573.4 3632.5 3651.3 3655.5 602.7 612.8 615.1 619.0 636.3 534.5 652.4 655.5 673.2 676.0 8902.7 9095.9 9288.3 9297.0 9622.9 566.0 579.9 607.2 655.9 699.4 3928.5 4182.5 4259.3 4262.3 4286.7 65077.3 66134.7 68384.7 86118.6 88021.6 71807.0 72361.0 72545.6 72624.0 73177.0 66502.3 68077.0 68277.7 68481.0 69868.0 8457.5 8545.5 8636.0 8636.3 8644.4 46255.5 46980.8 47017.0 47369.0 48644.8 50532.2 52365.0 53247.2 56088.4 56732.0 12908.7 13228.1 13257.3 13377.6 13384.2 14460.5 14549.7 14554.4 14907.9 14953.6 13702.0 13974.4 14145.1 14427.6 14470.0 13798.6 14054.4 14370.6 14845.6 14992.6 12444.7 12500.2 12852.2 13079.9 13180.8 10407.4 10788.9 11258.7 11341.7 11794.4 10860.2 11397.6 11399.2 11908.0 12040.5 15:27:05 INFO - PROCESS | 17666 | -------- Summary: end -------- 15:27:05 INFO - PROCESS | 17666 | 15:27:06 INFO - TEST-INFO | 17666: exit 0 15:27:06 INFO - TEST-OK | dromaeo_css | took 1118358ms 15:27:06 INFO - TEST-START | kraken 15:27:06 INFO - operating with platform_type : linux_ 15:27:06 INFO - Initialising browser for kraken test... 15:27:06 INFO - TEST-INFO | started process 18026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2wbRdy/profile http://localhost:47295/getInfo.html) 15:27:11 INFO - PROCESS | 18026 | __metrics Screen width/height:1600/1200 15:27:11 INFO - PROCESS | 18026 | colorDepth:24 15:27:11 INFO - PROCESS | 18026 | Browser inner width/height: 1024/697 15:27:11 INFO - PROCESS | 18026 | __metrics 15:27:12 ERROR - PROCESS | 18026 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 15:27:13 INFO - TEST-INFO | 18026: exit 0 15:27:13 INFO - Browser initialized. 15:27:13 INFO - Running cycle 1/1 for kraken test... 15:27:13 INFO - TEST-INFO | started process 18152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2wbRdy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:27:25 INFO - PROCESS | 18152 | RSS: Main: 186560512 15:27:25 INFO - PROCESS | 18152 | 15:27:28 INFO - PROCESS | 18152 | Cycle 1(1): loaded http://localhost:47295/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47295/tests/kraken/driver.html?testName=audio-beat-detection) 15:27:29 INFO - PROCESS | 18152 | RSS: Main: 198901760 15:27:29 INFO - PROCESS | 18152 | 15:27:32 INFO - PROCESS | 18152 | Cycle 1(1): loaded http://localhost:47295/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47295/tests/kraken/driver.html?testName=audio-dft) 15:27:32 INFO - PROCESS | 18152 | RSS: Main: 197238784 15:27:32 INFO - PROCESS | 18152 | 15:27:35 INFO - PROCESS | 18152 | Cycle 1(1): loaded http://localhost:47295/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47295/tests/kraken/driver.html?testName=audio-fft) 15:27:36 INFO - PROCESS | 18152 | RSS: Main: 194412544 15:27:36 INFO - PROCESS | 18152 | 15:27:38 INFO - PROCESS | 18152 | Cycle 1(1): loaded http://localhost:47295/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47295/tests/kraken/driver.html?testName=audio-oscillator) 15:27:39 INFO - PROCESS | 18152 | RSS: Main: 194924544 15:27:39 INFO - PROCESS | 18152 | 15:27:41 INFO - PROCESS | 18152 | Cycle 1(1): loaded http://localhost:47295/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47295/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:27:41 INFO - PROCESS | 18152 | RSS: Main: 195358720 15:27:41 INFO - PROCESS | 18152 | 15:27:45 INFO - PROCESS | 18152 | Cycle 1(1): loaded http://localhost:47295/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47295/tests/kraken/driver.html?testName=imaging-darkroom) 15:27:45 INFO - PROCESS | 18152 | RSS: Main: 200773632 15:27:45 INFO - PROCESS | 18152 | 15:27:49 INFO - PROCESS | 18152 | Cycle 1(1): loaded http://localhost:47295/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47295/tests/kraken/driver.html?testName=imaging-desaturate) 15:27:49 INFO - PROCESS | 18152 | RSS: Main: 196177920 15:27:49 INFO - PROCESS | 18152 | 15:27:52 INFO - PROCESS | 18152 | Cycle 1(1): loaded http://localhost:47295/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47295/tests/kraken/driver.html?testName=json-parse-financial) 15:27:53 INFO - PROCESS | 18152 | RSS: Main: 197320704 15:27:53 INFO - PROCESS | 18152 | 15:27:54 INFO - PROCESS | 18152 | Cycle 1(1): loaded http://localhost:47295/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47295/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:27:55 INFO - PROCESS | 18152 | RSS: Main: 197283840 15:27:55 INFO - PROCESS | 18152 | 15:27:57 INFO - PROCESS | 18152 | Cycle 1(1): loaded http://localhost:47295/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47295/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:27:57 INFO - PROCESS | 18152 | RSS: Main: 196988928 15:27:57 INFO - PROCESS | 18152 | 15:28:00 INFO - PROCESS | 18152 | Cycle 1(1): loaded http://localhost:47295/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47295/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:28:00 INFO - PROCESS | 18152 | RSS: Main: 197578752 15:28:00 INFO - PROCESS | 18152 | 15:28:03 INFO - PROCESS | 18152 | Cycle 1(1): loaded http://localhost:47295/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:28:04 INFO - PROCESS | 18152 | RSS: Main: 198217728 15:28:04 INFO - PROCESS | 18152 | 15:28:07 INFO - PROCESS | 18152 | Cycle 1(1): loaded http://localhost:47295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:28:07 INFO - PROCESS | 18152 | RSS: Main: 197615616 15:28:07 INFO - PROCESS | 18152 | 15:28:09 INFO - PROCESS | 18152 | Cycle 1(1): loaded http://localhost:47295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47295/tests/kraken/driver.html?testName=ai-astar) 15:28:09 INFO - PROCESS | 18152 | RSS: Main: 199184384 15:28:09 INFO - PROCESS | 18152 | 15:28:09 INFO - PROCESS | 18152 | __start_tp_report 15:28:09 INFO - PROCESS | 18152 | _x_x_mozilla_page_load 15:28:09 INFO - PROCESS | 18152 | _x_x_mozilla_page_load_details 15:28:09 INFO - PROCESS | 18152 | |i|pagename|runs| 15:28:09 INFO - PROCESS | 18152 | |0;ai-astar;106;112;112;111;111;113;112;112;111;112 15:28:09 INFO - PROCESS | 18152 | |1;audio-beat-detection;154;128;126;161;130;132;132;127;149;130 15:28:09 INFO - PROCESS | 18152 | |2;audio-dft;163;166;166;168;167;164;164;165;164;163 15:28:09 INFO - PROCESS | 18152 | |3;audio-fft;76;76;76;106;76;77;77;76;92;78 15:28:09 INFO - PROCESS | 18152 | |4;audio-oscillator;81;82;105;82;82;82;101;82;83;113 15:28:09 INFO - PROCESS | 18152 | |5;imaging-gaussian-blur;118;118;118;118;118;118;119;118;117;117 15:28:09 INFO - PROCESS | 18152 | |6;imaging-darkroom;148;150;148;147;149;148;148;148;147;147 15:28:09 INFO - PROCESS | 18152 | |7;imaging-desaturate;98;96;96;97;97;96;96;96;96;97 15:28:09 INFO - PROCESS | 18152 | |8;json-parse-financial;58;56;57;54;56;54;60;55;54;57 15:28:09 INFO - PROCESS | 18152 | |9;json-stringify-tinderbox;63;62;61;62;62;61;61;62;64;62 15:28:09 INFO - PROCESS | 18152 | |10;stanford-crypto-aes;82;82;82;86;82;83;81;81;82;81 15:28:09 INFO - PROCESS | 18152 | |11;stanford-crypto-ccm;135;142;133;142;152;134;147;136;188;150 15:28:09 INFO - PROCESS | 18152 | |12;stanford-crypto-pbkdf2;177;174;172;171;170;172;169;178;177;173 15:28:09 INFO - PROCESS | 18152 | |13;stanford-crypto-sha256-iterative;71;67;66;70;67;67;71;70;68;71 15:28:09 INFO - PROCESS | 18152 | __end_tp_report 15:28:09 INFO - PROCESS | 18152 | __start_cc_report 15:28:09 INFO - PROCESS | 18152 | _x_x_mozilla_cycle_collect,819 15:28:09 INFO - PROCESS | 18152 | __end_cc_report 15:28:09 INFO - PROCESS | 18152 | __startTimestamp1480462089769__endTimestamp 15:28:09 INFO - PROCESS | 18152 | 15:28:09 INFO - PROCESS | 18152 | ------- Summary: start ------- 15:28:09 INFO - PROCESS | 18152 | Number of tests: 14 15:28:09 INFO - PROCESS | 18152 | 15:28:09 INFO - PROCESS | 18152 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:1.93 (1.7%) stddev-sans-first:0.67 15:28:09 INFO - PROCESS | 18152 | Values: 106.0 112.0 112.0 111.0 111.0 113.0 112.0 112.0 111.0 112.0 15:28:09 INFO - PROCESS | 18152 | 15:28:09 INFO - PROCESS | 18152 | [#1] audio-beat-detection Cycles:10 Average:136.90 Median:132.00 stddev:12.73 (9.6%) stddev-sans-first:11.91 15:28:09 INFO - PROCESS | 18152 | Values: 154.0 128.0 126.0 161.0 130.0 132.0 132.0 127.0 149.0 130.0 15:28:09 INFO - PROCESS | 18152 | 15:28:09 INFO - PROCESS | 18152 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.50 stddev:1.70 (1.0%) stddev-sans-first:1.64 15:28:09 INFO - PROCESS | 18152 | Values: 163.0 166.0 166.0 168.0 167.0 164.0 164.0 165.0 164.0 163.0 15:28:09 INFO - PROCESS | 18152 | 15:28:09 INFO - PROCESS | 18152 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.50 stddev:10.07 (13.2%) stddev-sans-first:10.51 15:28:09 INFO - PROCESS | 18152 | Values: 76.0 76.0 76.0 106.0 76.0 77.0 77.0 76.0 92.0 78.0 15:28:09 INFO - PROCESS | 18152 | 15:28:09 INFO - PROCESS | 18152 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:82.00 stddev:12.11 (14.8%) stddev-sans-first:12.47 15:28:09 INFO - PROCESS | 18152 | Values: 81.0 82.0 105.0 82.0 82.0 82.0 101.0 82.0 83.0 113.0 15:28:09 INFO - PROCESS | 18152 | 15:28:09 INFO - PROCESS | 18152 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:28:09 INFO - PROCESS | 18152 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 119.0 118.0 117.0 117.0 15:28:09 INFO - PROCESS | 18152 | 15:28:09 INFO - PROCESS | 18152 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 15:28:09 INFO - PROCESS | 18152 | Values: 148.0 150.0 148.0 147.0 149.0 148.0 148.0 148.0 147.0 147.0 15:28:09 INFO - PROCESS | 18152 | 15:28:09 INFO - PROCESS | 18152 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.50 15:28:09 INFO - PROCESS | 18152 | Values: 98.0 96.0 96.0 97.0 97.0 96.0 96.0 96.0 96.0 97.0 15:28:09 INFO - PROCESS | 18152 | 15:28:09 INFO - PROCESS | 18152 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.50 stddev:1.97 (3.5%) stddev-sans-first:1.96 15:28:09 INFO - PROCESS | 18152 | Values: 58.0 56.0 57.0 54.0 56.0 54.0 60.0 55.0 54.0 57.0 15:28:09 INFO - PROCESS | 18152 | 15:28:09 INFO - PROCESS | 18152 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 15:28:09 INFO - PROCESS | 18152 | Values: 63.0 62.0 61.0 62.0 62.0 61.0 61.0 62.0 64.0 62.0 15:28:09 INFO - PROCESS | 18152 | 15:28:09 INFO - PROCESS | 18152 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:1.48 (1.8%) stddev-sans-first:1.56 15:28:09 INFO - PROCESS | 18152 | Values: 82.0 82.0 82.0 86.0 82.0 83.0 81.0 81.0 82.0 81.0 15:28:09 INFO - PROCESS | 18152 | 15:28:09 INFO - PROCESS | 18152 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:144.50 stddev:16.27 (11.3%) stddev-sans-first:16.77 15:28:09 INFO - PROCESS | 18152 | Values: 135.0 142.0 133.0 142.0 152.0 134.0 147.0 136.0 188.0 150.0 15:28:09 INFO - PROCESS | 18152 | 15:28:09 INFO - PROCESS | 18152 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:173.50 stddev:3.13 (1.8%) stddev-sans-first:3.02 15:28:09 INFO - PROCESS | 18152 | Values: 177.0 174.0 172.0 171.0 170.0 172.0 169.0 178.0 177.0 173.0 15:28:09 INFO - PROCESS | 18152 | 15:28:09 INFO - PROCESS | 18152 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:70.00 stddev:1.99 (2.8%) stddev-sans-first:1.94 15:28:09 INFO - PROCESS | 18152 | Values: 71.0 67.0 66.0 70.0 67.0 67.0 71.0 70.0 68.0 71.0 15:28:09 INFO - PROCESS | 18152 | -------- Summary: end -------- 15:28:09 INFO - PROCESS | 18152 | 15:28:10 INFO - TEST-INFO | 18152: exit 0 15:28:11 INFO - TEST-OK | kraken | took 64074ms 15:28:11 INFO - SUITE-END | took 1182s 15:28:11 INFO - Completed test suite (00:19:42) 15:28:11 INFO - javascript benchmark 15:28:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7203.439041047293, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3138.6547479777228, 3149.5118256670225, 3154.921126971824, 3157.289609837787, 3184.697453741895, 5360.437154098822, 5447.237386765856, 5454.045542030144, 5479.534239589635, 5505.311836020497, 5394.083005888999, 5409.864753381167, 5484.698341591211, 5496.983058134248, 5546.389897111325, 4882.536159064901, 4978.5270399312, 4979.153543897528, 5027.346444962168, 5042.445331013586, 4921.2618107284015, 5056.469070747574, 5090.643654944155, 5119.436861945183, 5144.717040562768, 4924.876878078041, 5035.144025515671, 5046.697198168122, 5100.362454693163, 5102.081625307444, 4943.802247910079, 4963.305137280748, 5005.849824505271, 5018.623603229736, 5025.522575355372, 4957.603391728653, 4976.850694479172, 5041.9747901260625, 5049.949500504985, 5063.291139240509, 5413.512783849473, 5472.288602481652, 5474.206240095204, 5486.945130548684, 5506.504414602705, 5699.088145896678, 5898.085796701518, 5900.822975310747, 5905.055191169392, 5946.732397042144, 5832.387599302097, 5901.940980590182, 5927.911081333784, 5932.762689492458, 5976.910346344808, 5597.384287728347, 5605.775768969277, 5606.439356064402, 5625.240592519998, 5640.576956728261, 6087.878242435127, 6098.298695650057, 6136.938630613726, 6138.570300078952, 6161.106639537242, 5661.377248502661, 5704.030314846486, 5855.824325270249, 5907.172995780594, 5912.408759124053, 5800.970995145081, 5809.651420914759, 5810.157527158538, 5912.142739302863, 5928.0, 5638.182463542763, 5706.857328566819, 5823.505002074871, 5856.648601083949, 5857.589968702235, 5870.853228669232, 5876.030454974967, 5913.615614985099, 5918.674472904032, 5923.703814809242, 4490.50604433512, 4517.119161763425, 4545.250033744395, 4546.65900057497, 4575.954240457553, 3935.58676338986, 3948.881533553998, 3974.682025437958, 3992.3811809169624, 4056.756594604274, 5516.365617953907, 5539.0, 5544.390117087117, 5547.11246200614, 5583.944160558423, 5818.650880947157, 5823.883522329615, 5833.591648584558, 5834.241548598655, 5834.649921004753, 5528.44715528452, 5536.584756143306, 5550.69471179089, 5595.944040559623, 5596.468335508121, 5091.134507133796, 5096.61775366849, 5128.564072053842, 5139.511746384088, 5148.892988007597, 6072.848178795565, 6073.939260607337, 6089.817305480843, 6173.290071641639, 6186.566940314135, 5965.761369545169, 5970.0746384310505, 5977.103434484862, 5991.041433370639, 6023.247094113236, 5935.40645935403, 6112.0, 6112.899678057992, 6120.663363515049, 6169.660668663267, 5727.828165155052, 5735.426457354231, 5760.567957403296, 5783.392743761844, 5874.295084589877, 5936.347001829881, 5939.406059394026, 5939.970300148471, 5940.524758019435, 5949.25634295713, 5768.134779783066, 5824.475797178275, 5832.445917637818, 5834.504067154339, 5842.065269556851, 5679.8864022720145, 5743.224664670383, 5751.482366587027, 5798.94201057984, 5818.854528636818, 5664.178694089252, 5693.829185124453, 5706.4864162225595, 5758.366579676316, 5785.161151633074, 5820.970895145497, 5825.3883342248455, 5826.7086645666695, 5827.854303642443, 5872.1778950947755, 5640.605157638925, 5668.433156684298, 5679.204911312337, 5690.174924635988, 5696.430356964271], "value": 5435.617372447416, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.1762136091986, 589.2192844481061, 594.7620951619351, 594.8334466349423, 596.8388535095521, 38068.23863522728, 40022.59977400229, 40040.79979600102, 43083.78458107713, 43114.35328470075, 42850.785746071226, 43271.350929736, 43279.78360108203, 43326.35010474837, 43399.13201735963, 8561.0582835888, 8592.269657079156, 8698.0, 8702.695405660803, 10103.292769506137, 10089.344192627455, 10362.896371036306, 10368.896311036868, 10393.376397416141, 10405.167586593054, 10271.948640256789, 10275.537600807944, 10321.277510574262, 10434.113100386476, 10437.530311135979, 10334.7416314592, 10390.376577405343, 10432.947835260775, 10444.738881527946, 10453.895461045367, 10160.288779785418, 10267.127294180003, 10307.79384412315, 10312.226583006304, 10330.690079297634, 41327.0, 41451.37822932658, 41509.37735933963, 41544.37683434751, 41548.0, 3355.664612719871, 3739.719521035933, 3883.3010058189516, 3908.472356231901, 4027.9597204027878, 30664.693353066406, 30714.53928191079, 30723.539146912815, 30913.69086309153, 32360.676393236, 4065.7560546367017, 4141.689373296985, 4175.164967006611, 4322.935155972663, 4334.826606935719, 346191.0, 347653.0, 348123.0, 350024.2498787515, 350070.0, 58218.417815821296, 58550.41449585535, 58981.0, 59004.0, 59064.7046764772, 61019.389806102256, 61408.0, 61415.38584614186, 61494.38505614976, 61791.382086178564, 17102.743458848126, 17384.130793460277, 17400.47798566045, 17503.212355443782, 17516.82483175152, 12277.631671049883, 12445.75108497825, 12858.935705321413, 13102.934485327512, 13286.136401133896, 18618.53453663642, 18699.34552290663, 18772.71840922387, 18854.3400980965, 19090.0, 6826.24911259761, 6833.296028252441, 7129.89305160423, 7169.96415017932, 7204.819879503054, 915.4370062411568, 928.4150984879483, 1053.6101642392211, 1144.9942750286195, 1157.7106819234716, 30447.543286850716, 34181.31637367288, 34221.82889085588, 35827.4625880612, 36526.45210321794, 1113.8106521891298, 1164.2956011612853, 1178.3813497913663, 1230.0958795285458, 1234.4818660587162, 15163.848361516464, 16800.582919853536, 16830.410935617194, 16856.57858553546, 16912.408065717886, 460623.0, 468304.0, 471196.0, 472784.0, 475716.0, 53831.46168538343, 54543.72728136334, 54866.0, 54909.1763623546, 55300.72349638226, 1383.9861601383857, 1390.1242217402971, 1414.4766436418386, 1415.242845077899, 1426.1015560197009, 29291.85354073216, 30647.467626618134, 30861.845690771403, 31170.376592468478, 31479.527807082453, 49928.251076234614, 50524.0, 50554.241686374, 50634.0, 50690.239646404596, 433648.0, 434125.0, 436256.0, 436369.0, 437424.0, 40088.59911400965, 40951.0, 41006.79496602498, 41066.384004239364, 41542.58457415508, 45272.54727452815, 45438.54561454343, 46276.30585541152, 47101.7644911787, 47164.0, 38209.2358152841, 38991.610083899934, 39320.09866327171, 40328.7983560092, 40740.796296019515, 39111.804440978754, 39921.0, 40198.99405213449, 40466.59533404628, 40860.38709419421, 38798.76216710708, 39698.759041938916, 39859.80070099747, 40614.39078413767, 41041.17917641571, 33105.83447082749, 35429.46855797217, 35925.28149437049, 36127.45808812817, 36265.63734362623, 27350.5897411535, 27352.589711154746, 27455.313617159733, 27476.17571472859, 27756.861215693792], "value": 20475.42029221871, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.4749714137342, 388.355330151948, 406.9287874621941, 408.96523795477384, 415.98960025999344, 17603.911980440094, 18970.0, 19318.0, 19452.319168829094, 19743.5064123397, 19153.23387064516, 19448.4165475036, 19806.603867922633, 19923.0, 20088.196472141095, 5508.256385387971, 5560.193771903072, 5651.491365777079, 5686.829395118153, 5687.4312568743, 5548.167774833767, 5604.2154098426045, 5609.943900561003, 5620.971895140518, 5667.716614169275, 5618.185363122345, 5660.150977353389, 5922.230110085704, 5924.703764811764, 6023.006203976361, 5803.738831752581, 5948.196993405878, 5957.85105372367, 5967.940320596782, 5984.192134061911, 5740.684262365568, 5789.2763404574425, 5789.88420231593, 5794.5943783935145, 5794.5943783935145, 13922.37349319273, 14126.576202713832, 22340.776592234033, 22490.10039598414, 22579.209727659618, 2348.1429278313294, 2355.552445035438, 2446.192756390387, 2458.4714286428502, 2858.7284208000415, 10130.189584833195, 10348.0, 10379.636712715093, 10944.835827462515, 10975.341479511255, 1765.885217460861, 1778.413123669186, 1882.2282864025683, 1913.9951525449112, 1991.074150520015, 81161.0, 84544.99999999939, 84845.0, 85025.0, 87561.56219218927, 10911.727206819734, 11004.39475828837, 11110.944445277722, 11163.162762792823, 11507.482163302671, 15716.528504144893, 15795.21023948798, 15885.602859928595, 15935.12356820386, 16004.279807408695, 7595.0, 7848.372130229568, 7861.764147075597, 7879.0939042010905, 8097.473664211808, 7400.851982960311, 7426.777196684108, 7443.144038435649, 7593.772186834404, 7671.309582137523, 4749.121412538622, 4813.687110337817, 4833.202521583969, 4840.128776820206, 4942.946783637454, 1954.79474655162, 1973.4770285874256, 1979.7228388025687, 1993.9700904486444, 2008.5581172142106, 838.5220424358057, 908.922741566961, 959.9568019439142, 983.1839573154265, 1008.4151192308443, 18041.458756237334, 18524.44426667175, 19566.70649940252, 19994.500137496678, 20291.797082029287, 935.4761333653177, 939.2767568971854, 963.5856581669949, 986.1519093579516, 1000.3697670467704, 10506.212034097472, 10917.434845800137, 11071.114310855111, 11138.888611113947, 11148.219624626197, 431495.0, 436181.0, 436792.0, 443249.0, 444680.0, 88585.0, 91581.0, 91667.5416622926, 92930.53534732418, 92987.0, 996.352370958868, 1007.8135544924213, 1016.1718199667248, 1032.7160030991388, 1047.858539097212, 16510.504684859472, 16934.49196524106, 17275.222614982104, 17579.384721534683, 17950.281988720304, 40633.79683101566, 41952.790236048626, 42047.36928946007, 42282.57717422787, 42352.0, 51560.22659660033, 56096.439035610754, 56291.43708562862, 57515.42484575268, 57855.421445785, 8345.374096942875, 8447.788805279917, 8504.149585041694, 8591.570421478777, 8702.956485217534, 11606.70983225426, 12942.741145177231, 12969.351532423152, 12993.675158121123, 13116.278604676834, 11211.71970700739, 11337.489812958602, 12078.33569153705, 12081.335526546125, 12091.334976576372, 11067.833982490109, 11083.224174307721, 11139.33164010162, 11200.607978720705, 11978.520859165536, 11394.715132121763, 11617.593384231512, 11813.586524471602, 11931.4034298283, 12427.813582796447, 8508.106648802035, 8649.610767515604, 8680.218780309802, 8861.778455538406, 8893.06622804622, 11274.436278185894, 11456.427178641201, 11734.471948762497, 11744.530218791495, 11804.527818887493], "value": 9152.383235306646, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.4014293925081, 1433.6917562724016, 1512.3874830693574, 1663.542525805404, 1692.8137904830473, 7184.3174898384705, 7336.266373362661, 7904.6442910069045, 8362.623681934312, 8367.49795012299, 7936.365090792737, 8200.138985406536, 8200.548969806658, 8400.579971001456, 8416.705415310465, 2261.310300358394, 2298.092253559843, 2305.170138750057, 2305.8385912986096, 2307.711536057993, 2325.988370058147, 2333.53329334133, 2372.6678265042906, 2395.8562486250794, 2396.8322217444784, 2259.423846919033, 2262.4117729390396, 2289.347535952254, 2302.251768175341, 2304.850184737995, 2229.6432570788756, 2257.480779420734, 2263.343630347197, 2266.8639881607155, 2289.9084036638596, 2296.2651951375565, 2303.5968705476644, 2311.4914718761847, 2338.216697406354, 2339.181286549711, 8274.379421543408, 8293.543855087968, 8303.211194936472, 8389.538575378352, 8437.95781021091, 5096.082705113078, 5197.142471492237, 5217.608679349064, 5232.790688372461, 5241.606879484016, 3112.688731126892, 3144.3082521845386, 3404.114930118162, 3411.710004649608, 3414.5219669246326, 1006.9395836249848, 1026.4611079183414, 1061.8194906865851, 1066.3015724700333, 1086.3264775838952, 11512.712182195428, 11608.767824643544, 11693.532258709727, 11703.122265830012, 11735.23720958135, 4389.990302230505, 4638.768061596907, 4706.987997580468, 4771.498992605796, 4774.809007639725, 9677.0, 9741.853872191923, 9753.804923901482, 9774.631551582785, 9784.0, 5223.973880130651, 5235.110031294689, 5242.475752424727, 5247.973760131251, 5281.577473802086, 4713.481517033124, 4863.562279394871, 4882.414110306715, 4924.507549245119, 4969.577585905238, 3629.7840223525413, 3668.761530500509, 3703.0, 3761.887143385703, 3781.9243615127543, 1154.18629865946, 1165.2833507392893, 1175.6649354933802, 1176.917615766888, 1186.6084192216547, 826.01703972274, 860.4020205956925, 900.9729708108767, 913.2555484722249, 927.3832901120815, 5245.501677340647, 5285.656432331886, 5396.163594642837, 5451.373092094381, 5469.507744303032, 430.03457238499146, 433.65741064559273, 440.43184292262623, 446.4999200895018, 457.3163121133926, 3631.4008188649104, 3632.219072899339, 3650.653187947141, 3652.141746689526, 3722.5346831646043, 10009.449480278508, 10127.0, 10436.478176091165, 10474.790504189874, 10499.475026248658, 10382.117520010883, 10422.530986105643, 10474.057334839748, 10556.736081597868, 10558.208134389952, 7837.451378403457, 7840.215978402228, 7872.094709108412, 7944.880826787603, 7957.482763620231, 5384.488473595002, 5394.622376433612, 5421.430749771217, 5529.419410961791, 5651.265335506358, 9359.532023398666, 9407.85888211691, 9412.529373531434, 9547.283953703361, 9567.61729530811, 9136.771580710536, 9313.44119352841, 9394.154526092685, 9472.810543788948, 9642.855357169788, 7225.385842203472, 7476.70093196266, 7498.0, 7555.848883022419, 7671.654775535003, 8274.917250827655, 8320.916790832014, 8324.625391857502, 8331.291840193651, 8338.207870252316, 7184.209736928829, 7232.349088582053, 7327.523710958771, 7374.188839227788, 7579.204183560647, 7235.0, 7284.38082762971, 7295.343419092307, 7433.553986760596, 7493.288137626917, 6687.0, 6749.966250168718, 6750.426213771884, 6762.087118239171, 6783.152105986752, 4588.954110458986, 4678.906421871611, 4706.788194531323, 4934.333864928189, 4982.451930287738, 4779.928301075417, 4814.061258054646, 4890.55984961341, 4953.950460495349, 5008.899822003466], "value": 4349.454049147871, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.4772308764246, 340.39070064584394, 349.28048220665414, 349.6486031538304, 351.69578314757734, 5422.421202006676, 5424.887897980914, 5439.5920305977015, 5534.114541673333, 5534.335879694432, 5375.3280839895015, 5396.730163491829, 5416.945830541694, 5437.238786569884, 5500.0299838087385, 4320.0063985283405, 4326.242907491192, 4331.155424692186, 4345.565443455653, 4358.302671572549, 3904.97364542479, 4166.500019997605, 4245.681573881971, 4250.404943307939, 4270.188664153801, 4218.493780746315, 4222.725522841021, 4223.97888010561, 4234.597713217239, 4245.936310955338, 4243.830246790125, 4272.743635381871, 4273.358996150571, 4300.182965236595, 4312.28847240205, 3722.4788529605876, 3727.5713292971386, 3759.2105657811617, 3812.618738126165, 3814.389697648363, 5313.804394011355, 5332.146856502941, 5339.813106541253, 5344.465553444663, 5382.757775900094, 4897.216445368759, 4906.533879281463, 4910.852674419737, 4914.827981020683, 4941.505849415065, 5412.431694672042, 5615.596100974756, 5695.914561281584, 5745.2818397700285, 5791.942080579182, 4061.7969101544804, 4077.368007958771, 4077.7961101944784, 4148.854790082363, 4148.92128046707, 5788.466056495032, 5814.133601155185, 5981.910271345933, 5986.880262394728, 6000.75996960121, 4146.315857883415, 4156.711419459916, 4162.542120366757, 4168.166366726667, 4186.099988502426, 4212.178625168124, 4239.703220774516, 4251.893702657397, 4278.465191851019, 4285.807138678767, 4616.991608650248, 4801.351817504662, 4828.465055845709, 4834.516548345207, 4857.4171099467585, 5705.343885453143, 5737.196792449061, 5740.368559458456, 5751.245870009687, 5761.135829625506, 1408.485902645527, 1415.4550498058322, 1422.8363738170035, 1436.6695659998259, 1441.8269807623153, 948.7153853843819, 983.6114734679761, 992.846108853129, 994.418265314799, 994.4778991029767, 5251.398323511366, 5278.577713782888, 5301.867453313698, 5389.973050134724, 5394.62237643369, 5716.657000579895, 5759.452851979056, 5765.394633563499, 5794.942050579524, 5799.94200057994, 5238.423773384925, 5297.496737809902, 5344.225087362311, 5560.694161821058, 5561.610687251934, 3031.9545206821917, 3037.331787006855, 3046.6496352919253, 3060.3420264642764, 3062.6111632926354, 5629.971850140723, 5885.028970219952, 5937.762489500372, 5962.970185149046, 5998.86021655884, 5751.59738818287, 5756.42435756421, 5760.95486102436, 5834.737436815269, 5839.445252700986, 5745.425457454221, 5841.349156777014, 5879.412058794172, 5886.823395298148, 5920.703964801656, 5606.131049687305, 5704.229928959703, 5717.5425965921795, 5854.590178687451, 5897.557683173865, 5839.649621022582, 5867.647941123546, 5898.761260135419, 5907.645541267538, 5955.91066134017, 5892.026171232685, 6105.175801266772, 6107.457674548662, 6108.267007959073, 6154.846128846635, 4187.341038440673, 4233.724807887601, 4237.813412244576, 4240.872773816791, 4249.745015299092, 5651.717414129359, 5928.703564821655, 5938.2280303560265, 6017.578769486094, 6035.0, 5733.082706766897, 5760.683162426107, 5792.82621521355, 5803.622764520462, 5808.82573522795, 5784.0, 5793.391693872083, 5795.565332600157, 5832.600175957825, 5842.38654941242, 5464.672119672832, 5702.800401985911, 5736.541076713769, 5737.483626473638, 5797.362290148165, 5724.627899186539, 5773.971130144322, 5807.448292412214, 5831.446012628793, 5856.707164641665, 5533.039823694304, 5634.718264086861, 5649.802256920988, 5710.2576665033275, 5725.425507985337], "value": 4354.720026497308, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.8204113053997, 789.1201310538751, 801.4389927051066, 820.671731307477, 832.8001279692876, 14569.781453278196, 16418.83581164188, 16422.50732478026, 16698.916505417485, 16712.83287167128, 14686.192259425727, 14981.0, 15000.0, 15053.247337633102, 15208.69582608347, 798.5687728626534, 809.7287408718087, 812.358236992775, 812.4800127918137, 813.8860559521672, 787.4645241235958, 800.1118758178417, 809.9190080991913, 811.1766556944706, 811.6834434570522, 858.4505916213598, 867.3408209760596, 870.0038455967913, 870.0951010948637, 871.1984973824098, 852.9402941794077, 857.536930057768, 861.0184389795606, 861.0399404663817, 861.8017855893117, 623.1618473153601, 630.2468550082654, 630.486153784664, 631.4916492223758, 631.9115323854664, 16145.596360090974, 16203.1088290144, 16249.350025998945, 16508.75236871448, 16525.504234872853, 14637.0, 15063.849361506354, 15074.472393466285, 15116.0, 15132.546023619308, 11058.22592418531, 11211.495482703216, 11252.54989800407, 11590.478428470738, 11973.0, 4347.217500849846, 4366.912661746779, 4370.497392799805, 4374.475062992461, 4382.758948257844, 78747.21252787457, 79302.0, 80564.19435805625, 81063.9999999994, 81382.0, 10941.945290273658, 10966.396848173426, 11062.668119956414, 11190.608328708457, 11541.942290288494, 20027.499312517302, 20089.799102009085, 20097.497562561053, 20115.597688046157, 20118.19527218924, 7992.800179995546, 8003.4797738146835, 8130.471519351341, 8247.381446391424, 8400.453970491899, 4386.166628340605, 4639.257718765049, 4682.765861706901, 4736.95263047372, 4787.760611969387, 3536.5225694531423, 3573.446115852047, 3632.473291372789, 3651.2879988402005, 3655.5430571178604, 602.704674709398, 612.7579606055583, 615.1265203411167, 619.0497586205154, 636.3413866647998, 534.5322842512801, 652.3997921911853, 655.4657953767664, 673.2123415603755, 675.9932400676029, 8902.688405905763, 9095.909040909639, 9288.303377246733, 9296.953515232515, 9622.9037709622, 565.9527943919155, 579.9130130480378, 607.1560530862105, 655.9212894452696, 699.4474365251394, 3928.5482169550296, 4182.477190351206, 4259.339802330644, 4262.296721041055, 4286.657067434598, 65077.349226507125, 66134.66932665306, 68384.6580767093, 86118.56940715382, 88021.5598922014, 71807.0, 72361.0, 72545.63727181435, 72624.0, 73177.0, 66502.33497665059, 68077.0, 68277.65861170762, 68480.99999999901, 69868.0, 8457.492550446992, 8545.529995850287, 8635.95682021611, 8636.309095272489, 8644.394892357475, 46255.53744462647, 46980.7650961743, 47017.0, 47369.0, 48644.756776215894, 50532.24201637052, 52365.0, 53247.20129198143, 56088.43911560995, 56732.0, 12908.677283067998, 13228.07403481747, 13257.270850103338, 13377.598672039854, 13384.19694818314, 14460.493882714054, 14549.709005819612, 14554.41782328695, 14907.850921490646, 14953.626159346104, 13702.0, 13974.371153298329, 14145.080569762933, 14427.639309017359, 14470.0, 13798.586042418743, 14054.426455390925, 14370.640733981734, 14845.628859278604, 14992.550223493312, 12444.68888277764, 12500.187487813264, 12852.164609300366, 13079.869201307865, 13180.783956425661, 10407.375557466576, 10788.946055269673, 11258.66224013281, 11341.716457088638, 11794.410279486163, 10860.185486088732, 11397.601083962021, 11399.202055856342, 11908.0, 12040.518379265082], "value": 7240.72508618732, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 112.0, 111.0, 111.0, 113.0, 112.0, 112.0, 111.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 128.0, 126.0, 161.0, 130.0, 132.0, 132.0, 127.0, 149.0, 130.0], "value": 136.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 166.0, 168.0, 167.0, 164.0, 164.0, 165.0, 164.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 106.0, 76.0, 77.0, 77.0, 76.0, 92.0, 78.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 105.0, 82.0, 82.0, 82.0, 101.0, 82.0, 83.0, 113.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 117.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 148.0, 147.0, 149.0, 148.0, 148.0, 148.0, 147.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 57.0, 54.0, 56.0, 54.0, 60.0, 55.0, 54.0, 57.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 62.0, 64.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 86.0, 82.0, 83.0, 81.0, 81.0, 82.0, 81.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 142.0, 133.0, 142.0, 152.0, 134.0, 147.0, 136.0, 188.0, 150.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 174.0, 172.0, 171.0, 170.0, 172.0, 169.0, 178.0, 177.0, 173.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 66.0, 70.0, 67.0, 67.0, 71.0, 70.0, 68.0, 71.0], "value": 68.8, "unit": "score"}]}]} 15:28:11 INFO - Return code: 0 15:28:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:28:11 ERROR - # TBPL SUCCESS # 15:28:11 INFO - Running post-action listener: _resource_record_post_action 15:28:11 INFO - [mozharness: 2016-11-29 23:28:11.587851Z] Finished run-tests step (success) 15:28:11 INFO - Running post-run listener: _resource_record_post_run 15:28:11 INFO - Total resource usage - Wall time: 1200s; CPU: 14.0%; Read bytes: 4096; Write bytes: 409260032; Read time: 16; Write time: 803704 15:28:11 INFO - TinderboxPrint: CPU usage
13.5% 15:28:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 15:28:11 INFO - TinderboxPrint: I/O write bytes / time
409,260,032 / 803,704 15:28:11 INFO - TinderboxPrint: CPU idle
8,276.1 (86.5%) 15:28:11 INFO - TinderboxPrint: CPU user
1,224.3 (12.8%) 15:28:11 INFO - TinderboxPrint: Swap in / out
0 / 0 15:28:11 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 104308736; Read time: 0; Write time: 296656 15:28:11 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 300834816; Read time: 0; Write time: 506464 15:28:12 INFO - Running post-run listener: _upload_blobber_files 15:28:12 INFO - Blob upload gear active. 15:28:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:28:12 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 15:28:12 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'] 15:28:12 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 15:28:12 INFO - (blobuploader) - INFO - Open directory for files ... 15:28:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:28:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:28:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:28:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:28:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:28:16 INFO - (blobuploader) - INFO - Done attempting. 15:28:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:28:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:28:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:28:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:28:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:28:17 INFO - (blobuploader) - INFO - Done attempting. 15:28:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:28:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:28:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:28:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:28:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:28:18 INFO - (blobuploader) - INFO - Done attempting. 15:28:18 INFO - (blobuploader) - INFO - Iteration through files over. 15:28:18 INFO - Return code: 0 15:28:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:28:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:28:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7521a5f2b8afff3c3b80a4b35aedd7e3fa8678989b671fcdf86e460c3b4882f63caf3050c6e495bc0bd8d8a25b6df5742e7228406e50c41d7deed4ef74ca815f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4756b377ed4b6cc0c87f56ea126b09c99ae1ca5a279ac63101d27f8ea8b7b03a3c042abf56f97f7034313e948050b434f91841d6dbfd70796a60901380806abb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c5e4452126d5b740dd867feb5ff969c04f145d74db6ff0616bc7891d91c479652cfc2cc9247e3ce1588a60c6b1e5ecda1ac04c44584505a908910838bf2f5a53"} 15:28:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:28:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:28:18 INFO - Contents: 15:28:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7521a5f2b8afff3c3b80a4b35aedd7e3fa8678989b671fcdf86e460c3b4882f63caf3050c6e495bc0bd8d8a25b6df5742e7228406e50c41d7deed4ef74ca815f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4756b377ed4b6cc0c87f56ea126b09c99ae1ca5a279ac63101d27f8ea8b7b03a3c042abf56f97f7034313e948050b434f91841d6dbfd70796a60901380806abb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c5e4452126d5b740dd867feb5ff969c04f145d74db6ff0616bc7891d91c479652cfc2cc9247e3ce1588a60c6b1e5ecda1ac04c44584505a908910838bf2f5a53"} 15:28:18 INFO - Running post-run listener: copy_logs_to_upload_dir 15:28:18 INFO - Copying logs to upload dir... 15:28:18 INFO - mkdir: /builds/slave/test/build/upload/logs 15:28:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.002184 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-11-29 15:28:18.170107) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 15:28:18.174124) ========= 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=df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7521a5f2b8afff3c3b80a4b35aedd7e3fa8678989b671fcdf86e460c3b4882f63caf3050c6e495bc0bd8d8a25b6df5742e7228406e50c41d7deed4ef74ca815f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4756b377ed4b6cc0c87f56ea126b09c99ae1ca5a279ac63101d27f8ea8b7b03a3c042abf56f97f7034313e948050b434f91841d6dbfd70796a60901380806abb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c5e4452126d5b740dd867feb5ff969c04f145d74db6ff0616bc7891d91c479652cfc2cc9247e3ce1588a60c6b1e5ecda1ac04c44584505a908910838bf2f5a53"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011849 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7521a5f2b8afff3c3b80a4b35aedd7e3fa8678989b671fcdf86e460c3b4882f63caf3050c6e495bc0bd8d8a25b6df5742e7228406e50c41d7deed4ef74ca815f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4756b377ed4b6cc0c87f56ea126b09c99ae1ca5a279ac63101d27f8ea8b7b03a3c042abf56f97f7034313e948050b434f91841d6dbfd70796a60901380806abb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c5e4452126d5b740dd867feb5ff969c04f145d74db6ff0616bc7891d91c479652cfc2cc9247e3ce1588a60c6b1e5ecda1ac04c44584505a908910838bf2f5a53"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 15:28:18.204705) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:28:18.205548) ========= 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=df17445c3590ff7897617a0e00000225-1480460855.340061-1109958250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:28:18.290126) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 15:28:18.290971) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 15:28:18.291710) ========= ========= Total master_lag: 0.20 =========