builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1478800660.57 results: success (0) buildid: 20161110094308 builduid: ad9a122615224237b86726736ce06593 revision: 3930bf2158788bc3681992d61cc0d26614c8b388 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-10 09:57:40.570099) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-10 09:57:40.570592) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-10 09:57:40.570876) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-10 09:57:40.585315) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 09:57:40.585648) ========= 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=14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-10 09:57:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-11-10 09:57:41 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080564 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 09:57:40.680817) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 09:57:40.681152) ========= 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=14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015004 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 09:57:40.730971) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 09:57:40.731350) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3930bf2158788bc3681992d61cc0d26614c8b388 --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 3930bf2158788bc3681992d61cc0d26614c8b388 --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=14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-10 09:57:41,138 truncating revision to first 12 chars 2016-11-10 09:57:41,138 Setting DEBUG logging. 2016-11-10 09:57:41,138 attempt 1/10 2016-11-10 09:57:41,138 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/3930bf215878?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-10 09:57:41,456 unpacking tar archive at: mozilla-inbound-3930bf215878/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651690 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 09:57:41.396461) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-10 09:57:41.396794) ========= script_repo_revision: 3930bf2158788bc3681992d61cc0d26614c8b388 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-10 09:57:41.397228) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-10 09:57:41.397577) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-10 09:57:41.406144) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-11-10 09:57:41.406479) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:57:41 INFO - MultiFileLogger online at 20161110 09:57:41 in /builds/slave/test 09:57:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:57:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:57:41 INFO - {'append_to_log': False, 09:57:41 INFO - 'base_work_dir': '/builds/slave/test', 09:57:41 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:57:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:57:41 INFO - 'branch': 'Mozilla-Inbound', 09:57:41 INFO - 'buildbot_json_path': 'buildprops.json', 09:57:41 INFO - 'config_files': ('talos/linux_config.py',), 09:57:41 INFO - 'default_actions': ('clobber', 09:57:41 INFO - 'read-buildbot-config', 09:57:41 INFO - 'download-and-extract', 09:57:41 INFO - 'populate-webroot', 09:57:41 INFO - 'create-virtualenv', 09:57:41 INFO - 'install', 09:57:41 INFO - 'run-tests'), 09:57:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:57:41 INFO - 'download_minidump_stackwalk': True, 09:57:41 INFO - 'download_symbols': 'ondemand', 09:57:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:57:41 INFO - 'tooltool.py': '/tools/tooltool.py', 09:57:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:57:41 INFO - '/tools/misc-python/virtualenv.py')}, 09:57:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:57:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:57:41 INFO - 'installer_path': 'installer.exe', 09:57:41 INFO - 'log_level': 'info', 09:57:41 INFO - 'log_name': 'talos', 09:57:41 INFO - 'log_to_console': True, 09:57:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:57:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:57:41 INFO - 'opt_config_files': (), 09:57:41 INFO - 'pip_index': False, 09:57:41 INFO - 'sps_profile': False, 09:57:41 INFO - 'sps_profile_interval': 0, 09:57:41 INFO - 'suite': 'dromaeojs', 09:57:41 INFO - 'system_bits': '32', 09:57:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:57:41 INFO - 'title': 'talos-linux64-ix-036', 09:57:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:57:41 INFO - 'use_talos_json': True, 09:57:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:57:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:57:41 INFO - 'work_dir': 'build'} 09:57:41 INFO - [mozharness: 2016-11-10 17:57:41.909863Z] Running clobber step. 09:57:41 INFO - Running pre-action listener: _resource_record_pre_action 09:57:41 INFO - Running main action method: clobber 09:57:41 INFO - rmtree: /builds/slave/test/build 09:57:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:57:42 INFO - Running post-action listener: _resource_record_post_action 09:57:42 INFO - [mozharness: 2016-11-10 17:57:42.377422Z] Finished clobber step (success) 09:57:42 INFO - [mozharness: 2016-11-10 17:57:42.377521Z] Running read-buildbot-config step. 09:57:42 INFO - Running pre-action listener: _resource_record_pre_action 09:57:42 INFO - Running main action method: read_buildbot_config 09:57:42 INFO - Using buildbot properties: 09:57:42 INFO - { 09:57:42 INFO - "project": "", 09:57:42 INFO - "product": "firefox", 09:57:42 INFO - "script_repo_revision": "production", 09:57:42 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 09:57:42 INFO - "repository": "", 09:57:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 09:57:42 INFO - "buildid": "20161110094308", 09:57:42 INFO - "stage_platform": "linux64-pgo", 09:57:42 INFO - "basedir": "/builds/slave/test", 09:57:42 INFO - "buildnumber": 2033, 09:57:42 INFO - "platform": "ubuntu64_hw", 09:57:42 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:57:42 INFO - "slavebuilddir": "test", 09:57:42 INFO - "branch": "mozilla-inbound", 09:57:42 INFO - "revision": "3930bf2158788bc3681992d61cc0d26614c8b388", 09:57:42 INFO - "slavename": "talos-linux64-ix-036", 09:57:42 INFO - "builduid": "ad9a122615224237b86726736ce06593", 09:57:42 INFO - "repo_path": "integration/mozilla-inbound" 09:57:42 INFO - } 09:57:42 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478788690/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:57:42 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478788690/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 09:57:42 INFO - Running post-action listener: _resource_record_post_action 09:57:42 INFO - [mozharness: 2016-11-10 17:57:42.379853Z] Finished read-buildbot-config step (success) 09:57:42 INFO - [mozharness: 2016-11-10 17:57:42.379940Z] Running download-and-extract step. 09:57:42 INFO - Running pre-action listener: _resource_record_pre_action 09:57:42 INFO - Running main action method: download_and_extract 09:57:42 INFO - mkdir: /builds/slave/test/build/tests 09:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:42 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478788690/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:57:42 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478788690/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:57:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478788690/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:57:42 INFO - Downloaded 1361 bytes. 09:57:42 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:57:42 INFO - Using the following test package requirements: 09:57:42 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:57:42 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:57:42 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:57:42 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:42 INFO - u'jsshell-linux-x86_64.zip'], 09:57:42 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:57:42 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:57:42 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:57:42 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:57:42 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:57:42 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:57:42 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:57: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/1478788690/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:57: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/1478788690/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:57:42 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478788690/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:57:42 INFO - Http code: 200 09:57:42 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 09:57:42 INFO - x-amz-cf-id: e7cpz1uTtLApJ0va3wdAs4lm4cObYNDv_ASnogxTktUn9VPuCJcpsg== 09:57:42 INFO - x-amz-replication-status: COMPLETED 09:57:42 INFO - x-amz-version-id: srKlJM7zZV1pbVi9D2t5u.DARQyHlWhk 09:57:42 INFO - Expected file size: 21969968 09:57:42 INFO - Obtained file size: 21969968 09:57:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:57:46 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/1478788690/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:57:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478788690/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:57:46 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478788690/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:57:46 INFO - Http code: 200 09:57:46 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 09:57:46 INFO - x-amz-cf-id: rihV8Olr1hPSgYd5dN2ncWBIoLQMDeTnM5jYYnML4mfo5gWlxxMcMQ== 09:57:46 INFO - x-amz-replication-status: COMPLETED 09:57:46 INFO - x-amz-version-id: srKlJM7zZV1pbVi9D2t5u.DARQyHlWhk 09:57:47 INFO - Expected file size: 21969968 09:57:47 INFO - Obtained file size: 21969968 09:57:51 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/1478788690/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:57:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478788690/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:57:51 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478788690/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:57:51 INFO - Http code: 200 09:57:51 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 09:57:51 INFO - x-amz-cf-id: E1aGeSZr5I4_2AQXOhHEvoz0DCcFnG_nGkGqPL4ISC9xobvpAIwabA== 09:57:51 INFO - x-amz-replication-status: COMPLETED 09:57:51 INFO - x-amz-version-id: i7Zz9fMDrx7aTV_DIxoJg1nN_muWJrtN 09:57:51 INFO - Expected file size: 14409038 09:57:51 INFO - Obtained file size: 14409038 09:57:52 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')]} 09:57:52 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478788690/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:57:52 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478788690/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:57:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478788690/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:57:52 INFO - Downloaded 59337716 bytes. 09:57:52 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478788690/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:57:52 INFO - mkdir: /builds/slave/test/properties 09:57:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:57:52 INFO - Writing to file /builds/slave/test/properties/build_url 09:57:52 INFO - Contents: 09:57:52 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478788690/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:57:53 INFO - Running post-action listener: _resource_record_post_action 09:57:53 INFO - Running post-action listener: set_extra_try_arguments 09:57:53 INFO - [mozharness: 2016-11-10 17:57:53.216022Z] Finished download-and-extract step (success) 09:57:53 INFO - [mozharness: 2016-11-10 17:57:53.216247Z] Running populate-webroot step. 09:57:53 INFO - Running pre-action listener: _resource_record_pre_action 09:57:53 INFO - Running main action method: populate_webroot 09:57:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:57:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:57:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:57:53 INFO - '--tppagecycles', 09:57:53 INFO - '7'], 09:57:53 INFO - 'tests': ['tsvgm']}}, 09:57:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:57:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:57:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:57:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:57:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:53 INFO - 'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:53 INFO - 'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['damp', 'tps']}, 09:57:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:53 INFO - 'tests': ['damp', 'tps']}, 09:57:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['dromaeo_dom']}, 09:57:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:57:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['basic_compositor_video']}, 09:57:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:57:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['a11yr', 09:57:53 INFO - 'ts_paint', 09:57:53 INFO - 'tpaint', 09:57:53 INFO - 'sessionrestore', 09:57:53 INFO - 'sessionrestore_no_auto_restore', 09:57:53 INFO - 'tabpaint']}, 09:57:53 INFO - 'other-e10s': {'tests': ['a11yr', 09:57:53 INFO - 'ts_paint', 09:57:53 INFO - 'tpaint', 09:57:53 INFO - 'sessionrestore', 09:57:53 INFO - 'sessionrestore_no_auto_restore', 09:57:53 INFO - 'tabpaint']}, 09:57:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:57:53 INFO - 'ts_paint', 09:57:53 INFO - 'tpaint', 09:57:53 INFO - 'sessionrestore', 09:57:53 INFO - 'sessionrestore_no_auto_restore', 09:57:53 INFO - 'tabpaint']}, 09:57:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:57:53 INFO - 'ts_paint', 09:57:53 INFO - 'tpaint', 09:57:53 INFO - 'sessionrestore', 09:57:53 INFO - 'sessionrestore_no_auto_restore', 09:57:53 INFO - 'tabpaint']}, 09:57:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['a11yr', 09:57:53 INFO - 'ts_paint', 09:57:53 INFO - 'tpaint', 09:57:53 INFO - 'sessionrestore', 09:57:53 INFO - 'sessionrestore_no_auto_restore', 09:57:53 INFO - 'tabpaint']}, 09:57:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['a11yr', 09:57:53 INFO - 'ts_paint', 09:57:53 INFO - 'tpaint', 09:57:53 INFO - 'sessionrestore', 09:57:53 INFO - 'sessionrestore_no_auto_restore', 09:57:53 INFO - 'tabpaint']}, 09:57:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['tsvgx', 09:57:53 INFO - 'tsvgr_opacity', 09:57:53 INFO - 'tart', 09:57:53 INFO - 'tscrollx', 09:57:53 INFO - 'cart']}, 09:57:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:57:53 INFO - 'tsvgr_opacity', 09:57:53 INFO - 'tart', 09:57:53 INFO - 'tscrollx', 09:57:53 INFO - 'cart']}, 09:57:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:53 INFO - 'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['tp5o']}, 09:57:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:53 INFO - 'tests': ['tp5o']}, 09:57:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:53 INFO - 'talos_options': ['--disable-e10s', 09:57:53 INFO - '--xperf_path', 09:57:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:53 INFO - 'tests': ['tp5n']}, 09:57:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:53 INFO - 'talos_options': ['--xperf_path', 09:57:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:53 INFO - 'tests': ['tp5n']}}, 09:57:53 INFO - 'talos.zip': {'path': '', 09:57:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:57:53 INFO - Running post-action listener: _resource_record_post_action 09:57:53 INFO - [mozharness: 2016-11-10 17:57:53.232904Z] Finished populate-webroot step (success) 09:57:53 INFO - [mozharness: 2016-11-10 17:57:53.232991Z] Running create-virtualenv step. 09:57:53 INFO - Running pre-action listener: _resource_record_pre_action 09:57:53 INFO - Running main action method: create_virtualenv 09:57:53 INFO - Creating virtualenv /builds/slave/test/build/venv 09:57:53 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 09:57:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:57:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:57:53 INFO - Using real prefix '/usr' 09:57:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:57:53 INFO - Installing distribute.............................................................................................................................................................................................done. 09:57:55 INFO - Installing pip.................done. 09:57:55 INFO - Return code: 0 09:57:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:57:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:57:55 INFO - Reading from file tmpfile_stdout 09:57:55 INFO - Output received: 09:57:55 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) 09:57:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:57:55 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')]} 09:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:55 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')]} 09:57:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6e517eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e9f60>, '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 0x14ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb1d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', '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 09:57: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', 'pip>=1.5'] in /builds/slave/test/build 09:57: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 pip>=1.5 09:57:56 INFO - Using env: {'DISPLAY': ':0', 09:57:56 INFO - 'HOME': '/home/cltbld', 09:57:56 INFO - 'LANG': 'en_US.UTF-8', 09:57:56 INFO - 'LANGUAGE': 'en_US:en', 09:57:56 INFO - 'LOGNAME': 'cltbld', 09:57:56 INFO - 'MAIL': '/var/mail/cltbld', 09:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:56 INFO - 'MOZ_NO_REMOTE': '1', 09:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:56 INFO - 'NO_EM_RESTART': '1', 09:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:56 INFO - 'PWD': '/builds/slave/test', 09:57:56 INFO - 'SHELL': '/bin/bash', 09:57:56 INFO - 'SHLVL': '1', 09:57:56 INFO - 'TERM': 'linux', 09:57:56 INFO - 'TMOUT': '86400', 09:57:56 INFO - 'USER': 'cltbld', 09:57:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', 09:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:56 INFO - '_': '/tools/buildbot/bin/python'} 09:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:56 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 09:57:56 INFO - Cleaning up... 09:57:56 INFO - Return code: 0 09:57:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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', '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 0x7f6e517eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e9f60>, '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 0x14ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb1d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', '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 09:57: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', 'psutil>=3.1.1'] in /builds/slave/test/build 09:57: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 psutil>=3.1.1 09:57:56 INFO - Using env: {'DISPLAY': ':0', 09:57:56 INFO - 'HOME': '/home/cltbld', 09:57:56 INFO - 'LANG': 'en_US.UTF-8', 09:57:56 INFO - 'LANGUAGE': 'en_US:en', 09:57:56 INFO - 'LOGNAME': 'cltbld', 09:57:56 INFO - 'MAIL': '/var/mail/cltbld', 09:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:56 INFO - 'MOZ_NO_REMOTE': '1', 09:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:56 INFO - 'NO_EM_RESTART': '1', 09:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:56 INFO - 'PWD': '/builds/slave/test', 09:57:56 INFO - 'SHELL': '/bin/bash', 09:57:56 INFO - 'SHLVL': '1', 09:57:56 INFO - 'TERM': 'linux', 09:57:56 INFO - 'TMOUT': '86400', 09:57:56 INFO - 'USER': 'cltbld', 09:57:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', 09:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:56 INFO - '_': '/tools/buildbot/bin/python'} 09:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:56 INFO - Downloading/unpacking psutil>=3.1.1 09:57:56 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 09:57:56 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 09:57:56 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 09:57:56 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 09:57:56 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 09:57:56 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 09:57:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:57:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:58 INFO - Installing collected packages: psutil 09:57:58 INFO - Running setup.py install for psutil 09:57:58 INFO - building 'psutil._psutil_linux' extension 09:57:58 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 09:57:58 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 09:57:58 INFO - building 'psutil._psutil_posix' extension 09:57:58 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 09:57:58 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 09:57:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:58 INFO - Successfully installed psutil 09:57:58 INFO - Cleaning up... 09:57:59 INFO - Return code: 0 09:57:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6e517eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e9f60>, '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 0x14ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb1d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', '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 09:57: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:57: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 mozsystemmonitor==0.3 09:57:59 INFO - Using env: {'DISPLAY': ':0', 09:57:59 INFO - 'HOME': '/home/cltbld', 09:57:59 INFO - 'LANG': 'en_US.UTF-8', 09:57:59 INFO - 'LANGUAGE': 'en_US:en', 09:57:59 INFO - 'LOGNAME': 'cltbld', 09:57:59 INFO - 'MAIL': '/var/mail/cltbld', 09:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:59 INFO - 'MOZ_NO_REMOTE': '1', 09:57:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:59 INFO - 'NO_EM_RESTART': '1', 09:57:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:59 INFO - 'PWD': '/builds/slave/test', 09:57:59 INFO - 'SHELL': '/bin/bash', 09:57:59 INFO - 'SHLVL': '1', 09:57:59 INFO - 'TERM': 'linux', 09:57:59 INFO - 'TMOUT': '86400', 09:57:59 INFO - 'USER': 'cltbld', 09:57:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', 09:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:59 INFO - '_': '/tools/buildbot/bin/python'} 09:57:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:58:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:58:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:58:01 INFO - Installing collected packages: mozsystemmonitor 09:58:01 INFO - Running setup.py install for mozsystemmonitor 09:58:01 INFO - Successfully installed mozsystemmonitor 09:58:01 INFO - Cleaning up... 09:58:01 INFO - Return code: 0 09:58:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:58:01 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')]} 09:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:01 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')]} 09:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:01 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 0x7f6e517eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e9f60>, '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 0x14ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb1d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', '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 09:58:01 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 09:58:01 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 09:58:01 INFO - Using env: {'DISPLAY': ':0', 09:58:01 INFO - 'HOME': '/home/cltbld', 09:58:01 INFO - 'LANG': 'en_US.UTF-8', 09:58:01 INFO - 'LANGUAGE': 'en_US:en', 09:58:01 INFO - 'LOGNAME': 'cltbld', 09:58:01 INFO - 'MAIL': '/var/mail/cltbld', 09:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:01 INFO - 'MOZ_NO_REMOTE': '1', 09:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:01 INFO - 'NO_EM_RESTART': '1', 09:58:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:01 INFO - 'PWD': '/builds/slave/test', 09:58:01 INFO - 'SHELL': '/bin/bash', 09:58:01 INFO - 'SHLVL': '1', 09:58:01 INFO - 'TERM': 'linux', 09:58:01 INFO - 'TMOUT': '86400', 09:58:01 INFO - 'USER': 'cltbld', 09:58:01 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', 09:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:01 INFO - '_': '/tools/buildbot/bin/python'} 09:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:01 INFO - Downloading/unpacking jsonschema==2.5.1 09:58:01 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 09:58:01 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 09:58:01 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 09:58:01 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 09:58:01 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 09:58:01 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 09:58:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:58:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:58:03 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 09:58:03 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 09:58:03 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 09:58:03 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 09:58:03 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 09:58:03 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 09:58:03 INFO - Downloading functools32-3.2.3-2.tar.gz 09:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:58:03 INFO - warning: no files found matching '*.txt' 09:58:03 INFO - no previously-included directories found matching 'build' 09:58:03 INFO - no previously-included directories found matching 'dist' 09:58:03 INFO - no previously-included directories found matching '.git*' 09:58:03 INFO - Installing collected packages: jsonschema, functools32 09:58:03 INFO - Running setup.py install for functools32 09:58:03 INFO - warning: no files found matching '*.txt' 09:58:03 INFO - no previously-included directories found matching 'build' 09:58:03 INFO - no previously-included directories found matching 'dist' 09:58:03 INFO - no previously-included directories found matching '.git*' 09:58:03 INFO - Successfully installed jsonschema functools32 09:58:03 INFO - Cleaning up... 09:58:04 INFO - Return code: 0 09:58:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:58:04 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')]} 09:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:04 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')]} 09:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:04 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 0x7f6e517eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e9f60>, '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 0x14ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb1d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', '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 09:58:04 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 09:58:04 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 09:58:04 INFO - Using env: {'DISPLAY': ':0', 09:58:04 INFO - 'HOME': '/home/cltbld', 09:58:04 INFO - 'LANG': 'en_US.UTF-8', 09:58:04 INFO - 'LANGUAGE': 'en_US:en', 09:58:04 INFO - 'LOGNAME': 'cltbld', 09:58:04 INFO - 'MAIL': '/var/mail/cltbld', 09:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:04 INFO - 'MOZ_NO_REMOTE': '1', 09:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:04 INFO - 'NO_EM_RESTART': '1', 09:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:04 INFO - 'PWD': '/builds/slave/test', 09:58:04 INFO - 'SHELL': '/bin/bash', 09:58:04 INFO - 'SHLVL': '1', 09:58:04 INFO - 'TERM': 'linux', 09:58:04 INFO - 'TMOUT': '86400', 09:58:04 INFO - 'USER': 'cltbld', 09:58:04 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', 09:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:04 INFO - '_': '/tools/buildbot/bin/python'} 09:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:58:04 INFO - Cleaning up... 09:58:04 INFO - Return code: 0 09:58:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:58:04 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')]} 09:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:04 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')]} 09:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:04 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 0x7f6e517eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e9f60>, '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 0x14ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb1d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', '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 09:58:04 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 09:58:04 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 09:58:04 INFO - Using env: {'DISPLAY': ':0', 09:58:04 INFO - 'HOME': '/home/cltbld', 09:58:04 INFO - 'LANG': 'en_US.UTF-8', 09:58:04 INFO - 'LANGUAGE': 'en_US:en', 09:58:04 INFO - 'LOGNAME': 'cltbld', 09:58:04 INFO - 'MAIL': '/var/mail/cltbld', 09:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:04 INFO - 'MOZ_NO_REMOTE': '1', 09:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:04 INFO - 'NO_EM_RESTART': '1', 09:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:04 INFO - 'PWD': '/builds/slave/test', 09:58:04 INFO - 'SHELL': '/bin/bash', 09:58:04 INFO - 'SHLVL': '1', 09:58:04 INFO - 'TERM': 'linux', 09:58:04 INFO - 'TMOUT': '86400', 09:58:04 INFO - 'USER': 'cltbld', 09:58:04 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', 09:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:04 INFO - '_': '/tools/buildbot/bin/python'} 09:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:04 INFO - Downloading/unpacking blobuploader==1.2.4 09:58:04 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 09:58:04 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 09:58:04 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 09:58:04 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 09:58:04 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 09:58:04 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 09:58:06 INFO - Downloading blobuploader-1.2.4.tar.gz 09:58:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:58:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:58:06 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 09:58:06 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 09:58:06 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 09:58:06 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 09:58:06 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 09:58:06 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 09:58:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:58:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:58:06 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 09:58:06 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 09:58:06 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 09:58:06 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 09:58:06 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 09:58:06 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 09:58:07 INFO - Downloading docopt-0.6.1.tar.gz 09:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:58:07 INFO - Installing collected packages: blobuploader, requests, docopt 09:58:07 INFO - Running setup.py install for blobuploader 09:58:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:58:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:58:07 INFO - Running setup.py install for requests 09:58:07 INFO - Running setup.py install for docopt 09:58:07 INFO - Successfully installed blobuploader requests docopt 09:58:07 INFO - Cleaning up... 09:58:07 INFO - Return code: 0 09:58:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:07 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')]} 09:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:07 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')]} 09:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:07 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 0x7f6e517eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e9f60>, '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 0x14ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb1d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', '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 09:58:07 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 09:58:07 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 09:58:07 INFO - Using env: {'DISPLAY': ':0', 09:58:07 INFO - 'HOME': '/home/cltbld', 09:58:07 INFO - 'LANG': 'en_US.UTF-8', 09:58:07 INFO - 'LANGUAGE': 'en_US:en', 09:58:07 INFO - 'LOGNAME': 'cltbld', 09:58:07 INFO - 'MAIL': '/var/mail/cltbld', 09:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:07 INFO - 'MOZ_NO_REMOTE': '1', 09:58:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:07 INFO - 'NO_EM_RESTART': '1', 09:58:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:07 INFO - 'PWD': '/builds/slave/test', 09:58:07 INFO - 'SHELL': '/bin/bash', 09:58:07 INFO - 'SHLVL': '1', 09:58:07 INFO - 'TERM': 'linux', 09:58:07 INFO - 'TMOUT': '86400', 09:58:07 INFO - 'USER': 'cltbld', 09:58:07 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', 09:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:07 INFO - '_': '/tools/buildbot/bin/python'} 09:58:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:07 INFO - Running setup.py (path:/tmp/pip-p4PKtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:08 INFO - Running setup.py (path:/tmp/pip-xzUMod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:08 INFO - Running setup.py (path:/tmp/pip-1MB59I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:08 INFO - Running setup.py (path:/tmp/pip-kFNAop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:08 INFO - Running setup.py (path:/tmp/pip-MMmo1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:08 INFO - Running setup.py (path:/tmp/pip-WBrfcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:08 INFO - Running setup.py (path:/tmp/pip-G9c4dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:08 INFO - Running setup.py (path:/tmp/pip-6WB79g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:08 INFO - Running setup.py (path:/tmp/pip-A1cv4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:08 INFO - Running setup.py (path:/tmp/pip-T6bopt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:08 INFO - Running setup.py (path:/tmp/pip-lhMrsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:08 INFO - Running setup.py (path:/tmp/pip-KsaNa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:08 INFO - Running setup.py (path:/tmp/pip-RIeK3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:08 INFO - Running setup.py (path:/tmp/pip-M_DVGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:09 INFO - Running setup.py (path:/tmp/pip-cA7cr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:09 INFO - Running setup.py (path:/tmp/pip-hgvLU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:09 INFO - Running setup.py (path:/tmp/pip-Zc5I_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:58:09 INFO - Running setup.py install for manifestparser 09:58:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:58:09 INFO - Running setup.py install for mozcrash 09:58:09 INFO - Running setup.py install for mozdebug 09:58:09 INFO - Running setup.py install for mozdevice 09:58:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:58:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:58:09 INFO - Running setup.py install for mozfile 09:58:09 INFO - Running setup.py install for mozhttpd 09:58:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:58:09 INFO - Running setup.py install for mozinfo 09:58:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:58:09 INFO - Running setup.py install for mozInstall 09:58:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:58:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:58:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:58:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:58:10 INFO - Running setup.py install for mozleak 09:58:10 INFO - Running setup.py install for mozlog 09:58:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:58:10 INFO - Running setup.py install for moznetwork 09:58:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:58:10 INFO - Running setup.py install for mozprocess 09:58:10 INFO - Running setup.py install for mozprofile 09:58:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:58:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:58:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:58:10 INFO - Running setup.py install for mozrunner 09:58:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:58:10 INFO - Running setup.py install for mozscreenshot 09:58:10 INFO - Running setup.py install for moztest 09:58:10 INFO - Running setup.py install for mozversion 09:58:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:58:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:58:11 INFO - Cleaning up... 09:58:11 INFO - Return code: 0 09:58:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:11 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 0x7f6e517eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e9f60>, '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 0x14ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb1d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', '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 09:58:11 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 09:58:11 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 09:58:11 INFO - Using env: {'DISPLAY': ':0', 09:58:11 INFO - 'HOME': '/home/cltbld', 09:58:11 INFO - 'LANG': 'en_US.UTF-8', 09:58:11 INFO - 'LANGUAGE': 'en_US:en', 09:58:11 INFO - 'LOGNAME': 'cltbld', 09:58:11 INFO - 'MAIL': '/var/mail/cltbld', 09:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:11 INFO - 'MOZ_NO_REMOTE': '1', 09:58:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:11 INFO - 'NO_EM_RESTART': '1', 09:58:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:11 INFO - 'PWD': '/builds/slave/test', 09:58:11 INFO - 'SHELL': '/bin/bash', 09:58:11 INFO - 'SHLVL': '1', 09:58:11 INFO - 'TERM': 'linux', 09:58:11 INFO - 'TMOUT': '86400', 09:58:11 INFO - 'USER': 'cltbld', 09:58:11 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', 09:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:11 INFO - '_': '/tools/buildbot/bin/python'} 09:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:11 INFO - Running setup.py (path:/tmp/pip-UXHyX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:11 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)) 09:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:11 INFO - Running setup.py (path:/tmp/pip-U9ekah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:11 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)) 09:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:11 INFO - Running setup.py (path:/tmp/pip-NkaH9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:11 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)) 09:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:11 INFO - Running setup.py (path:/tmp/pip-cXqiNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:11 INFO - Running setup.py (path:/tmp/pip-F9Kemd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:11 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)) 09:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:11 INFO - Running setup.py (path:/tmp/pip-aki78w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:11 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)) 09:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:11 INFO - Running setup.py (path:/tmp/pip-Dkyme9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:11 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)) 09:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:11 INFO - Running setup.py (path:/tmp/pip-fn1B0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:11 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)) 09:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:11 INFO - Running setup.py (path:/tmp/pip-Al8_7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:11 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)) 09:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:11 INFO - Running setup.py (path:/tmp/pip-b5HHRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:12 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)) 09:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:12 INFO - Running setup.py (path:/tmp/pip-MjSHLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:12 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)) 09:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:12 INFO - Running setup.py (path:/tmp/pip-UpxT8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:12 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)) 09:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:12 INFO - Running setup.py (path:/tmp/pip-Zea7Pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:12 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)) 09:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:12 INFO - Running setup.py (path:/tmp/pip-6_zeVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:12 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)) 09:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:12 INFO - Running setup.py (path:/tmp/pip-PNOWJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:12 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)) 09:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:12 INFO - Running setup.py (path:/tmp/pip-1iYHuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:12 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)) 09:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:12 INFO - Running setup.py (path:/tmp/pip-BlDXCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:12 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)) 09:58:12 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)) 09:58:12 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)) 09:58:12 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)) 09:58:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58:12 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 09:58:12 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 09:58:12 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 09:58:12 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 09:58:12 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 09:58:12 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 09:58:14 INFO - Downloading blessings-1.6.tar.gz 09:58:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:58:14 INFO - Installing collected packages: blessings 09:58:14 INFO - Running setup.py install for blessings 09:58:14 INFO - Successfully installed blessings 09:58:14 INFO - Cleaning up... 09:58:14 INFO - Return code: 0 09:58:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:58:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:14 INFO - Reading from file tmpfile_stdout 09:58:14 INFO - Current package versions: 09:58:14 INFO - argparse == 1.2.1 09:58:14 INFO - blessings == 1.6 09:58:14 INFO - blobuploader == 1.2.4 09:58:14 INFO - docopt == 0.6.1 09:58:14 INFO - functools32 == 3.2.3-2 09:58:14 INFO - jsonschema == 2.5.1 09:58:14 INFO - manifestparser == 1.1 09:58:14 INFO - mozInstall == 1.12 09:58:14 INFO - mozcrash == 1.0 09:58:14 INFO - mozdebug == 0.1 09:58:14 INFO - mozdevice == 0.48 09:58:14 INFO - mozfile == 1.2 09:58:14 INFO - mozhttpd == 0.7 09:58:14 INFO - mozinfo == 0.9 09:58:14 INFO - mozleak == 0.1 09:58:14 INFO - mozlog == 3.4 09:58:14 INFO - moznetwork == 0.27 09:58:14 INFO - mozprocess == 0.23 09:58:14 INFO - mozprofile == 0.28 09:58:14 INFO - mozrunner == 6.13 09:58:14 INFO - mozscreenshot == 0.1 09:58:14 INFO - mozsystemmonitor == 0.3 09:58:14 INFO - moztest == 0.7 09:58:14 INFO - mozversion == 1.4 09:58:14 INFO - psutil == 3.1.1 09:58:14 INFO - requests == 1.2.3 09:58:14 INFO - wsgiref == 0.1.2 09:58:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:14 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 0x7f6e517eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e9f60>, '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 0x14ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb1d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', '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 09:58:14 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 09:58:14 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 09:58:14 INFO - Using env: {'DISPLAY': ':0', 09:58:14 INFO - 'HOME': '/home/cltbld', 09:58:14 INFO - 'LANG': 'en_US.UTF-8', 09:58:14 INFO - 'LANGUAGE': 'en_US:en', 09:58:14 INFO - 'LOGNAME': 'cltbld', 09:58:14 INFO - 'MAIL': '/var/mail/cltbld', 09:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:14 INFO - 'MOZ_NO_REMOTE': '1', 09:58:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:14 INFO - 'NO_EM_RESTART': '1', 09:58:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:14 INFO - 'PWD': '/builds/slave/test', 09:58:14 INFO - 'SHELL': '/bin/bash', 09:58:14 INFO - 'SHLVL': '1', 09:58:14 INFO - 'TERM': 'linux', 09:58:14 INFO - 'TMOUT': '86400', 09:58:14 INFO - 'USER': 'cltbld', 09:58:14 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', 09:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:14 INFO - '_': '/tools/buildbot/bin/python'} 09:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:15 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)) 09:58:15 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)) 09:58:15 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)) 09:58:15 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)) 09:58:15 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)) 09:58:15 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)) 09:58:15 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)) 09:58:15 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)) 09:58:15 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)) 09:58:15 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)) 09:58:15 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)) 09:58:15 INFO - Cleaning up... 09:58:15 INFO - Return code: 0 09:58:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:58:15 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')]} 09:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:15 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')]} 09:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:15 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 0x7f6e517eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e9f60>, '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 0x14ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb1d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', '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 09:58:15 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 09:58:15 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 09:58:15 INFO - Using env: {'DISPLAY': ':0', 09:58:15 INFO - 'HOME': '/home/cltbld', 09:58:15 INFO - 'LANG': 'en_US.UTF-8', 09:58:15 INFO - 'LANGUAGE': 'en_US:en', 09:58:15 INFO - 'LOGNAME': 'cltbld', 09:58:15 INFO - 'MAIL': '/var/mail/cltbld', 09:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:15 INFO - 'MOZ_NO_REMOTE': '1', 09:58:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:15 INFO - 'NO_EM_RESTART': '1', 09:58:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:15 INFO - 'PWD': '/builds/slave/test', 09:58:15 INFO - 'SHELL': '/bin/bash', 09:58:15 INFO - 'SHLVL': '1', 09:58:15 INFO - 'TERM': 'linux', 09:58:15 INFO - 'TMOUT': '86400', 09:58:15 INFO - 'USER': 'cltbld', 09:58:15 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', 09:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:15 INFO - '_': '/tools/buildbot/bin/python'} 09:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:58:15 INFO - Cleaning up... 09:58:15 INFO - Return code: 0 09:58:15 INFO - Running post-action listener: _resource_record_post_action 09:58:15 INFO - Running post-action listener: _start_resource_monitoring 09:58:15 INFO - Starting resource monitoring. 09:58:15 INFO - [mozharness: 2016-11-10 17:58:15.415317Z] Finished create-virtualenv step (success) 09:58:15 INFO - [mozharness: 2016-11-10 17:58:15.415837Z] Running install step. 09:58:15 INFO - Running pre-action listener: _resource_record_pre_action 09:58:15 INFO - Running main action method: install 09:58:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:15 INFO - Reading from file tmpfile_stdout 09:58:15 INFO - Detecting whether we're running mozinstall >=1.0... 09:58:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:58:15 INFO - Reading from file tmpfile_stdout 09:58:15 INFO - Output received: 09:58:15 INFO - Usage: mozinstall [options] installer 09:58:15 INFO - Options: 09:58:15 INFO - -h, --help show this help message and exit 09:58:15 INFO - -d DEST, --destination=DEST 09:58:15 INFO - Directory to install application into. [default: 09:58:15 INFO - "/builds/slave/test"] 09:58:15 INFO - --app=APP Application being installed. [default: firefox] 09:58:15 INFO - mkdir: /builds/slave/test/build/application 09:58:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:58:32 INFO - Reading from file tmpfile_stdout 09:58:32 INFO - Output received: 09:58:32 INFO - /builds/slave/test/build/application/firefox/firefox 09:58:32 INFO - Running post-action listener: _resource_record_post_action 09:58:32 INFO - [mozharness: 2016-11-10 17:58:32.565258Z] Finished install step (success) 09:58:32 INFO - [mozharness: 2016-11-10 17:58:32.565534Z] Running run-tests step. 09:58:32 INFO - Running pre-action listener: _resource_record_pre_action 09:58:32 INFO - Running main action method: run_tests 09:58:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:58:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:58:32 INFO - Python 2.7.3 09:58:32 INFO - Return code: 0 09:58:32 INFO - grabbing minidump binary from tooltool 09:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:32 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 0x14e9f60>, '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 0x14ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:58:32 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 09:58:32 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 09:58:32 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 09:58:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:58:32 INFO - Return code: 0 09:58:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:58:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:58:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:58:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:58:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:58:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478788690/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:58:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478788690/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:58:32 INFO - Using env: {'DISPLAY': ':0', 09:58:32 INFO - 'HOME': '/home/cltbld', 09:58:32 INFO - 'LANG': 'en_US.UTF-8', 09:58:32 INFO - 'LANGUAGE': 'en_US:en', 09:58:32 INFO - 'LOGNAME': 'cltbld', 09:58:32 INFO - 'MAIL': '/var/mail/cltbld', 09:58:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:58:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:32 INFO - 'MOZ_NO_REMOTE': '1', 09:58:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:32 INFO - 'NO_EM_RESTART': '1', 09:58:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:32 INFO - 'PWD': '/builds/slave/test', 09:58:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:58:32 INFO - 'SHELL': '/bin/bash', 09:58:32 INFO - 'SHLVL': '1', 09:58:32 INFO - 'TERM': 'linux', 09:58:32 INFO - 'TMOUT': '86400', 09:58:32 INFO - 'USER': 'cltbld', 09:58:32 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878', 09:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:32 INFO - '_': '/tools/buildbot/bin/python'} 09:58:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478788690/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:58:32 INFO - mozversion application_buildid: 20161110063810 09:58:32 INFO - mozversion application_changeset: 3930bf2158788bc3681992d61cc0d26614c8b388 09:58:32 INFO - mozversion application_display_name: Nightly 09:58:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:58:32 INFO - mozversion application_name: Firefox 09:58:32 INFO - mozversion application_remotingname: firefox 09:58:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:58:32 INFO - mozversion application_vendor: Mozilla 09:58:32 INFO - mozversion application_version: 52.0a1 09:58:32 INFO - mozversion platform_buildid: 20161110063810 09:58:32 INFO - mozversion platform_changeset: 3930bf2158788bc3681992d61cc0d26614c8b388 09:58:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:58:32 INFO - mozversion platform_version: 52.0a1 09:58:32 INFO - using testdate: 1478800712 09:58:32 INFO - actual date: 1478800712 09:58:32 INFO - starting webserver on 'localhost:50081' 09:58:32 INFO - SUITE-START | Running 2 tests 09:58:32 INFO - TEST-START | dromaeo_css 09:58:32 INFO - operating with platform_type : linux_ 09:58:32 INFO - Initialising browser for dromaeo_css test... 09:58:32 INFO - TEST-INFO | started process 1814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq34fjg/profile http://localhost:50081/getInfo.html) 09:58:37 INFO - PROCESS | 1814 | __metrics Screen width/height:1600/1200 09:58:37 INFO - PROCESS | 1814 | colorDepth:24 09:58:37 INFO - PROCESS | 1814 | Browser inner width/height: 1024/697 09:58:37 INFO - PROCESS | 1814 | __metrics 09:58:37 INFO - PROCESS | 1814 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:58:37 INFO - PROCESS | 1814 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:58:38 INFO - PROCESS | 1814 | console.error: PushService: 09:58:38 INFO - PROCESS | 1814 | stateChangeProcessEnqueue: Error transitioning state 09:58:38 INFO - PROCESS | 1814 | UnknownError 09:58:38 INFO - TEST-INFO | 1814: exit 0 09:58:38 INFO - Browser initialized. 09:58:38 INFO - Running cycle 1/1 for dromaeo_css test... 09:58:38 INFO - TEST-INFO | started process 1898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq34fjg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:51 INFO - PROCESS | 1898 | RSS: Main: 172986368 09:58:51 INFO - PROCESS | 1898 | 09:59:42 INFO - PROCESS | 1898 | 1478800782395 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] 10:01:52 INFO - PROCESS | 1898 | Cycle 1(1): loaded http://localhost:50081/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50081/tests/dromaeo/cssquery-ext.html) 10:01:54 INFO - PROCESS | 1898 | RSS: Main: 408297472 10:01:54 INFO - PROCESS | 1898 | 10:04:57 INFO - PROCESS | 1898 | Cycle 1(1): loaded http://localhost:50081/tests/dromaeo/cssquery-ext.html (next: http://localhost:50081/tests/dromaeo/cssquery-jquery.html) 10:04:57 INFO - PROCESS | 1898 | RSS: Main: 286240768 10:04:57 INFO - PROCESS | 1898 | 10:08:00 INFO - PROCESS | 1898 | Cycle 1(1): loaded http://localhost:50081/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50081/tests/dromaeo/cssquery-mootools.html) 10:08:00 INFO - PROCESS | 1898 | RSS: Main: 261783552 10:08:00 INFO - PROCESS | 1898 | 10:11:02 INFO - PROCESS | 1898 | Cycle 1(1): loaded http://localhost:50081/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50081/tests/dromaeo/cssquery-prototype.html) 10:11:03 INFO - PROCESS | 1898 | RSS: Main: 281632768 10:11:03 INFO - PROCESS | 1898 | 10:14:06 INFO - PROCESS | 1898 | Cycle 1(1): loaded http://localhost:50081/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50081/tests/dromaeo/cssquery-yui.html) 10:14:06 INFO - PROCESS | 1898 | RSS: Main: 220045312 10:14:06 INFO - PROCESS | 1898 | 10:17:10 INFO - PROCESS | 1898 | Cycle 1(1): loaded http://localhost:50081/tests/dromaeo/cssquery-yui.html (next: http://localhost:50081/tests/dromaeo/cssquery-dojo.html) 10:17:10 INFO - PROCESS | 1898 | RSS: Main: 315056128 10:17:10 INFO - PROCESS | 1898 | 10:17:10 INFO - PROCESS | 1898 | __start_tp_report 10:17:10 INFO - PROCESS | 1898 | _x_x_mozilla_page_load 10:17:10 INFO - PROCESS | 1898 | _x_x_mozilla_page_load_details 10:17:10 INFO - PROCESS | 1898 | |i|pagename|runs| 10:17:10 INFO - PROCESS | 1898 | |0;dojo.html;2972.895948641797;2994.955075673864;3018.396320735852;3027.545868119782;3034.9544756828636;5109.821156259532;5159.071367153911;5211.557017653495;5248.632595718302;5307.787688492465;5206.088934436478;5253;5257.23770053342;5263.631545791796;5359.222912677659;4737.218358970766;4773.594244489223;4780.617550595953;4801.783919723621;4814.951850481485;4766.2850572414245;4853.441854186778;4882.97558512207;4909.729964851932;4932.383452068491;4893.535114164149;4926.876828079308;4942.110420124376;4943.357363542752;4989.525995030466;4674.719516829001;4696.342512048316;4703.2239680452685;4766.404199475066;4825.348577941968;4702.952970470285;4709.740964246965;4729.692569982974;4738.644601654855;4741.857744267678;5220.634555581111;5245.082110630662;5271.578273738091;5271.841844744626;5272.499112584298;5556.666600004012;5556.833295001156;5569.860753481195;5573.749181286852;5578.776848926038;5416.431274716177;5595.300587426572;5595.440455954413;5604.635698679614;5653.547716182696;5149.819756308549;5204;5209.088409528355;5210.76551555181;5295.4969277918535;5685.914711279334;5689.6586204827845;5708.942910570924;5710.942890571041;5711.457411545896;5425.810096646598;5459.836204913859;5487.506124448739;5492.258545096441;5555.583331250173;5414.566834653218;5476.397596264408;5541.168824676251;5571.609987300931;5575.637583557056;5592.888142237214;5595.21666966625;5601.327840659065;5640.633358831663;5642.04085305499;5604.831855044274;5616;5621.4378562144275;5622.212890195376;5628.437156284339;4149.087200815816;4160.875173744793;4209.221294060609;4210.431591735138;4233.957660423356;3765.8493660253284;3773.6226377362595;3801.4107813288983;3804.6766024888193;3810.580836108026;5212.8957420851375;5260.237265596467;5264.131418315935;5268.236105764643;5272.815451459181;5368.194770784414;5477.972610137003;5566.944330556643;5568.192612071227;5631.155326700946;5233.947660523346;5246.527812496894;5279.41926388097;5302.655327403706;5359.812406565751;4716.3868697069165;4720.362751028636;4722.268048452495;4746.335513028179;4764;5820.185174075633;5825.50483208932;5833.795817146464;5839.474447299764;5840.94159058404;5460.972695136499;5503.064479038653;5540.168974653834;5602.439756024365;5624.100143976944;5804.709764511842;5824.621399609012;5826.446487583673;5853.0635098384055;5875.764969401176;5483.972580137074;5526.944730552643;5530.861728456821;5531.806386776443;5537.307836520435;5477.260569823182;5501.449855014626;5530.225768392348;5619.381867994435;5645.802396916089;5423.83728488146;5456.863578410572;5458.727063646881;5460.180972854104;5464.098423760194;5453.209284653783;5468.863278418072;5468.945310546844;5470.781168753365;5471;5442.945570544244;5449.972750136224;5460.781568737206;5461.344638643388;5463;5491.258680078298;5531.917021244604;5537.6954267515675;5541.806036788693;5550.111982082847;5430.891382172414;5472.097103977958;5479.589030822624;5527.336719593674;5577.27495425592 10:17:10 INFO - PROCESS | 1898 | |1;ext.html;598.0132780911497;616.2758758458812;625.6308777821084;636.522608043967;642.3480167629854;31662.52506212406;41207.58792412075;42049.369259461135;42257.36613950793;45476.77261613687;42933.35599966003;43307.3503897441;43387;43409;43447.131057378836;8564.443311184768;8597.785055373635;8680.30557555394;8708.782280443007;8710.085441028665;7945.96027019867;8040.638171282307;10057.748556286078;10258.435786031765;10268.383896966207;10342;10407.531661075232;10408.427536485491;10410.375377477376;10415.114715249212;10261.281710280284;10294.227932904987;10299.124574411184;10306.484675766256;10312.742181445448;10181.847272290921;10250.9487452563;10262.127719143882;10265.692029239135;10273.794524109477;40744.38883416751;40794.592054079374;41155;41210.793946030375;41252.793736031424;3325.617553981299;3325.783824051429;3422.247105636756;3441.5698037745283;3525.594556625995;30623.387532249453;30838.845805770827;30986;31127.37745245105;31647.84176079105;3919.2357490289405;4054.635082842529;4082.4692789937117;4161.791910404468;4168.520620128664;320376;320385;321412.3929380362;321838;322584.96735293936;53884.73057634687;54206.45793542014;54214;54269.45730542644;54295.76971914784;61222;61774.38225617686;61812.69093654503;61874;61913.690431547555;14269.714605708035;14409.495667651581;14455.78316325256;14461.927690361481;14469.78295325571;9160.770980725401;10823.621173259056;10879.619213327655;10885.564577416973;10890.237683362247;14313;16878.74681879773;17186.828131718772;17245.827541724673;18037;4917.582005529499;6163.8150855474405;6208.255009398901;6209.223847019122;6221.502279817604;953.8569214617725;1008.6923488335981;1037.7976294622476;1072.2815713471994;1109.606089838112;30654;31241.53137702936;31245.53131703026;31817.52273715896;31917.20206994844;1089.1667874076338;1090.5256213547132;1098.3135540287321;1134.2230572058168;1159.7100724818795;15774.605634859221;16602.75095873563;16634.833651663328;16669.66660666804;16696.582585435463;495589;497447;498767;498784;499262;50467;51674.22488662673;55022;56131;56324.71837640786;1294.8834604885417;1303.89568834493;1324.1591589340646;1330.0955350361653;1343.0598580993149;30344.241393964443;32896.342073158885;32905.341893162484;32929.34141317208;33283.500747488324;53225;59051.390117938725;59259.40740592539;59481.40518594759;59534.10698839434;419205;421546;421691;422384;422591;28004.159875203775;28228.435431290847;28327.858360708065;28625.856870716347;28629.141125766262;45624.31563526616;46314.76842615765;46688.29967550422;47857.76071119622;47944;39185.608143918194;39937.2012559753;39982.800085999384;41106.588934111474;41674;39906.00234994148;40321.395179072926;40654.59345406508;41715;41974.58025419707;39969.6448145704;40273;40326.798366007984;40618.390724139754;40724;33063.66936330606;35553.644463555036;36335.46891085618;36339.81830090833;36734.265314694094;26576.601350980138;27260.727392725817;27439.322934882017;27520;27572.310692232855 10:17:10 INFO - PROCESS | 1898 | |2;jquery.html;367.86389036056664;390.55281702450696;399.6203606573754;402.9315016447204;416.72079706596577;13026.478940842368;14887.776683349759;15865;18824.007372249023;18875.905620471913;17700.203490842912;18081.819181808212;18199.27202911882;18319.450416487525;18333.449996500094;5474.288342515468;5693.686847223401;5693.800716974907;5699.401562835905;5700.230468886689;5264.736763161845;5328.973355133219;5655.943440565604;5688.63023903445;5696.490430036044;5658.434156584329;5661.688607126606;5661.801836935708;5663.745131469073;5663.9433605664035;5376.247325374431;5536.086545719952;5566.916496252559;5585.692786896719;5607.943920560803;4868.318435419044;5007.12375334315;5011.84964451067;5013.097642424362;5042.117629414838;21924.561508769737;22257.22099726518;22346.329610111723;22379.992900319525;22415.215467458725;2188.245055455865;2312.6531020346915;2320.97679023211;2471.6910386201725;2536.720960694322;13441.32793360338;13527.526536571173;13594.524191653343;13643.863561364358;14429.206393648345;1852.4720454670355;1860.2187081425834;1869.5980364221757;1896.8861868287947;1968.4586738646844;77156;81377;91673;100466;105158.47420762847;16476.83523164777;16540.58648533772;16921.83078169227;17162.39931602413;18043.54891127706;31234.843825780725;31532.527012094837;31652.36695266128;31658.366832663218;31658.683413165574;8712.390132690778;8955.686550970684;9001.414908030956;9191.77020574491;9212.769680757901;6664.400203981568;7196.424286057103;7200.747973820891;7422.257774222642;7435.739749108755;8473.703420380258;8720.30237580992;8763.298936085097;8811.911880881238;8950.955245223733;3056.3085663506413;3177.7874255829797;3181.9522707159413;3509.771864828778;3523.048776830293;844.6536919862826;928;955.8996305387973;1014.7310962594918;1073.7798751255973;17311.56721081983;20135;20269.898650506948;20467.18131274762;20680.379588612366;958.3626888119462;978.9608415663293;980.1472718734603;984.1536278800226;1029.7322696099068;10364.5335959882;10685.358878467161;10857.51141198648;10863.782724345627;10871.619493317696;153099;335718;337400.1379820657;338277;338483;75742.24257757462;78945.60527197442;82463;90018;96368;459.8022850174457;498.0512124403018;501.5335737763842;503.1170296130268;504.34183390674787;10488.213383996079;10907.618233361794;10956.178286628694;10980.560777568808;11382.54469821198;37375;39578.802105989285;39797;40867;40921;53715.46284537261;53897.730511347196;55473.44526554683;56632.43367566436;57203;8242.546659933761;8468.57657117154;8528.957355213184;8765.868511972198;8801.339899507435;12266.632001039983;12395.75208495843;12575.748485030432;12696.746065078461;12905.806412903627;10963.671089867317;11150.553977840795;11386.146039046938;11494.540218391505;11868.347240901834;11188.608398706332;11199.72000699989;11337.659870203906;11342.886571134182;11417.344485049787;11163.72090697739;11264.887351126385;11292;11474.655760327203;11606.272525956225;8460;8516.787080323042;8656.182201737705;8722.91277087221;8896.911030889609;9857.704268871945;10872.130229581457;10994.120470362512;11210.831837522606;11394.601188958346 10:17:10 INFO - PROCESS | 1898 | |3;mootools.html;1419.6308959670482;1436.61929588659;1558.8051493563305;1698.4310256064218;1739.1565090930897;7123.287671232874;7334.96332518338;7490.138634057085;8029.558374289419;8034.437589368739;7557.357624601916;7794.37644988401;7801.492902961318;7946.92053079469;7953.244441778036;2272.1138755885218;2291.8968646410867;2298.9310320690324;2300.1719381022817;2301.033565902325;1980.2178139634907;2069.0999415254337;2208.9447763805874;2255.210676263303;2298.2415802785126;2182.8144607708364;2244.2481768607454;2247.5617254635354;2250.1336985260627;2262.6492893601517;2192.0574153114153;2195.6157672407267;2213.457702862809;2224.399412158708;2231.34175418252;2236.2061468178886;2258.841881068326;2284.303287497313;2286.691296674944;2287.645414960684;7728.845423091563;7787.805304867367;7921.128675845653;7925.247101525346;7926.80182995424;4780.402449693788;4898.975505122487;4899.632527560448;4900.877478063041;4905.681130726492;3228.8869889553753;3315.7015868571702;3334.249793796401;3396.6603339666085;3408.863645454179;1162.8430161928115;1180.6044974933407;1192.7375977284983;1211.1945556205112;2030.4416285521452;10427.374357538572;10741.731456713567;10792.676219713343;10805.243632945776;10815.891841081568;4084.7957602119777;4167.812448439828;4182.330827067715;4242.787860606957;4256.446661933991;8255;8315.251627353568;8319.916800831914;8343.582820858932;8345.248927596424;4777.140114779304;4785.234362501983;4810.4708482067645;4826;4827.951720482821;4457.77711114443;4550.726956382628;4551.362809206714;4553.1804275230115;4580.541945805393;3429.879954201641;3527.400341941876;3558.6085530591613;3570;3571.160777217352;1075.231209685079;1117.044926587772;1141.6118519703175;1144.7824913266452;1157.3923690062784;766.0692258905457;767.8157242261929;770.3298130626279;821.0393839208141;925.6251218256617;5178.223266510054;5196.8960620787375;5361.678299302054;5366.329208848894;5534.557235421156;937.8265020971143;983.3952119446488;991.8413053911484;993.9204863610894;1010.9696709098739;3681.9447708284397;3751.5685696144747;3767.3407153747985;3772.5661548921676;3902.9219415612097;9374.156325930562;9604.75988100289;9720.513974301257;9722.416655000723;9744.853827192455;9638.710838674851;9646.758831029281;9667.274954378308;9668.70993870185;9671.129598336183;7256.2743725627015;7410;7438.7024519019715;7445.516041457397;7454.589997550187;4956.603471722182;5034.501021789821;5145.430643653722;5183.870403239798;5464.535514481314;8626.09426010285;8629.050804411636;8638.17937295956;8668.696595619123;8805.075467075865;8634.395592308478;8878.112188781328;8939.642414303355;8943.731688049369;9001.819963600823;6694.832629184115;6889.2421833599265;6897.448204143757;6899.551529150589;6901.1718593769065;7341.889871652036;7350.044494215717;7375.114986201475;7430.777076687708;7448.329650331496;5505.779768809202;6740.662966851736;6791.0832037676255;6816.386525212754;6955.8956615649795;6614.834629134118;6620.304867988792;6668.499862510428;6669.2997235289595;6722.899156512558;6277.905831412624;6381.840453988688;6395.296517383177;6395.328490508616;6395.712192951235;4656.254999200111;4706.92939605913;4733.7396443194575;4764.3568118304975;4764.809407623657;4706.670533062653;4790.8323208687525;4854.538818812207;4955.578775803953;5035.949640503548 10:17:10 INFO - PROCESS | 1898 | |4;prototype.html;326.982814167973;336.46670028005616;338.13437599744657;342.73095619938323;344.55380282534117;4988.65079444439;5075.187969924813;5131.3842338919285;5151.639385243035;5188.273641690157;5089.262057001742;5131.33292671953;5133;5144.022635699214;5190.792368305263;4050.7772072536;4082.6121518455698;4098.426220329156;4102.405151253081;4108.691848111389;3865.845366185349;3934.4688467057013;3970.940435893464;4018.4575082363945;4027.6576490998154;4009.218202450523;4012.61880121388;4018.276710192179;4020.738651987626;4031.093004074089;3988.820503077354;4017.156397156586;4026.9194616107516;4027.3487869973465;4033.6890510583885;3406.097384193191;3475.287566048954;3481;3542.1852973816167;3558.6441355864467;4959.330490383788;4961.751912404401;4969.850904472835;4977.452480227172;4998.450170481244;4527.388802511652;4542.8864278392975;4552.725236933664;4556.567126123046;4558.49856515783;5038.74031492127;5274.657147285453;5306.630289765988;5308.601854860901;5348.358197016344;3893.669038131762;3904.511936007999;3905.218956208741;3909.2963266612;3918.8628398005935;5537.169424586304;5552.806146678484;5553.750081246354;5567.3040869891265;5567.47109024642;3857.9228415431535;3958.5051868516434;3992.540857801332;4010.438538604598;4012.057166565855;4020.2160578686876;4039.5152581690386;4042.4138499917935;4043.7169398142437;4043.7978101094827;4586.3579098926175;4590.747508886977;4591.150637132075;4593.770311484413;4615.953840461552;5103.464136265713;5317.494837990384;5359.14253719403;5364.517193452608;5377.623566350396;1333.2067419885152;1347.7574036673298;1348.7774517204748;1355.4307190979812;1358.6060042587737;867.6572753762229;904.0101089307198;907.2605826251583;912.3659056955485;920.2591913509689;4987.376577927759;4999.500049994971;5019.447860735316;5028.64799464034;5029.698218106925;5389.973050134803;5428.321459817523;5478.890422191614;5489.941272022991;5508.586855985817;5143.3570803649545;5156.009514481591;5168.586513078944;5184.948150518447;5210.843674689765;2716.4023914738727;2762.309422644339;2789.7768178545666;2792.2042217967783;2819.068937777588;5547.611667183259;5555.2778138842505;5566.997940370772;5574.049082821061;5581.469760372758;5458.808941687022;5460.5085542301385;5462.770876552744;5480.205370221375;5485.451454854483;5386.48828361305;5452.409163696225;5500.899820036009;5525.530329921841;5542.556595472433;5254.710990895537;5287.339082614673;5306.97346513265;5341.866453338697;5343.65266257692;5068.543831055223;5257.237700533477;5267.446918073547;5291.365036195682;5309.637211440871;5499.560035197094;5549.750261238173;5555.472230138131;5558.026900450282;5570.86072848182;3849.230153969161;3861.7489863158803;3866.7293289470595;3868.168343806095;3868.477755502971;5023.899522009612;5261.394939581997;5322.866928326823;5335.226392173191;5336.466353364788;5100.846974590768;5118.38579370478;5132.820351287687;5166.948330516647;5187.29971453864;5165.845024649267;5172.793088276427;5183.844484665466;5206.869828254324;5210.869728256824;4998.550130488274;5137.768800404066;5166.2508936204795;5171.965606878564;5194.974025130002;5135.281060651437;5162.922556161586;5175.534201921845;5183.263606691649;5224.242484839753;5057.595392368676;5161.174212126042;5185.092608793521;5297.258383826191;5306.336707911511 10:17:10 INFO - PROCESS | 1898 | |5;yui.html;649.5940037476577;664.8769977554152;720.3624792059029;735.6144311116392;754.773567929621;13937.581872543815;15169.848301516982;15185.772213416807;15191.620209494768;15203.999999999985;13473.258970756604;13551.728965420685;13714.93142534286;14365.78451323231;14530.782038269434;790.1190172957155;792.9048514178306;799.7960520067375;800.2597597222575;800.7877912353231;666.5234357434433;785.603270348476;788.696351904518;789.2186735132235;789.7986013566532;711.7971378157226;817.6238930092164;839.7228914458215;840.7855996720828;841.3773807382554;826.5040975414763;827.2554700769325;828.5608627427473;828.8176601147737;828.9709860154895;510.9208072748693;605.35832018061;605.4641642146688;605.4732382826969;605.5004621187538;10895.891041089646;12988.870111298955;13242.404091815892;13298.202107873558;13765.38055787492;13878.097923634932;13977.497557855288;14092.788608170886;14158.716825663532;14344.497942572065;10981.286216395909;11202.68665762501;11236.157288203336;11238.831417528743;11321.377324247163;3632.3643362411735;3653.6894363979095;3778.6977041836585;3780.546334439885;3801.030737162034;62271;64124.35875641231;64705;65762.67118664423;66381;10407.58369665205;10440.216983726252;10677.91780602775;10678.145748340114;10729.731756705989;19220.807791922183;19379.903100484407;19384.127714252892;19404.126814293108;19415;7869.724559640385;7904.841903161904;8008.359331253602;8209.58952052395;8287.917120828715;4209.621134097884;4220.493540775126;4334.783260836945;4345.521992580813;4508.887277818081;3307.570015897918;3361.436931826712;3383.7462190335823;3396.6603339665835;3397.677220664033;549.0885130683126;553.4161459660097;575.2148317546519;577.3101144132721;583.2272239282967;518.6291801362045;566.3628418029716;571.1946155920133;609.5763444406184;646.7089809585706;8345.44219238955;8394.202550757669;8661.30709543235;8755.868661970075;8892.73321800347;511.95648369888977;616.9105479705418;628.3936001758234;648.7210499485172;650.9153810004764;4254.085371645049;4318.330658747899;4384.6711496637245;4391.538888416734;4427.338767096639;90185;91237.54381228052;92806.53596732108;93168;95209.5239523798;50271.49728502668;69902.65048674724;77394.6130269345;81080;81194.59402702948;55396.72301638547;56692.149617755764;58631.120533192036;62299.99999999909;71959;8789.912100879164;9117;9257.67598134062;9332.253419726541;9350.625974960925;43125.56874431216;44025.55974440215;45096;46154.307685385415;46198.7690061561;62789.686051571276;63476;64591;64648.35351646423;66039.33960660332;10033.74915627086;10152.137068349273;10239.795204096024;10279.743006424898;10289.176865850864;12276.693082673004;12752.48990040425;13012.284324361872;13053.673658158623;13593.329800953885;11890.643280701594;12270.141090123963;12298.508059677513;12302.323372214614;12819.871801281868;11270.887291126985;12157.331346775658;12277.508899643914;12658.177218480769;12674.746505069663;11315.547378104784;11908.285502869856;12010;12038.819417708917;12398.442070106687;9654.420734755937;9670.516474176404;9688.70933871985;9955.800883982425;10564.947175264075;9824.80350392974;10070.295079344376;10349.84475232857;10357.74105647365;10400.115990140923 10:17:10 INFO - PROCESS | 1898 | __end_tp_report 10:17:10 INFO - PROCESS | 1898 | __start_cc_report 10:17:10 INFO - PROCESS | 1898 | _x_x_mozilla_cycle_collect,2372 10:17:10 INFO - PROCESS | 1898 | __end_cc_report 10:17:10 INFO - PROCESS | 1898 | __startTimestamp1478801830281__endTimestamp 10:17:10 INFO - PROCESS | 1898 | 10:17:10 INFO - PROCESS | 1898 | ------- Summary: start ------- 10:17:10 INFO - PROCESS | 1898 | Number of tests: 6 10:17:10 INFO - PROCESS | 1898 | 10:17:10 INFO - PROCESS | 1898 | [#0] dojo.html Cycles:165 Average:5198.57 Median:5449.97 stddev:594.55 (10.9%) stddev-sans-first:570.16 10:17:10 INFO - PROCESS | 1898 | Values: 2972.9 2995.0 3018.4 3027.5 3035.0 5109.8 5159.1 5211.6 5248.6 5307.8 5206.1 5253.0 5257.2 5263.6 5359.2 4737.2 4773.6 4780.6 4801.8 4815.0 4766.3 4853.4 4883.0 4909.7 4932.4 4893.5 4926.9 4942.1 4943.4 4989.5 4674.7 4696.3 4703.2 4766.4 4825.3 4703.0 4709.7 4729.7 4738.6 4741.9 5220.6 5245.1 5271.6 5271.8 5272.5 5556.7 5556.8 5569.9 5573.7 5578.8 5416.4 5595.3 5595.4 5604.6 5653.5 5149.8 5204.0 5209.1 5210.8 5295.5 5685.9 5689.7 5708.9 5710.9 5711.5 5425.8 5459.8 5487.5 5492.3 5555.6 5414.6 5476.4 5541.2 5571.6 5575.6 5592.9 5595.2 5601.3 5640.6 5642.0 5604.8 5616.0 5621.4 5622.2 5628.4 4149.1 4160.9 4209.2 4210.4 4234.0 3765.8 3773.6 3801.4 3804.7 3810.6 5212.9 5260.2 5264.1 5268.2 5272.8 5368.2 5478.0 5566.9 5568.2 5631.2 5233.9 5246.5 5279.4 5302.7 5359.8 4716.4 4720.4 4722.3 4746.3 4764.0 5820.2 5825.5 5833.8 5839.5 5840.9 5461.0 5503.1 5540.2 5602.4 5624.1 5804.7 5824.6 5826.4 5853.1 5875.8 5484.0 5526.9 5530.9 5531.8 5537.3 5477.3 5501.4 5530.2 5619.4 5645.8 5423.8 5456.9 5458.7 5460.2 5464.1 5453.2 5468.9 5468.9 5470.8 5471.0 5442.9 5450.0 5460.8 5461.3 5463.0 5491.3 5531.9 5537.7 5541.8 5550.1 5430.9 5472.1 5479.6 5527.3 5577.3 10:17:10 INFO - PROCESS | 1898 | 10:17:10 INFO - PROCESS | 1898 | [#1] ext.html Cycles:180 Average:57578.61 Median:36537.04 stddev:111134.95 (304.2%) stddev-sans-first:111364.36 10:17:10 INFO - PROCESS | 1898 | Values: 598.0 616.3 625.6 636.5 642.3 31662.5 41207.6 42049.4 42257.4 45476.8 42933.4 43307.4 43387.0 43409.0 43447.1 8564.4 8597.8 8680.3 8708.8 8710.1 7946.0 8040.6 10057.7 10258.4 10268.4 10342.0 10407.5 10408.4 10410.4 10415.1 10261.3 10294.2 10299.1 10306.5 10312.7 10181.8 10250.9 10262.1 10265.7 10273.8 40744.4 40794.6 41155.0 41210.8 41252.8 3325.6 3325.8 3422.2 3441.6 3525.6 30623.4 30838.8 30986.0 31127.4 31647.8 3919.2 4054.6 4082.5 4161.8 4168.5 320376.0 320385.0 321412.4 321838.0 322585.0 53884.7 54206.5 54214.0 54269.5 54295.8 61222.0 61774.4 61812.7 61874.0 61913.7 14269.7 14409.5 14455.8 14461.9 14469.8 9160.8 10823.6 10879.6 10885.6 10890.2 14313.0 16878.7 17186.8 17245.8 18037.0 4917.6 6163.8 6208.3 6209.2 6221.5 953.9 1008.7 1037.8 1072.3 1109.6 30654.0 31241.5 31245.5 31817.5 31917.2 1089.2 1090.5 1098.3 1134.2 1159.7 15774.6 16602.8 16634.8 16669.7 16696.6 495589.0 497447.0 498767.0 498784.0 499262.0 50467.0 51674.2 55022.0 56131.0 56324.7 1294.9 1303.9 1324.2 1330.1 1343.1 30344.2 32896.3 32905.3 32929.3 33283.5 53225.0 59051.4 59259.4 59481.4 59534.1 419205.0 421546.0 421691.0 422384.0 422591.0 28004.2 28228.4 28327.9 28625.9 28629.1 45624.3 46314.8 46688.3 47857.8 47944.0 39185.6 39937.2 39982.8 41106.6 41674.0 39906.0 40321.4 40654.6 41715.0 41974.6 39969.6 40273.0 40326.8 40618.4 40724.0 33063.7 35553.6 36335.5 36339.8 36734.3 26576.6 27260.7 27439.3 27520.0 27572.3 10:17:10 INFO - PROCESS | 1898 | 10:17:10 INFO - PROCESS | 1898 | [#2] jquery.html Cycles:180 Average:24148.99 Median:338380.00 stddev:52718.91 (15.6%) stddev-sans-first:52836.56 10:17:10 INFO - PROCESS | 1898 | Values: 367.9 390.6 399.6 402.9 416.7 13026.5 14887.8 15865.0 18824.0 18875.9 17700.2 18081.8 18199.3 18319.5 18333.4 5474.3 5693.7 5693.8 5699.4 5700.2 5264.7 5329.0 5655.9 5688.6 5696.5 5658.4 5661.7 5661.8 5663.7 5663.9 5376.2 5536.1 5566.9 5585.7 5607.9 4868.3 5007.1 5011.8 5013.1 5042.1 21924.6 22257.2 22346.3 22380.0 22415.2 2188.2 2312.7 2321.0 2471.7 2536.7 13441.3 13527.5 13594.5 13643.9 14429.2 1852.5 1860.2 1869.6 1896.9 1968.5 77156.0 81377.0 91673.0 100466.0 105158.5 16476.8 16540.6 16921.8 17162.4 18043.5 31234.8 31532.5 31652.4 31658.4 31658.7 8712.4 8955.7 9001.4 9191.8 9212.8 6664.4 7196.4 7200.7 7422.3 7435.7 8473.7 8720.3 8763.3 8811.9 8951.0 3056.3 3177.8 3182.0 3509.8 3523.0 844.7 928.0 955.9 1014.7 1073.8 17311.6 20135.0 20269.9 20467.2 20680.4 958.4 979.0 980.1 984.2 1029.7 10364.5 10685.4 10857.5 10863.8 10871.6 153099.0 335718.0 337400.1 338277.0 338483.0 75742.2 78945.6 82463.0 90018.0 96368.0 459.8 498.1 501.5 503.1 504.3 10488.2 10907.6 10956.2 10980.6 11382.5 37375.0 39578.8 39797.0 40867.0 40921.0 53715.5 53897.7 55473.4 56632.4 57203.0 8242.5 8468.6 8529.0 8765.9 8801.3 12266.6 12395.8 12575.7 12696.7 12905.8 10963.7 11150.6 11386.1 11494.5 11868.3 11188.6 11199.7 11337.7 11342.9 11417.3 11163.7 11264.9 11292.0 11474.7 11606.3 8460.0 8516.8 8656.2 8722.9 8896.9 9857.7 10872.1 10994.1 11210.8 11394.6 10:17:10 INFO - PROCESS | 1898 | 10:17:10 INFO - PROCESS | 1898 | [#3] mootools.html Cycles:180 Average:5181.59 Median:4995.55 stddev:2793.31 (55.9%) stddev-sans-first:2786.84 10:17:10 INFO - PROCESS | 1898 | Values: 1419.6 1436.6 1558.8 1698.4 1739.2 7123.3 7335.0 7490.1 8029.6 8034.4 7557.4 7794.4 7801.5 7946.9 7953.2 2272.1 2291.9 2298.9 2300.2 2301.0 1980.2 2069.1 2208.9 2255.2 2298.2 2182.8 2244.2 2247.6 2250.1 2262.6 2192.1 2195.6 2213.5 2224.4 2231.3 2236.2 2258.8 2284.3 2286.7 2287.6 7728.8 7787.8 7921.1 7925.2 7926.8 4780.4 4899.0 4899.6 4900.9 4905.7 3228.9 3315.7 3334.2 3396.7 3408.9 1162.8 1180.6 1192.7 1211.2 2030.4 10427.4 10741.7 10792.7 10805.2 10815.9 4084.8 4167.8 4182.3 4242.8 4256.4 8255.0 8315.3 8319.9 8343.6 8345.2 4777.1 4785.2 4810.5 4826.0 4828.0 4457.8 4550.7 4551.4 4553.2 4580.5 3429.9 3527.4 3558.6 3570.0 3571.2 1075.2 1117.0 1141.6 1144.8 1157.4 766.1 767.8 770.3 821.0 925.6 5178.2 5196.9 5361.7 5366.3 5534.6 937.8 983.4 991.8 993.9 1011.0 3681.9 3751.6 3767.3 3772.6 3902.9 9374.2 9604.8 9720.5 9722.4 9744.9 9638.7 9646.8 9667.3 9668.7 9671.1 7256.3 7410.0 7438.7 7445.5 7454.6 4956.6 5034.5 5145.4 5183.9 5464.5 8626.1 8629.1 8638.2 8668.7 8805.1 8634.4 8878.1 8939.6 8943.7 9001.8 6694.8 6889.2 6897.4 6899.6 6901.2 7341.9 7350.0 7375.1 7430.8 7448.3 5505.8 6740.7 6791.1 6816.4 6955.9 6614.8 6620.3 6668.5 6669.3 6722.9 6277.9 6381.8 6395.3 6395.3 6395.7 4656.3 4706.9 4733.7 4764.4 4764.8 4706.7 4790.8 4854.5 4955.6 5035.9 10:17:10 INFO - PROCESS | 1898 | 10:17:10 INFO - PROCESS | 1898 | [#4] prototype.html Cycles:180 Average:4459.65 Median:5124.86 stddev:1289.27 (25.2%) stddev-sans-first:1255.02 10:17:10 INFO - PROCESS | 1898 | Values: 327.0 336.5 338.1 342.7 344.6 4988.7 5075.2 5131.4 5151.6 5188.3 5089.3 5131.3 5133.0 5144.0 5190.8 4050.8 4082.6 4098.4 4102.4 4108.7 3865.8 3934.5 3970.9 4018.5 4027.7 4009.2 4012.6 4018.3 4020.7 4031.1 3988.8 4017.2 4026.9 4027.3 4033.7 3406.1 3475.3 3481.0 3542.2 3558.6 4959.3 4961.8 4969.9 4977.5 4998.5 4527.4 4542.9 4552.7 4556.6 4558.5 5038.7 5274.7 5306.6 5308.6 5348.4 3893.7 3904.5 3905.2 3909.3 3918.9 5537.2 5552.8 5553.8 5567.3 5567.5 3857.9 3958.5 3992.5 4010.4 4012.1 4020.2 4039.5 4042.4 4043.7 4043.8 4586.4 4590.7 4591.2 4593.8 4616.0 5103.5 5317.5 5359.1 5364.5 5377.6 1333.2 1347.8 1348.8 1355.4 1358.6 867.7 904.0 907.3 912.4 920.3 4987.4 4999.5 5019.4 5028.6 5029.7 5390.0 5428.3 5478.9 5489.9 5508.6 5143.4 5156.0 5168.6 5184.9 5210.8 2716.4 2762.3 2789.8 2792.2 2819.1 5547.6 5555.3 5567.0 5574.0 5581.5 5458.8 5460.5 5462.8 5480.2 5485.5 5386.5 5452.4 5500.9 5525.5 5542.6 5254.7 5287.3 5307.0 5341.9 5343.7 5068.5 5257.2 5267.4 5291.4 5309.6 5499.6 5549.8 5555.5 5558.0 5570.9 3849.2 3861.7 3866.7 3868.2 3868.5 5023.9 5261.4 5322.9 5335.2 5336.5 5100.8 5118.4 5132.8 5166.9 5187.3 5165.8 5172.8 5183.8 5206.9 5210.9 4998.6 5137.8 5166.3 5172.0 5195.0 5135.3 5162.9 5175.5 5183.3 5224.2 5057.6 5161.2 5185.1 5297.3 5306.3 10:17:10 INFO - PROCESS | 1898 | 10:17:10 INFO - PROCESS | 1898 | [#5] yui.html Cycles:180 Average:17329.67 Median:25391.21 stddev:23494.78 (92.5%) stddev-sans-first:23527.30 10:17:10 INFO - PROCESS | 1898 | Values: 649.6 664.9 720.4 735.6 754.8 13937.6 15169.8 15185.8 15191.6 15204.0 13473.3 13551.7 13714.9 14365.8 14530.8 790.1 792.9 799.8 800.3 800.8 666.5 785.6 788.7 789.2 789.8 711.8 817.6 839.7 840.8 841.4 826.5 827.3 828.6 828.8 829.0 510.9 605.4 605.5 605.5 605.5 10895.9 12988.9 13242.4 13298.2 13765.4 13878.1 13977.5 14092.8 14158.7 14344.5 10981.3 11202.7 11236.2 11238.8 11321.4 3632.4 3653.7 3778.7 3780.5 3801.0 62271.0 64124.4 64705.0 65762.7 66381.0 10407.6 10440.2 10677.9 10678.1 10729.7 19220.8 19379.9 19384.1 19404.1 19415.0 7869.7 7904.8 8008.4 8209.6 8287.9 4209.6 4220.5 4334.8 4345.5 4508.9 3307.6 3361.4 3383.7 3396.7 3397.7 549.1 553.4 575.2 577.3 583.2 518.6 566.4 571.2 609.6 646.7 8345.4 8394.2 8661.3 8755.9 8892.7 512.0 616.9 628.4 648.7 650.9 4254.1 4318.3 4384.7 4391.5 4427.3 90185.0 91237.5 92806.5 93168.0 95209.5 50271.5 69902.7 77394.6 81080.0 81194.6 55396.7 56692.1 58631.1 62300.0 71959.0 8789.9 9117.0 9257.7 9332.3 9350.6 43125.6 44025.6 45096.0 46154.3 46198.8 62789.7 63476.0 64591.0 64648.4 66039.3 10033.7 10152.1 10239.8 10279.7 10289.2 12276.7 12752.5 13012.3 13053.7 13593.3 11890.6 12270.1 12298.5 12302.3 12819.9 11270.9 12157.3 12277.5 12658.2 12674.7 11315.5 11908.3 12010.0 12038.8 12398.4 9654.4 9670.5 9688.7 9955.8 10564.9 9824.8 10070.3 10349.8 10357.7 10400.1 10:17:10 INFO - PROCESS | 1898 | -------- Summary: end -------- 10:17:10 INFO - PROCESS | 1898 | 10:17:11 INFO - TEST-INFO | 1898: exit 0 10:17:11 INFO - TEST-OK | dromaeo_css | took 1118438ms 10:17:11 INFO - TEST-START | kraken 10:17:11 INFO - operating with platform_type : linux_ 10:17:11 INFO - Initialising browser for kraken test... 10:17:11 INFO - TEST-INFO | started process 2213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaaVgho/profile http://localhost:50081/getInfo.html) 10:17:15 INFO - PROCESS | 2213 | __metrics Screen width/height:1600/1200 10:17:15 INFO - PROCESS | 2213 | colorDepth:24 10:17:15 INFO - PROCESS | 2213 | Browser inner width/height: 1024/697 10:17:15 INFO - PROCESS | 2213 | __metrics 10:17:16 INFO - PROCESS | 2213 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:17:16 INFO - PROCESS | 2213 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:17:16 INFO - PROCESS | 2213 | console.error: PushService: 10:17:16 INFO - PROCESS | 2213 | stateChangeProcessEnqueue: Error transitioning state 10:17:16 INFO - PROCESS | 2213 | UnknownError 10:17:17 INFO - TEST-INFO | 2213: exit 0 10:17:17 INFO - Browser initialized. 10:17:17 INFO - Running cycle 1/1 for kraken test... 10:17:17 INFO - TEST-INFO | started process 2298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaaVgho/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:17:29 INFO - PROCESS | 2298 | RSS: Main: 172548096 10:17:29 INFO - PROCESS | 2298 | 10:17:32 INFO - PROCESS | 2298 | Cycle 1(1): loaded http://localhost:50081/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50081/tests/kraken/driver.html?testName=audio-beat-detection) 10:17:33 INFO - PROCESS | 2298 | RSS: Main: 238276608 10:17:33 INFO - PROCESS | 2298 | 10:17:35 INFO - PROCESS | 2298 | Cycle 1(1): loaded http://localhost:50081/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50081/tests/kraken/driver.html?testName=audio-dft) 10:17:36 INFO - PROCESS | 2298 | RSS: Main: 216055808 10:17:36 INFO - PROCESS | 2298 | 10:17:39 INFO - PROCESS | 2298 | Cycle 1(1): loaded http://localhost:50081/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50081/tests/kraken/driver.html?testName=audio-fft) 10:17:39 INFO - PROCESS | 2298 | RSS: Main: 297611264 10:17:39 INFO - PROCESS | 2298 | 10:17:42 INFO - PROCESS | 2298 | Cycle 1(1): loaded http://localhost:50081/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50081/tests/kraken/driver.html?testName=audio-oscillator) 10:17:42 INFO - PROCESS | 2298 | RSS: Main: 206880768 10:17:42 INFO - PROCESS | 2298 | 10:17:44 INFO - PROCESS | 2298 | Cycle 1(1): loaded http://localhost:50081/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50081/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:17:45 INFO - PROCESS | 2298 | RSS: Main: 212180992 10:17:45 INFO - PROCESS | 2298 | 10:17:48 INFO - PROCESS | 2298 | Cycle 1(1): loaded http://localhost:50081/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50081/tests/kraken/driver.html?testName=imaging-darkroom) 10:17:48 INFO - PROCESS | 2298 | RSS: Main: 248295424 10:17:48 INFO - PROCESS | 2298 | 10:17:52 INFO - PROCESS | 2298 | Cycle 1(1): loaded http://localhost:50081/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50081/tests/kraken/driver.html?testName=imaging-desaturate) 10:17:52 INFO - PROCESS | 2298 | RSS: Main: 247054336 10:17:52 INFO - PROCESS | 2298 | 10:17:55 INFO - PROCESS | 2298 | Cycle 1(1): loaded http://localhost:50081/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50081/tests/kraken/driver.html?testName=json-parse-financial) 10:17:56 INFO - PROCESS | 2298 | RSS: Main: 246083584 10:17:56 INFO - PROCESS | 2298 | 10:17:57 INFO - PROCESS | 2298 | Cycle 1(1): loaded http://localhost:50081/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50081/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:17:58 INFO - PROCESS | 2298 | RSS: Main: 209076224 10:17:58 INFO - PROCESS | 2298 | 10:18:00 INFO - PROCESS | 2298 | Cycle 1(1): loaded http://localhost:50081/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50081/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:18:00 INFO - PROCESS | 2298 | RSS: Main: 215674880 10:18:00 INFO - PROCESS | 2298 | 10:18:02 INFO - PROCESS | 2298 | Cycle 1(1): loaded http://localhost:50081/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50081/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:18:03 INFO - PROCESS | 2298 | RSS: Main: 224641024 10:18:03 INFO - PROCESS | 2298 | 10:18:05 INFO - PROCESS | 2298 | Cycle 1(1): loaded http://localhost:50081/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:18:06 INFO - PROCESS | 2298 | RSS: Main: 233390080 10:18:06 INFO - PROCESS | 2298 | 10:18:09 INFO - PROCESS | 2298 | Cycle 1(1): loaded http://localhost:50081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:18:09 INFO - PROCESS | 2298 | RSS: Main: 231280640 10:18:09 INFO - PROCESS | 2298 | 10:18:11 INFO - PROCESS | 2298 | Cycle 1(1): loaded http://localhost:50081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50081/tests/kraken/driver.html?testName=ai-astar) 10:18:11 INFO - PROCESS | 2298 | RSS: Main: 281735168 10:18:11 INFO - PROCESS | 2298 | 10:18:11 INFO - PROCESS | 2298 | __start_tp_report 10:18:11 INFO - PROCESS | 2298 | _x_x_mozilla_page_load 10:18:11 INFO - PROCESS | 2298 | _x_x_mozilla_page_load_details 10:18:11 INFO - PROCESS | 2298 | |i|pagename|runs| 10:18:11 INFO - PROCESS | 2298 | |0;ai-astar;106;113;112;113;114;114;111;111;114;112 10:18:11 INFO - PROCESS | 2298 | |1;audio-beat-detection;148;125;124;155;124;132;122;123;159;126 10:18:11 INFO - PROCESS | 2298 | |2;audio-dft;163;163;162;162;163;163;163;161;161;161 10:18:11 INFO - PROCESS | 2298 | |3;audio-fft;75;76;76;112;75;76;76;75;101;75 10:18:11 INFO - PROCESS | 2298 | |4;audio-oscillator;82;82;107;82;83;83;100;83;83;124 10:18:11 INFO - PROCESS | 2298 | |5;imaging-gaussian-blur;117;116;116;116;117;117;117;116;116;116 10:18:11 INFO - PROCESS | 2298 | |6;imaging-darkroom;145;146;146;146;145;146;147;148;146;146 10:18:11 INFO - PROCESS | 2298 | |7;imaging-desaturate;84;85;85;84;85;90;85;84;84;84 10:18:11 INFO - PROCESS | 2298 | |8;json-parse-financial;51;50;50;51;51;54;58;52;52;52 10:18:11 INFO - PROCESS | 2298 | |9;json-stringify-tinderbox;64;63;64;64;65;64;64;64;64;64 10:18:11 INFO - PROCESS | 2298 | |10;stanford-crypto-aes;80;87;80;87;80;79;89;79;79;81 10:18:11 INFO - PROCESS | 2298 | |11;stanford-crypto-ccm;128;137;133;130;129;128;128;139;173;145 10:18:11 INFO - PROCESS | 2298 | |12;stanford-crypto-pbkdf2;163;164;168;164;163;165;170;167;167;163 10:18:11 INFO - PROCESS | 2298 | |13;stanford-crypto-sha256-iterative;66;65;64;64;66;66;66;63;64;78 10:18:11 INFO - PROCESS | 2298 | __end_tp_report 10:18:11 INFO - PROCESS | 2298 | __start_cc_report 10:18:11 INFO - PROCESS | 2298 | _x_x_mozilla_cycle_collect,1665 10:18:11 INFO - PROCESS | 2298 | __end_cc_report 10:18:11 INFO - PROCESS | 2298 | __startTimestamp1478801891931__endTimestamp 10:18:11 INFO - PROCESS | 2298 | 10:18:11 INFO - PROCESS | 2298 | ------- Summary: start ------- 10:18:11 INFO - PROCESS | 2298 | Number of tests: 14 10:18:11 INFO - PROCESS | 2298 | 10:18:11 INFO - PROCESS | 2298 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.40 (2.1%) stddev-sans-first:1.22 10:18:11 INFO - PROCESS | 2298 | Values: 106.0 113.0 112.0 113.0 114.0 114.0 111.0 111.0 114.0 112.0 10:18:11 INFO - PROCESS | 2298 | 10:18:11 INFO - PROCESS | 2298 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:129.00 stddev:14.44 (11.2%) stddev-sans-first:14.37 10:18:11 INFO - PROCESS | 2298 | Values: 148.0 125.0 124.0 155.0 124.0 132.0 122.0 123.0 159.0 126.0 10:18:11 INFO - PROCESS | 2298 | 10:18:11 INFO - PROCESS | 2298 | [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 10:18:11 INFO - PROCESS | 2298 | Values: 163.0 163.0 162.0 162.0 163.0 163.0 163.0 161.0 161.0 161.0 10:18:11 INFO - PROCESS | 2298 | 10:18:11 INFO - PROCESS | 2298 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.50 stddev:13.33 (17.7%) stddev-sans-first:13.92 10:18:11 INFO - PROCESS | 2298 | Values: 75.0 76.0 76.0 112.0 75.0 76.0 76.0 75.0 101.0 75.0 10:18:11 INFO - PROCESS | 2298 | 10:18:11 INFO - PROCESS | 2298 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:82.50 stddev:14.62 (17.7%) stddev-sans-first:15.15 10:18:11 INFO - PROCESS | 2298 | Values: 82.0 82.0 107.0 82.0 83.0 83.0 100.0 83.0 83.0 124.0 10:18:11 INFO - PROCESS | 2298 | 10:18:11 INFO - PROCESS | 2298 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:18:11 INFO - PROCESS | 2298 | Values: 117.0 116.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 116.0 10:18:11 INFO - PROCESS | 2298 | 10:18:11 INFO - PROCESS | 2298 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 10:18:11 INFO - PROCESS | 2298 | Values: 145.0 146.0 146.0 146.0 145.0 146.0 147.0 148.0 146.0 146.0 10:18:11 INFO - PROCESS | 2298 | 10:18:11 INFO - PROCESS | 2298 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:1.83 (2.1%) stddev-sans-first:1.90 10:18:11 INFO - PROCESS | 2298 | Values: 84.0 85.0 85.0 84.0 85.0 90.0 85.0 84.0 84.0 84.0 10:18:11 INFO - PROCESS | 2298 | 10:18:11 INFO - PROCESS | 2298 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:2.38 (4.6%) stddev-sans-first:2.49 10:18:11 INFO - PROCESS | 2298 | Values: 51.0 50.0 50.0 51.0 51.0 54.0 58.0 52.0 52.0 52.0 10:18:11 INFO - PROCESS | 2298 | 10:18:11 INFO - PROCESS | 2298 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 10:18:11 INFO - PROCESS | 2298 | Values: 64.0 63.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 64.0 10:18:11 INFO - PROCESS | 2298 | 10:18:11 INFO - PROCESS | 2298 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:80.50 stddev:3.93 (4.9%) stddev-sans-first:4.09 10:18:11 INFO - PROCESS | 2298 | Values: 80.0 87.0 80.0 87.0 80.0 79.0 89.0 79.0 79.0 81.0 10:18:11 INFO - PROCESS | 2298 | 10:18:11 INFO - PROCESS | 2298 | [#11] stanford-crypto-ccm Cycles:10 Average:137.00 Median:135.00 stddev:13.89 (10.3%) stddev-sans-first:14.34 10:18:11 INFO - PROCESS | 2298 | Values: 128.0 137.0 133.0 130.0 129.0 128.0 128.0 139.0 173.0 145.0 10:18:11 INFO - PROCESS | 2298 | 10:18:11 INFO - PROCESS | 2298 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.40 Median:166.00 stddev:2.46 (1.5%) stddev-sans-first:2.45 10:18:11 INFO - PROCESS | 2298 | Values: 163.0 164.0 168.0 164.0 163.0 165.0 170.0 167.0 167.0 163.0 10:18:11 INFO - PROCESS | 2298 | 10:18:11 INFO - PROCESS | 2298 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:4.29 (6.5%) stddev-sans-first:4.55 10:18:11 INFO - PROCESS | 2298 | Values: 66.0 65.0 64.0 64.0 66.0 66.0 66.0 63.0 64.0 78.0 10:18:11 INFO - PROCESS | 2298 | -------- Summary: end -------- 10:18:11 INFO - PROCESS | 2298 | 10:18:13 INFO - TEST-INFO | 2298: exit 0 10:18:13 INFO - TEST-OK | kraken | took 61924ms 10:18:13 INFO - SUITE-END | took 1180s 10:18:13 INFO - Completed test suite (00:19:40) 10:18:13 INFO - javascript benchmark 10:18:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2972.895948641797, 2994.955075673864, 3018.396320735852, 3027.545868119782, 3034.9544756828636, 5109.821156259532, 5159.071367153911, 5211.557017653495, 5248.632595718302, 5307.787688492465, 5206.088934436478, 5253.0, 5257.23770053342, 5263.631545791796, 5359.222912677659, 4737.218358970766, 4773.594244489223, 4780.617550595953, 4801.783919723621, 4814.951850481485, 4766.2850572414245, 4853.441854186778, 4882.97558512207, 4909.729964851932, 4932.383452068491, 4893.535114164149, 4926.876828079308, 4942.110420124376, 4943.357363542752, 4989.525995030466, 4674.719516829001, 4696.342512048316, 4703.2239680452685, 4766.404199475066, 4825.348577941968, 4702.952970470285, 4709.740964246965, 4729.692569982974, 4738.644601654855, 4741.857744267678, 5220.634555581111, 5245.082110630662, 5271.578273738091, 5271.841844744626, 5272.499112584298, 5556.666600004012, 5556.833295001156, 5569.860753481195, 5573.749181286852, 5578.776848926038, 5416.431274716177, 5595.300587426572, 5595.440455954413, 5604.635698679614, 5653.547716182696, 5149.819756308549, 5204.0, 5209.088409528355, 5210.76551555181, 5295.4969277918535, 5685.914711279334, 5689.6586204827845, 5708.942910570924, 5710.942890571041, 5711.457411545896, 5425.810096646598, 5459.836204913859, 5487.506124448739, 5492.258545096441, 5555.583331250173, 5414.566834653218, 5476.397596264408, 5541.168824676251, 5571.609987300931, 5575.637583557056, 5592.888142237214, 5595.21666966625, 5601.327840659065, 5640.633358831663, 5642.04085305499, 5604.831855044274, 5616.0, 5621.4378562144275, 5622.212890195376, 5628.437156284339, 4149.087200815816, 4160.875173744793, 4209.221294060609, 4210.431591735138, 4233.957660423356, 3765.8493660253284, 3773.6226377362595, 3801.4107813288983, 3804.6766024888193, 3810.580836108026, 5212.8957420851375, 5260.237265596467, 5264.131418315935, 5268.236105764643, 5272.815451459181, 5368.194770784414, 5477.972610137003, 5566.944330556643, 5568.192612071227, 5631.155326700946, 5233.947660523346, 5246.527812496894, 5279.41926388097, 5302.655327403706, 5359.812406565751, 4716.3868697069165, 4720.362751028636, 4722.268048452495, 4746.335513028179, 4764.0, 5820.185174075633, 5825.50483208932, 5833.795817146464, 5839.474447299764, 5840.94159058404, 5460.972695136499, 5503.064479038653, 5540.168974653834, 5602.439756024365, 5624.100143976944, 5804.709764511842, 5824.621399609012, 5826.446487583673, 5853.0635098384055, 5875.764969401176, 5483.972580137074, 5526.944730552643, 5530.861728456821, 5531.806386776443, 5537.307836520435, 5477.260569823182, 5501.449855014626, 5530.225768392348, 5619.381867994435, 5645.802396916089, 5423.83728488146, 5456.863578410572, 5458.727063646881, 5460.180972854104, 5464.098423760194, 5453.209284653783, 5468.863278418072, 5468.945310546844, 5470.781168753365, 5471.0, 5442.945570544244, 5449.972750136224, 5460.781568737206, 5461.344638643388, 5463.0, 5491.258680078298, 5531.917021244604, 5537.6954267515675, 5541.806036788693, 5550.111982082847, 5430.891382172414, 5472.097103977958, 5479.589030822624, 5527.336719593674, 5577.27495425592], "value": 5157.798679986815, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.0132780911497, 616.2758758458812, 625.6308777821084, 636.522608043967, 642.3480167629854, 31662.52506212406, 41207.58792412075, 42049.369259461135, 42257.36613950793, 45476.77261613687, 42933.35599966003, 43307.3503897441, 43387.0, 43409.0, 43447.131057378836, 8564.443311184768, 8597.785055373635, 8680.30557555394, 8708.782280443007, 8710.085441028665, 7945.96027019867, 8040.638171282307, 10057.748556286078, 10258.435786031765, 10268.383896966207, 10342.0, 10407.531661075232, 10408.427536485491, 10410.375377477376, 10415.114715249212, 10261.281710280284, 10294.227932904987, 10299.124574411184, 10306.484675766256, 10312.742181445448, 10181.847272290921, 10250.9487452563, 10262.127719143882, 10265.692029239135, 10273.794524109477, 40744.38883416751, 40794.592054079374, 41155.0, 41210.793946030375, 41252.793736031424, 3325.617553981299, 3325.783824051429, 3422.247105636756, 3441.5698037745283, 3525.594556625995, 30623.387532249453, 30838.845805770827, 30986.0, 31127.37745245105, 31647.84176079105, 3919.2357490289405, 4054.635082842529, 4082.4692789937117, 4161.791910404468, 4168.520620128664, 320376.0, 320385.0, 321412.3929380362, 321838.0, 322584.96735293936, 53884.73057634687, 54206.45793542014, 54214.0, 54269.45730542644, 54295.76971914784, 61222.0, 61774.38225617686, 61812.69093654503, 61874.0, 61913.690431547555, 14269.714605708035, 14409.495667651581, 14455.78316325256, 14461.927690361481, 14469.78295325571, 9160.770980725401, 10823.621173259056, 10879.619213327655, 10885.564577416973, 10890.237683362247, 14313.0, 16878.74681879773, 17186.828131718772, 17245.827541724673, 18037.0, 4917.582005529499, 6163.8150855474405, 6208.255009398901, 6209.223847019122, 6221.502279817604, 953.8569214617725, 1008.6923488335981, 1037.7976294622476, 1072.2815713471994, 1109.606089838112, 30654.0, 31241.53137702936, 31245.53131703026, 31817.52273715896, 31917.20206994844, 1089.1667874076338, 1090.5256213547132, 1098.3135540287321, 1134.2230572058168, 1159.7100724818795, 15774.605634859221, 16602.75095873563, 16634.833651663328, 16669.66660666804, 16696.582585435463, 495589.0, 497447.0, 498767.0, 498784.0, 499262.0, 50467.0, 51674.22488662673, 55022.0, 56131.0, 56324.71837640786, 1294.8834604885417, 1303.89568834493, 1324.1591589340646, 1330.0955350361653, 1343.0598580993149, 30344.241393964443, 32896.342073158885, 32905.341893162484, 32929.34141317208, 33283.500747488324, 53225.0, 59051.390117938725, 59259.40740592539, 59481.40518594759, 59534.10698839434, 419205.0, 421546.0, 421691.0, 422384.0, 422591.0, 28004.159875203775, 28228.435431290847, 28327.858360708065, 28625.856870716347, 28629.141125766262, 45624.31563526616, 46314.76842615765, 46688.29967550422, 47857.76071119622, 47944.0, 39185.608143918194, 39937.2012559753, 39982.800085999384, 41106.588934111474, 41674.0, 39906.00234994148, 40321.395179072926, 40654.59345406508, 41715.0, 41974.58025419707, 39969.6448145704, 40273.0, 40326.798366007984, 40618.390724139754, 40724.0, 33063.66936330606, 35553.644463555036, 36335.46891085618, 36339.81830090833, 36734.265314694094, 26576.601350980138, 27260.727392725817, 27439.322934882017, 27520.0, 27572.310692232855], "value": 19707.245603412255, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.86389036056664, 390.55281702450696, 399.6203606573754, 402.9315016447204, 416.72079706596577, 13026.478940842368, 14887.776683349759, 15865.0, 18824.007372249023, 18875.905620471913, 17700.203490842912, 18081.819181808212, 18199.27202911882, 18319.450416487525, 18333.449996500094, 5474.288342515468, 5693.686847223401, 5693.800716974907, 5699.401562835905, 5700.230468886689, 5264.736763161845, 5328.973355133219, 5655.943440565604, 5688.63023903445, 5696.490430036044, 5658.434156584329, 5661.688607126606, 5661.801836935708, 5663.745131469073, 5663.9433605664035, 5376.247325374431, 5536.086545719952, 5566.916496252559, 5585.692786896719, 5607.943920560803, 4868.318435419044, 5007.12375334315, 5011.84964451067, 5013.097642424362, 5042.117629414838, 21924.561508769737, 22257.22099726518, 22346.329610111723, 22379.992900319525, 22415.215467458725, 2188.245055455865, 2312.6531020346915, 2320.97679023211, 2471.6910386201725, 2536.720960694322, 13441.32793360338, 13527.526536571173, 13594.524191653343, 13643.863561364358, 14429.206393648345, 1852.4720454670355, 1860.2187081425834, 1869.5980364221757, 1896.8861868287947, 1968.4586738646844, 77156.0, 81377.0, 91673.0, 100466.0, 105158.47420762847, 16476.83523164777, 16540.58648533772, 16921.83078169227, 17162.39931602413, 18043.54891127706, 31234.843825780725, 31532.527012094837, 31652.36695266128, 31658.366832663218, 31658.683413165574, 8712.390132690778, 8955.686550970684, 9001.414908030956, 9191.77020574491, 9212.769680757901, 6664.400203981568, 7196.424286057103, 7200.747973820891, 7422.257774222642, 7435.739749108755, 8473.703420380258, 8720.30237580992, 8763.298936085097, 8811.911880881238, 8950.955245223733, 3056.3085663506413, 3177.7874255829797, 3181.9522707159413, 3509.771864828778, 3523.048776830293, 844.6536919862826, 928.0, 955.8996305387973, 1014.7310962594918, 1073.7798751255973, 17311.56721081983, 20135.0, 20269.898650506948, 20467.18131274762, 20680.379588612366, 958.3626888119462, 978.9608415663293, 980.1472718734603, 984.1536278800226, 1029.7322696099068, 10364.5335959882, 10685.358878467161, 10857.51141198648, 10863.782724345627, 10871.619493317696, 153099.0, 335718.0, 337400.1379820657, 338277.0, 338483.0, 75742.24257757462, 78945.60527197442, 82463.0, 90018.0, 96368.0, 459.8022850174457, 498.0512124403018, 501.5335737763842, 503.1170296130268, 504.34183390674787, 10488.213383996079, 10907.618233361794, 10956.178286628694, 10980.560777568808, 11382.54469821198, 37375.0, 39578.802105989285, 39797.0, 40867.0, 40921.0, 53715.46284537261, 53897.730511347196, 55473.44526554683, 56632.43367566436, 57203.0, 8242.546659933761, 8468.57657117154, 8528.957355213184, 8765.868511972198, 8801.339899507435, 12266.632001039983, 12395.75208495843, 12575.748485030432, 12696.746065078461, 12905.806412903627, 10963.671089867317, 11150.553977840795, 11386.146039046938, 11494.540218391505, 11868.347240901834, 11188.608398706332, 11199.72000699989, 11337.659870203906, 11342.886571134182, 11417.344485049787, 11163.72090697739, 11264.887351126385, 11292.0, 11474.655760327203, 11606.272525956225, 8460.0, 8516.787080323042, 8656.182201737705, 8722.91277087221, 8896.911030889609, 9857.704268871945, 10872.130229581457, 10994.120470362512, 11210.831837522606, 11394.601188958346], "value": 9266.500299019764, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.6308959670482, 1436.61929588659, 1558.8051493563305, 1698.4310256064218, 1739.1565090930897, 7123.287671232874, 7334.96332518338, 7490.138634057085, 8029.558374289419, 8034.437589368739, 7557.357624601916, 7794.37644988401, 7801.492902961318, 7946.92053079469, 7953.244441778036, 2272.1138755885218, 2291.8968646410867, 2298.9310320690324, 2300.1719381022817, 2301.033565902325, 1980.2178139634907, 2069.0999415254337, 2208.9447763805874, 2255.210676263303, 2298.2415802785126, 2182.8144607708364, 2244.2481768607454, 2247.5617254635354, 2250.1336985260627, 2262.6492893601517, 2192.0574153114153, 2195.6157672407267, 2213.457702862809, 2224.399412158708, 2231.34175418252, 2236.2061468178886, 2258.841881068326, 2284.303287497313, 2286.691296674944, 2287.645414960684, 7728.845423091563, 7787.805304867367, 7921.128675845653, 7925.247101525346, 7926.80182995424, 4780.402449693788, 4898.975505122487, 4899.632527560448, 4900.877478063041, 4905.681130726492, 3228.8869889553753, 3315.7015868571702, 3334.249793796401, 3396.6603339666085, 3408.863645454179, 1162.8430161928115, 1180.6044974933407, 1192.7375977284983, 1211.1945556205112, 2030.4416285521452, 10427.374357538572, 10741.731456713567, 10792.676219713343, 10805.243632945776, 10815.891841081568, 4084.7957602119777, 4167.812448439828, 4182.330827067715, 4242.787860606957, 4256.446661933991, 8255.0, 8315.251627353568, 8319.916800831914, 8343.582820858932, 8345.248927596424, 4777.140114779304, 4785.234362501983, 4810.4708482067645, 4826.0, 4827.951720482821, 4457.77711114443, 4550.726956382628, 4551.362809206714, 4553.1804275230115, 4580.541945805393, 3429.879954201641, 3527.400341941876, 3558.6085530591613, 3570.0, 3571.160777217352, 1075.231209685079, 1117.044926587772, 1141.6118519703175, 1144.7824913266452, 1157.3923690062784, 766.0692258905457, 767.8157242261929, 770.3298130626279, 821.0393839208141, 925.6251218256617, 5178.223266510054, 5196.8960620787375, 5361.678299302054, 5366.329208848894, 5534.557235421156, 937.8265020971143, 983.3952119446488, 991.8413053911484, 993.9204863610894, 1010.9696709098739, 3681.9447708284397, 3751.5685696144747, 3767.3407153747985, 3772.5661548921676, 3902.9219415612097, 9374.156325930562, 9604.75988100289, 9720.513974301257, 9722.416655000723, 9744.853827192455, 9638.710838674851, 9646.758831029281, 9667.274954378308, 9668.70993870185, 9671.129598336183, 7256.2743725627015, 7410.0, 7438.7024519019715, 7445.516041457397, 7454.589997550187, 4956.603471722182, 5034.501021789821, 5145.430643653722, 5183.870403239798, 5464.535514481314, 8626.09426010285, 8629.050804411636, 8638.17937295956, 8668.696595619123, 8805.075467075865, 8634.395592308478, 8878.112188781328, 8939.642414303355, 8943.731688049369, 9001.819963600823, 6694.832629184115, 6889.2421833599265, 6897.448204143757, 6899.551529150589, 6901.1718593769065, 7341.889871652036, 7350.044494215717, 7375.114986201475, 7430.777076687708, 7448.329650331496, 5505.779768809202, 6740.662966851736, 6791.0832037676255, 6816.386525212754, 6955.8956615649795, 6614.834629134118, 6620.304867988792, 6668.499862510428, 6669.2997235289595, 6722.899156512558, 6277.905831412624, 6381.840453988688, 6395.296517383177, 6395.328490508616, 6395.712192951235, 4656.254999200111, 4706.92939605913, 4733.7396443194575, 4764.3568118304975, 4764.809407623657, 4706.670533062653, 4790.8323208687525, 4854.538818812207, 4955.578775803953, 5035.949640503548], "value": 4249.195079579773, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.982814167973, 336.46670028005616, 338.13437599744657, 342.73095619938323, 344.55380282534117, 4988.65079444439, 5075.187969924813, 5131.3842338919285, 5151.639385243035, 5188.273641690157, 5089.262057001742, 5131.33292671953, 5133.0, 5144.022635699214, 5190.792368305263, 4050.7772072536, 4082.6121518455698, 4098.426220329156, 4102.405151253081, 4108.691848111389, 3865.845366185349, 3934.4688467057013, 3970.940435893464, 4018.4575082363945, 4027.6576490998154, 4009.218202450523, 4012.61880121388, 4018.276710192179, 4020.738651987626, 4031.093004074089, 3988.820503077354, 4017.156397156586, 4026.9194616107516, 4027.3487869973465, 4033.6890510583885, 3406.097384193191, 3475.287566048954, 3481.0, 3542.1852973816167, 3558.6441355864467, 4959.330490383788, 4961.751912404401, 4969.850904472835, 4977.452480227172, 4998.450170481244, 4527.388802511652, 4542.8864278392975, 4552.725236933664, 4556.567126123046, 4558.49856515783, 5038.74031492127, 5274.657147285453, 5306.630289765988, 5308.601854860901, 5348.358197016344, 3893.669038131762, 3904.511936007999, 3905.218956208741, 3909.2963266612, 3918.8628398005935, 5537.169424586304, 5552.806146678484, 5553.750081246354, 5567.3040869891265, 5567.47109024642, 3857.9228415431535, 3958.5051868516434, 3992.540857801332, 4010.438538604598, 4012.057166565855, 4020.2160578686876, 4039.5152581690386, 4042.4138499917935, 4043.7169398142437, 4043.7978101094827, 4586.3579098926175, 4590.747508886977, 4591.150637132075, 4593.770311484413, 4615.953840461552, 5103.464136265713, 5317.494837990384, 5359.14253719403, 5364.517193452608, 5377.623566350396, 1333.2067419885152, 1347.7574036673298, 1348.7774517204748, 1355.4307190979812, 1358.6060042587737, 867.6572753762229, 904.0101089307198, 907.2605826251583, 912.3659056955485, 920.2591913509689, 4987.376577927759, 4999.500049994971, 5019.447860735316, 5028.64799464034, 5029.698218106925, 5389.973050134803, 5428.321459817523, 5478.890422191614, 5489.941272022991, 5508.586855985817, 5143.3570803649545, 5156.009514481591, 5168.586513078944, 5184.948150518447, 5210.843674689765, 2716.4023914738727, 2762.309422644339, 2789.7768178545666, 2792.2042217967783, 2819.068937777588, 5547.611667183259, 5555.2778138842505, 5566.997940370772, 5574.049082821061, 5581.469760372758, 5458.808941687022, 5460.5085542301385, 5462.770876552744, 5480.205370221375, 5485.451454854483, 5386.48828361305, 5452.409163696225, 5500.899820036009, 5525.530329921841, 5542.556595472433, 5254.710990895537, 5287.339082614673, 5306.97346513265, 5341.866453338697, 5343.65266257692, 5068.543831055223, 5257.237700533477, 5267.446918073547, 5291.365036195682, 5309.637211440871, 5499.560035197094, 5549.750261238173, 5555.472230138131, 5558.026900450282, 5570.86072848182, 3849.230153969161, 3861.7489863158803, 3866.7293289470595, 3868.168343806095, 3868.477755502971, 5023.899522009612, 5261.394939581997, 5322.866928326823, 5335.226392173191, 5336.466353364788, 5100.846974590768, 5118.38579370478, 5132.820351287687, 5166.948330516647, 5187.29971453864, 5165.845024649267, 5172.793088276427, 5183.844484665466, 5206.869828254324, 5210.869728256824, 4998.550130488274, 5137.768800404066, 5166.2508936204795, 5171.965606878564, 5194.974025130002, 5135.281060651437, 5162.922556161586, 5175.534201921845, 5183.263606691649, 5224.242484839753, 5057.595392368676, 5161.174212126042, 5185.092608793521, 5297.258383826191, 5306.336707911511], "value": 4052.284134274866, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.5940037476577, 664.8769977554152, 720.3624792059029, 735.6144311116392, 754.773567929621, 13937.581872543815, 15169.848301516982, 15185.772213416807, 15191.620209494768, 15203.999999999985, 13473.258970756604, 13551.728965420685, 13714.93142534286, 14365.78451323231, 14530.782038269434, 790.1190172957155, 792.9048514178306, 799.7960520067375, 800.2597597222575, 800.7877912353231, 666.5234357434433, 785.603270348476, 788.696351904518, 789.2186735132235, 789.7986013566532, 711.7971378157226, 817.6238930092164, 839.7228914458215, 840.7855996720828, 841.3773807382554, 826.5040975414763, 827.2554700769325, 828.5608627427473, 828.8176601147737, 828.9709860154895, 510.9208072748693, 605.35832018061, 605.4641642146688, 605.4732382826969, 605.5004621187538, 10895.891041089646, 12988.870111298955, 13242.404091815892, 13298.202107873558, 13765.38055787492, 13878.097923634932, 13977.497557855288, 14092.788608170886, 14158.716825663532, 14344.497942572065, 10981.286216395909, 11202.68665762501, 11236.157288203336, 11238.831417528743, 11321.377324247163, 3632.3643362411735, 3653.6894363979095, 3778.6977041836585, 3780.546334439885, 3801.030737162034, 62271.0, 64124.35875641231, 64705.0, 65762.67118664423, 66381.0, 10407.58369665205, 10440.216983726252, 10677.91780602775, 10678.145748340114, 10729.731756705989, 19220.807791922183, 19379.903100484407, 19384.127714252892, 19404.126814293108, 19415.0, 7869.724559640385, 7904.841903161904, 8008.359331253602, 8209.58952052395, 8287.917120828715, 4209.621134097884, 4220.493540775126, 4334.783260836945, 4345.521992580813, 4508.887277818081, 3307.570015897918, 3361.436931826712, 3383.7462190335823, 3396.6603339665835, 3397.677220664033, 549.0885130683126, 553.4161459660097, 575.2148317546519, 577.3101144132721, 583.2272239282967, 518.6291801362045, 566.3628418029716, 571.1946155920133, 609.5763444406184, 646.7089809585706, 8345.44219238955, 8394.202550757669, 8661.30709543235, 8755.868661970075, 8892.73321800347, 511.95648369888977, 616.9105479705418, 628.3936001758234, 648.7210499485172, 650.9153810004764, 4254.085371645049, 4318.330658747899, 4384.6711496637245, 4391.538888416734, 4427.338767096639, 90185.0, 91237.54381228052, 92806.53596732108, 93168.0, 95209.5239523798, 50271.49728502668, 69902.65048674724, 77394.6130269345, 81080.0, 81194.59402702948, 55396.72301638547, 56692.149617755764, 58631.120533192036, 62299.99999999909, 71959.0, 8789.912100879164, 9117.0, 9257.67598134062, 9332.253419726541, 9350.625974960925, 43125.56874431216, 44025.55974440215, 45096.0, 46154.307685385415, 46198.7690061561, 62789.686051571276, 63476.0, 64591.0, 64648.35351646423, 66039.33960660332, 10033.74915627086, 10152.137068349273, 10239.795204096024, 10279.743006424898, 10289.176865850864, 12276.693082673004, 12752.48990040425, 13012.284324361872, 13053.673658158623, 13593.329800953885, 11890.643280701594, 12270.141090123963, 12298.508059677513, 12302.323372214614, 12819.871801281868, 11270.887291126985, 12157.331346775658, 12277.508899643914, 12658.177218480769, 12674.746505069663, 11315.547378104784, 11908.285502869856, 12010.0, 12038.819417708917, 12398.442070106687, 9654.420734755937, 9670.516474176404, 9688.70933871985, 9955.800883982425, 10564.947175264075, 9824.80350392974, 10070.295079344376, 10349.84475232857, 10357.74105647365, 10400.115990140923], "value": 6774.049557479592, "unit": "score"}], "name": "dromaeo_css", "value": 6920.728981906322, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 112.0, 113.0, 114.0, 114.0, 111.0, 111.0, 114.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 124.0, 155.0, 124.0, 132.0, 122.0, 123.0, 159.0, 126.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 162.0, 163.0, 163.0, 163.0, 161.0, 161.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 112.0, 75.0, 76.0, 76.0, 75.0, 101.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 107.0, 82.0, 83.0, 83.0, 100.0, 83.0, 83.0, 124.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 148.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 84.0, 85.0, 90.0, 85.0, 84.0, 84.0, 84.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 51.0, 51.0, 54.0, 58.0, 52.0, 52.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 87.0, 80.0, 87.0, 80.0, 79.0, 89.0, 79.0, 79.0, 81.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 137.0, 133.0, 130.0, 129.0, 128.0, 128.0, 139.0, 173.0, 145.0], "value": 137.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 168.0, 164.0, 163.0, 165.0, 170.0, 167.0, 167.0, 163.0], "value": 165.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 64.0, 66.0, 66.0, 66.0, 63.0, 64.0, 78.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1494.9, "alertThreshold": 2.0}]} 10:18:13 INFO - Return code: 0 10:18:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:18:13 INFO - # TBPL SUCCESS # 10:18:13 INFO - Running post-action listener: _resource_record_post_action 10:18:13 INFO - [mozharness: 2016-11-10 18:18:13.711420Z] Finished run-tests step (success) 10:18:13 INFO - Running post-run listener: _resource_record_post_run 10:18:13 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 396386304; Read time: 20; Write time: 348088 10:18:13 INFO - TinderboxPrint: CPU usage
13.1% 10:18:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 10:18:13 INFO - TinderboxPrint: I/O write bytes / time
396,386,304 / 348,088 10:18:13 INFO - TinderboxPrint: CPU idle
8,301.3 (86.9%) 10:18:13 INFO - TinderboxPrint: CPU user
1,204.0 (12.6%) 10:18:13 INFO - TinderboxPrint: Swap in / out
0 / 0 10:18:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103317504; Read time: 0; Write time: 98816 10:18:13 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 292626432; Read time: 0; Write time: 249268 10:18:14 INFO - Running post-run listener: _upload_blobber_files 10:18:14 INFO - Blob upload gear active. 10:18:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:18:14 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 10:18:14 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'] 10:18:14 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 10:18:14 INFO - (blobuploader) - INFO - Open directory for files ... 10:18:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:18:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:18:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:15 INFO - (blobuploader) - INFO - Done attempting. 10:18:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:18:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:18:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:16 INFO - (blobuploader) - INFO - Done attempting. 10:18:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:18:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:18:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:19 INFO - (blobuploader) - INFO - Done attempting. 10:18:19 INFO - (blobuploader) - INFO - Iteration through files over. 10:18:19 INFO - Return code: 0 10:18:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:18:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:18:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0af8dbb432b9f17c66946dc36382b6fe584cc423cab0cd8647d6b735785739118d87e96493597eba2dddc1fdb732b766970e098b7c49cc601558715a174cead8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/01b65a14692dcc837a66e5f7a5998a2e382b0263c11b9f3a6600eaccc039e360cffd51c2bfefcbd8716d6790c96c160a093177df70f4ac7c8cf26f2e1043bfcd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/286ffaf1cb031dc1f1de2979e353c2600a095e744ad705cc469e8149ee411b10fe803f45644b0428a4cdc901175fbd36d3faf97d4fc26b6c6dda558ee7f51ea5"} 10:18:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:18:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:18:19 INFO - Contents: 10:18:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0af8dbb432b9f17c66946dc36382b6fe584cc423cab0cd8647d6b735785739118d87e96493597eba2dddc1fdb732b766970e098b7c49cc601558715a174cead8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/01b65a14692dcc837a66e5f7a5998a2e382b0263c11b9f3a6600eaccc039e360cffd51c2bfefcbd8716d6790c96c160a093177df70f4ac7c8cf26f2e1043bfcd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/286ffaf1cb031dc1f1de2979e353c2600a095e744ad705cc469e8149ee411b10fe803f45644b0428a4cdc901175fbd36d3faf97d4fc26b6c6dda558ee7f51ea5"} 10:18:19 INFO - Running post-run listener: copy_logs_to_upload_dir 10:18:19 INFO - Copying logs to upload dir... 10:18:19 INFO - mkdir: /builds/slave/test/build/upload/logs 10:18:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.632342 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-11-10 10:18:19.058420) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-10 10:18:19.061469) ========= 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=14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0af8dbb432b9f17c66946dc36382b6fe584cc423cab0cd8647d6b735785739118d87e96493597eba2dddc1fdb732b766970e098b7c49cc601558715a174cead8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/01b65a14692dcc837a66e5f7a5998a2e382b0263c11b9f3a6600eaccc039e360cffd51c2bfefcbd8716d6790c96c160a093177df70f4ac7c8cf26f2e1043bfcd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/286ffaf1cb031dc1f1de2979e353c2600a095e744ad705cc469e8149ee411b10fe803f45644b0428a4cdc901175fbd36d3faf97d4fc26b6c6dda558ee7f51ea5"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478788690/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011332 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478788690/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0af8dbb432b9f17c66946dc36382b6fe584cc423cab0cd8647d6b735785739118d87e96493597eba2dddc1fdb732b766970e098b7c49cc601558715a174cead8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/01b65a14692dcc837a66e5f7a5998a2e382b0263c11b9f3a6600eaccc039e360cffd51c2bfefcbd8716d6790c96c160a093177df70f4ac7c8cf26f2e1043bfcd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/286ffaf1cb031dc1f1de2979e353c2600a095e744ad705cc469e8149ee411b10fe803f45644b0428a4cdc901175fbd36d3faf97d4fc26b6c6dda558ee7f51ea5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-10 10:18:19.087548) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 10:18:19.088101) ========= 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=14ef55db36f7623abb31b9cf000001d5-1478800660.248198-450481878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 10:18:19.172417) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-10 10:18:19.172939) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-10 10:18:19.173492) ========= ========= Total master_lag: 0.18 =========