builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1477457192.98 results: success (0) buildid: 20161025213543 builduid: b823c87570604fb7a2aff65c3051604f revision: ac6306117c61a56f8446d99415a853becd7a21c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 21:46:32.976209) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 21:46:32.976696) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 21:46:32.976973) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 21:46:32.991742) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 21:46:32.992045) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-25 21:46:33-- 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% 46.1M=0s 2016-10-25 21:46:33 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081755 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 21:46:33.087682) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 21:46:33.087989) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014308 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 21:46:33.137219) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 21:46:33.137576) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ac6306117c61a56f8446d99415a853becd7a21c0 --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 ac6306117c61a56f8446d99415a853becd7a21c0 --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=9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-25 21:46:33,438 truncating revision to first 12 chars 2016-10-25 21:46:33,438 Setting DEBUG logging. 2016-10-25 21:46:33,438 attempt 1/10 2016-10-25 21:46:33,438 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/ac6306117c61?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 21:46:34,448 unpacking tar archive at: mozilla-inbound-ac6306117c61/testing/mozharness/ program finished with exit code 0 elapsedTime=1.360412 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 21:46:34.511438) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 21:46:34.511759) ========= script_repo_revision: ac6306117c61a56f8446d99415a853becd7a21c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 21:46:34.512252) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 21:46:34.512545) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 21:46:34.521407) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-25 21:46:34.521712) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:46:34 INFO - MultiFileLogger online at 20161025 21:46:34 in /builds/slave/test 21:46:34 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 21:46:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:46:34 INFO - {'append_to_log': False, 21:46:34 INFO - 'base_work_dir': '/builds/slave/test', 21:46:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:46:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:46:34 INFO - 'branch': 'Mozilla-Inbound', 21:46:34 INFO - 'buildbot_json_path': 'buildprops.json', 21:46:34 INFO - 'config_files': ('talos/linux_config.py',), 21:46:34 INFO - 'default_actions': ('clobber', 21:46:34 INFO - 'read-buildbot-config', 21:46:34 INFO - 'download-and-extract', 21:46:34 INFO - 'populate-webroot', 21:46:34 INFO - 'create-virtualenv', 21:46:34 INFO - 'install', 21:46:34 INFO - 'run-tests'), 21:46:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:46:34 INFO - 'download_minidump_stackwalk': True, 21:46:34 INFO - 'download_symbols': 'ondemand', 21:46:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:46:34 INFO - 'tooltool.py': '/tools/tooltool.py', 21:46:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:46:34 INFO - '/tools/misc-python/virtualenv.py')}, 21:46:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:46:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:46:34 INFO - 'installer_path': 'installer.exe', 21:46:34 INFO - 'log_level': 'info', 21:46:34 INFO - 'log_name': 'talos', 21:46:34 INFO - 'log_to_console': True, 21:46:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:46:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:46:34 INFO - 'opt_config_files': (), 21:46:34 INFO - 'pip_index': False, 21:46:34 INFO - 'sps_profile': False, 21:46:34 INFO - 'sps_profile_interval': 0, 21:46:34 INFO - 'suite': 'dromaeojs', 21:46:34 INFO - 'system_bits': '32', 21:46:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:46:34 INFO - 'title': 'talos-linux64-ix-040', 21:46:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:46:34 INFO - 'use_talos_json': True, 21:46:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:46:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:46:34 INFO - 'work_dir': 'build'} 21:46:34 INFO - [mozharness: 2016-10-26 04:46:34.928627Z] Running clobber step. 21:46:34 INFO - Running pre-action listener: _resource_record_pre_action 21:46:34 INFO - Running main action method: clobber 21:46:34 INFO - rmtree: /builds/slave/test/build 21:46:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:46:35 INFO - Running post-action listener: _resource_record_post_action 21:46:35 INFO - [mozharness: 2016-10-26 04:46:35.389269Z] Finished clobber step (success) 21:46:35 INFO - [mozharness: 2016-10-26 04:46:35.389378Z] Running read-buildbot-config step. 21:46:35 INFO - Running pre-action listener: _resource_record_pre_action 21:46:35 INFO - Running main action method: read_buildbot_config 21:46:35 INFO - Using buildbot properties: 21:46:35 INFO - { 21:46:35 INFO - "project": "", 21:46:35 INFO - "product": "firefox", 21:46:35 INFO - "script_repo_revision": "production", 21:46:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 21:46:35 INFO - "repository": "", 21:46:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 21:46:35 INFO - "buildid": "20161025213543", 21:46:35 INFO - "stage_platform": "linux64-pgo", 21:46:35 INFO - "basedir": "/builds/slave/test", 21:46:35 INFO - "buildnumber": 1801, 21:46:35 INFO - "platform": "ubuntu64_hw", 21:46:35 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:46:35 INFO - "slavebuilddir": "test", 21:46:35 INFO - "branch": "mozilla-inbound", 21:46:35 INFO - "revision": "ac6306117c61a56f8446d99415a853becd7a21c0", 21:46:35 INFO - "slavename": "talos-linux64-ix-040", 21:46:35 INFO - "builduid": "b823c87570604fb7a2aff65c3051604f", 21:46:35 INFO - "repo_path": "integration/mozilla-inbound" 21:46:35 INFO - } 21:46:35 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:46:35 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 21:46:35 INFO - Running post-action listener: _resource_record_post_action 21:46:35 INFO - [mozharness: 2016-10-26 04:46:35.391793Z] Finished read-buildbot-config step (success) 21:46:35 INFO - [mozharness: 2016-10-26 04:46:35.391881Z] Running download-and-extract step. 21:46:35 INFO - Running pre-action listener: _resource_record_pre_action 21:46:35 INFO - Running main action method: download_and_extract 21:46:35 INFO - mkdir: /builds/slave/test/build/tests 21:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:35 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:46:35 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/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 21:46:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/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 21:46:35 INFO - Downloaded 1361 bytes. 21:46:35 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:46:35 INFO - Using the following test package requirements: 21:46:35 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:46:35 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:46:35 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:46:35 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:35 INFO - u'jsshell-linux-x86_64.zip'], 21:46:35 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:46:35 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:46:35 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:46:35 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:46:35 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:46:35 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:46:35 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:46:35 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/1477445407/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:46:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:46:35 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:46:35 INFO - Http code: 200 21:46:35 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 21:46:35 INFO - x-amz-cf-id: sGY3c9B179E1OKlz8GqZA0lUY5Ay-e1Dcvm_u9mkBxTKZcaU6JvWlg== 21:46:35 INFO - x-amz-replication-status: COMPLETED 21:46:35 INFO - x-amz-version-id: AR50MGmuK293f9oyb8hfv7s_iCAt2J08 21:46:35 INFO - Expected file size: 22058226 21:46:35 INFO - Obtained file size: 22058226 21:46:39 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 21:46:39 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/1477445407/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:46:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:46:39 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:46:39 INFO - Http code: 200 21:46:39 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 21:46:39 INFO - x-amz-cf-id: ZNiqs6yZ5nCLOUEUenB3265UcsKdWzBOLmLZpzC2uWjuwsRQpfXjvA== 21:46:39 INFO - x-amz-replication-status: COMPLETED 21:46:39 INFO - x-amz-version-id: AR50MGmuK293f9oyb8hfv7s_iCAt2J08 21:46:40 INFO - Expected file size: 22058226 21:46:40 INFO - Obtained file size: 22058226 21:46:44 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/1477445407/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:46:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:46:44 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:46:44 INFO - Http code: 200 21:46:44 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 21:46:44 INFO - x-amz-cf-id: dDxJ_lVhpQYYnuwg_NnrsLcJQXQuVLEBEWX-OphL9WvlEdPckX3LCw== 21:46:44 INFO - x-amz-replication-status: COMPLETED 21:46:44 INFO - x-amz-version-id: Tfdzo9Bf.BfysQa9rbYxcExRpFFsrpwf 21:46:44 INFO - Expected file size: 14409028 21:46:44 INFO - Obtained file size: 14409028 21:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:45 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:46:45 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/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 21:46:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/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 21:46:45 INFO - Downloaded 59445965 bytes. 21:46:45 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:46:45 INFO - mkdir: /builds/slave/test/properties 21:46:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:46:45 INFO - Writing to file /builds/slave/test/properties/build_url 21:46:45 INFO - Contents: 21:46:45 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:46:46 INFO - Running post-action listener: _resource_record_post_action 21:46:46 INFO - Running post-action listener: set_extra_try_arguments 21:46:46 INFO - [mozharness: 2016-10-26 04:46:46.184219Z] Finished download-and-extract step (success) 21:46:46 INFO - [mozharness: 2016-10-26 04:46:46.184445Z] Running populate-webroot step. 21:46:46 INFO - Running pre-action listener: _resource_record_pre_action 21:46:46 INFO - Running main action method: populate_webroot 21:46:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:46:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:46:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:46:46 INFO - '--tppagecycles', 21:46:46 INFO - '7'], 21:46:46 INFO - 'tests': ['tsvgm']}}, 21:46:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:46:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:46:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:46:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:46:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:46:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:46:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:46 INFO - 'talos_options': ['--disable-e10s'], 21:46:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:46:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:46:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:46 INFO - 'talos_options': ['--disable-e10s'], 21:46:46 INFO - 'tests': ['damp', 'tps']}, 21:46:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:46 INFO - 'tests': ['damp', 'tps']}, 21:46:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:46:46 INFO - 'tests': ['dromaeo_dom']}, 21:46:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:46:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:46:46 INFO - 'tests': ['basic_compositor_video']}, 21:46:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:46:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:46:46 INFO - 'tests': ['a11yr', 21:46:46 INFO - 'ts_paint', 21:46:46 INFO - 'tpaint', 21:46:46 INFO - 'sessionrestore', 21:46:46 INFO - 'sessionrestore_no_auto_restore', 21:46:46 INFO - 'tabpaint']}, 21:46:46 INFO - 'other-e10s': {'tests': ['a11yr', 21:46:46 INFO - 'ts_paint', 21:46:46 INFO - 'tpaint', 21:46:46 INFO - 'sessionrestore', 21:46:46 INFO - 'sessionrestore_no_auto_restore', 21:46:46 INFO - 'tabpaint']}, 21:46:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:46:46 INFO - 'ts_paint', 21:46:46 INFO - 'tpaint', 21:46:46 INFO - 'sessionrestore', 21:46:46 INFO - 'sessionrestore_no_auto_restore', 21:46:46 INFO - 'tabpaint']}, 21:46:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:46:46 INFO - 'ts_paint', 21:46:46 INFO - 'tpaint', 21:46:46 INFO - 'sessionrestore', 21:46:46 INFO - 'sessionrestore_no_auto_restore', 21:46:46 INFO - 'tabpaint']}, 21:46:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:46:46 INFO - 'tests': ['a11yr', 21:46:46 INFO - 'ts_paint', 21:46:46 INFO - 'tpaint', 21:46:46 INFO - 'sessionrestore', 21:46:46 INFO - 'sessionrestore_no_auto_restore', 21:46:46 INFO - 'tabpaint']}, 21:46:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:46:46 INFO - 'tests': ['a11yr', 21:46:46 INFO - 'ts_paint', 21:46:46 INFO - 'tpaint', 21:46:46 INFO - 'sessionrestore', 21:46:46 INFO - 'sessionrestore_no_auto_restore', 21:46:46 INFO - 'tabpaint']}, 21:46:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:46:46 INFO - 'tests': ['tsvgx', 21:46:46 INFO - 'tsvgr_opacity', 21:46:46 INFO - 'tart', 21:46:46 INFO - 'tscrollx', 21:46:46 INFO - 'cart']}, 21:46:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:46:46 INFO - 'tsvgr_opacity', 21:46:46 INFO - 'tart', 21:46:46 INFO - 'tscrollx', 21:46:46 INFO - 'cart']}, 21:46:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:46 INFO - 'talos_options': ['--disable-e10s'], 21:46:46 INFO - 'tests': ['tp5o']}, 21:46:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:46 INFO - 'tests': ['tp5o']}, 21:46:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:46 INFO - 'talos_options': ['--disable-e10s', 21:46:46 INFO - '--xperf_path', 21:46:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:46:46 INFO - 'tests': ['tp5n']}, 21:46:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:46 INFO - 'talos_options': ['--xperf_path', 21:46:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:46:46 INFO - 'tests': ['tp5n']}}, 21:46:46 INFO - 'talos.zip': {'path': '', 21:46:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:46:46 INFO - Running post-action listener: _resource_record_post_action 21:46:46 INFO - [mozharness: 2016-10-26 04:46:46.203339Z] Finished populate-webroot step (success) 21:46:46 INFO - [mozharness: 2016-10-26 04:46:46.203427Z] Running create-virtualenv step. 21:46:46 INFO - Running pre-action listener: _resource_record_pre_action 21:46:46 INFO - Running main action method: create_virtualenv 21:46:46 INFO - Creating virtualenv /builds/slave/test/build/venv 21:46:46 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 21:46:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:46:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:46:46 INFO - Using real prefix '/usr' 21:46:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:46:46 INFO - Installing distribute.............................................................................................................................................................................................done. 21:46:48 INFO - Installing pip.................done. 21:46:48 INFO - Return code: 0 21:46:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:46:48 INFO - Reading from file tmpfile_stdout 21:46:48 INFO - Output received: 21:46:48 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) 21:46:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:46:48 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')]} 21:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:48 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')]} 21:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:48 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 0x7f952ed2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38f60>, '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 0x2c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3a1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', '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 21:46:48 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 21:46:48 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 21:46:48 INFO - Using env: {'DISPLAY': ':0', 21:46:48 INFO - 'HOME': '/home/cltbld', 21:46:48 INFO - 'LANG': 'en_US.UTF-8', 21:46:48 INFO - 'LANGUAGE': 'en_US:en', 21:46:48 INFO - 'LOGNAME': 'cltbld', 21:46:48 INFO - 'MAIL': '/var/mail/cltbld', 21:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:48 INFO - 'MOZ_NO_REMOTE': '1', 21:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:48 INFO - 'NO_EM_RESTART': '1', 21:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:48 INFO - 'PWD': '/builds/slave/test', 21:46:48 INFO - 'SHELL': '/bin/bash', 21:46:48 INFO - 'SHLVL': '1', 21:46:48 INFO - 'TERM': 'linux', 21:46:48 INFO - 'TMOUT': '86400', 21:46:48 INFO - 'USER': 'cltbld', 21:46:48 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', 21:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:48 INFO - '_': '/tools/buildbot/bin/python'} 21:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:49 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 21:46:49 INFO - Cleaning up... 21:46:49 INFO - Return code: 0 21:46:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:46:49 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')]} 21:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:49 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')]} 21:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:49 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 0x7f952ed2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38f60>, '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 0x2c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3a1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', '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 21:46:49 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 21:46:49 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 21:46:49 INFO - Using env: {'DISPLAY': ':0', 21:46:49 INFO - 'HOME': '/home/cltbld', 21:46:49 INFO - 'LANG': 'en_US.UTF-8', 21:46:49 INFO - 'LANGUAGE': 'en_US:en', 21:46:49 INFO - 'LOGNAME': 'cltbld', 21:46:49 INFO - 'MAIL': '/var/mail/cltbld', 21:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:49 INFO - 'MOZ_NO_REMOTE': '1', 21:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:49 INFO - 'NO_EM_RESTART': '1', 21:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:49 INFO - 'PWD': '/builds/slave/test', 21:46:49 INFO - 'SHELL': '/bin/bash', 21:46:49 INFO - 'SHLVL': '1', 21:46:49 INFO - 'TERM': 'linux', 21:46:49 INFO - 'TMOUT': '86400', 21:46:49 INFO - 'USER': 'cltbld', 21:46:49 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', 21:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:49 INFO - '_': '/tools/buildbot/bin/python'} 21:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:49 INFO - Downloading/unpacking psutil>=3.1.1 21:46:49 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 21:46:49 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 21:46:49 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 21:46:49 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 21:46:49 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 21:46:49 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 21:46:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:46:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:46:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:46:51 INFO - Installing collected packages: psutil 21:46:51 INFO - Running setup.py install for psutil 21:46:51 INFO - building 'psutil._psutil_linux' extension 21:46:51 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 21:46:51 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 21:46:51 INFO - building 'psutil._psutil_posix' extension 21:46:51 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 21:46:51 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 21:46:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:46:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:46:51 INFO - Successfully installed psutil 21:46:51 INFO - Cleaning up... 21:46:52 INFO - Return code: 0 21:46:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:46: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')]} 21:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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')]} 21:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:52 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 0x7f952ed2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38f60>, '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 0x2c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3a1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', '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 21:46:52 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 21:46:52 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 21:46:52 INFO - Using env: {'DISPLAY': ':0', 21:46:52 INFO - 'HOME': '/home/cltbld', 21:46:52 INFO - 'LANG': 'en_US.UTF-8', 21:46:52 INFO - 'LANGUAGE': 'en_US:en', 21:46:52 INFO - 'LOGNAME': 'cltbld', 21:46:52 INFO - 'MAIL': '/var/mail/cltbld', 21:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:52 INFO - 'MOZ_NO_REMOTE': '1', 21:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:52 INFO - 'NO_EM_RESTART': '1', 21:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:52 INFO - 'PWD': '/builds/slave/test', 21:46:52 INFO - 'SHELL': '/bin/bash', 21:46:52 INFO - 'SHLVL': '1', 21:46:52 INFO - 'TERM': 'linux', 21:46:52 INFO - 'TMOUT': '86400', 21:46:52 INFO - 'USER': 'cltbld', 21:46:52 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', 21:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:52 INFO - '_': '/tools/buildbot/bin/python'} 21:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:46:52 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 21:46:52 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 21:46:52 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 21:46:52 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 21:46:52 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 21:46:52 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 21:46:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:46:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:46:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:46:54 INFO - Installing collected packages: mozsystemmonitor 21:46:54 INFO - Running setup.py install for mozsystemmonitor 21:46:54 INFO - Successfully installed mozsystemmonitor 21:46:54 INFO - Cleaning up... 21:46:54 INFO - Return code: 0 21:46:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f952ed2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38f60>, '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 0x2c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3a1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', '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 21:46:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:46:54 INFO - Using env: {'DISPLAY': ':0', 21:46:54 INFO - 'HOME': '/home/cltbld', 21:46:54 INFO - 'LANG': 'en_US.UTF-8', 21:46:54 INFO - 'LANGUAGE': 'en_US:en', 21:46:54 INFO - 'LOGNAME': 'cltbld', 21:46:54 INFO - 'MAIL': '/var/mail/cltbld', 21:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:54 INFO - 'MOZ_NO_REMOTE': '1', 21:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:54 INFO - 'NO_EM_RESTART': '1', 21:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:54 INFO - 'PWD': '/builds/slave/test', 21:46:54 INFO - 'SHELL': '/bin/bash', 21:46:54 INFO - 'SHLVL': '1', 21:46:54 INFO - 'TERM': 'linux', 21:46:54 INFO - 'TMOUT': '86400', 21:46:54 INFO - 'USER': 'cltbld', 21:46:54 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', 21:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:54 INFO - '_': '/tools/buildbot/bin/python'} 21:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:54 INFO - Downloading/unpacking jsonschema==2.5.1 21:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:46:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46:56 INFO - Downloading functools32-3.2.3-2.tar.gz 21:46:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:46:56 INFO - warning: no files found matching '*.txt' 21:46:56 INFO - no previously-included directories found matching 'build' 21:46:56 INFO - no previously-included directories found matching 'dist' 21:46:56 INFO - no previously-included directories found matching '.git*' 21:46:56 INFO - Installing collected packages: jsonschema, functools32 21:46:56 INFO - Running setup.py install for functools32 21:46:56 INFO - warning: no files found matching '*.txt' 21:46:56 INFO - no previously-included directories found matching 'build' 21:46:56 INFO - no previously-included directories found matching 'dist' 21:46:56 INFO - no previously-included directories found matching '.git*' 21:46:56 INFO - Successfully installed jsonschema functools32 21:46:56 INFO - Cleaning up... 21:46:57 INFO - Return code: 0 21:46:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:46:57 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')]} 21:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:57 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')]} 21:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:57 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 0x7f952ed2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38f60>, '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 0x2c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3a1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', '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 21:46:57 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 21:46:57 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 21:46:57 INFO - Using env: {'DISPLAY': ':0', 21:46:57 INFO - 'HOME': '/home/cltbld', 21:46:57 INFO - 'LANG': 'en_US.UTF-8', 21:46:57 INFO - 'LANGUAGE': 'en_US:en', 21:46:57 INFO - 'LOGNAME': 'cltbld', 21:46:57 INFO - 'MAIL': '/var/mail/cltbld', 21:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:57 INFO - 'MOZ_NO_REMOTE': '1', 21:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:57 INFO - 'NO_EM_RESTART': '1', 21:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:57 INFO - 'PWD': '/builds/slave/test', 21:46:57 INFO - 'SHELL': '/bin/bash', 21:46:57 INFO - 'SHLVL': '1', 21:46:57 INFO - 'TERM': 'linux', 21:46:57 INFO - 'TMOUT': '86400', 21:46:57 INFO - 'USER': 'cltbld', 21:46:57 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', 21:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:57 INFO - '_': '/tools/buildbot/bin/python'} 21:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:46:57 INFO - Cleaning up... 21:46:57 INFO - Return code: 0 21:46:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:46:57 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')]} 21:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:57 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')]} 21:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:57 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 0x7f952ed2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38f60>, '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 0x2c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3a1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', '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 21:46:57 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 21:46:57 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 21:46:57 INFO - Using env: {'DISPLAY': ':0', 21:46:57 INFO - 'HOME': '/home/cltbld', 21:46:57 INFO - 'LANG': 'en_US.UTF-8', 21:46:57 INFO - 'LANGUAGE': 'en_US:en', 21:46:57 INFO - 'LOGNAME': 'cltbld', 21:46:57 INFO - 'MAIL': '/var/mail/cltbld', 21:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:57 INFO - 'MOZ_NO_REMOTE': '1', 21:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:57 INFO - 'NO_EM_RESTART': '1', 21:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:57 INFO - 'PWD': '/builds/slave/test', 21:46:57 INFO - 'SHELL': '/bin/bash', 21:46:57 INFO - 'SHLVL': '1', 21:46:57 INFO - 'TERM': 'linux', 21:46:57 INFO - 'TMOUT': '86400', 21:46:57 INFO - 'USER': 'cltbld', 21:46:57 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', 21:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:57 INFO - '_': '/tools/buildbot/bin/python'} 21:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:57 INFO - Downloading/unpacking blobuploader==1.2.4 21:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:59 INFO - Downloading blobuploader-1.2.4.tar.gz 21:46:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:46:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:46:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:47:00 INFO - Downloading docopt-0.6.1.tar.gz 21:47:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:47:00 INFO - Installing collected packages: blobuploader, requests, docopt 21:47:00 INFO - Running setup.py install for blobuploader 21:47:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:47:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:47:00 INFO - Running setup.py install for requests 21:47:00 INFO - Running setup.py install for docopt 21:47:00 INFO - Successfully installed blobuploader requests docopt 21:47:00 INFO - Cleaning up... 21:47:00 INFO - Return code: 0 21:47:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:00 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 0x7f952ed2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38f60>, '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 0x2c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3a1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', '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 21:47:00 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 21:47:00 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 21:47:00 INFO - Using env: {'DISPLAY': ':0', 21:47:00 INFO - 'HOME': '/home/cltbld', 21:47:00 INFO - 'LANG': 'en_US.UTF-8', 21:47:00 INFO - 'LANGUAGE': 'en_US:en', 21:47:00 INFO - 'LOGNAME': 'cltbld', 21:47:00 INFO - 'MAIL': '/var/mail/cltbld', 21:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:00 INFO - 'MOZ_NO_REMOTE': '1', 21:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:00 INFO - 'NO_EM_RESTART': '1', 21:47:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:00 INFO - 'PWD': '/builds/slave/test', 21:47:00 INFO - 'SHELL': '/bin/bash', 21:47:00 INFO - 'SHLVL': '1', 21:47:00 INFO - 'TERM': 'linux', 21:47:00 INFO - 'TMOUT': '86400', 21:47:00 INFO - 'USER': 'cltbld', 21:47:00 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', 21:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:00 INFO - '_': '/tools/buildbot/bin/python'} 21:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:47:01 INFO - Running setup.py (path:/tmp/pip-_61IEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:47:01 INFO - Running setup.py (path:/tmp/pip-T9Hv_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:47:01 INFO - Running setup.py (path:/tmp/pip-FCWSuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:47:01 INFO - Running setup.py (path:/tmp/pip-FikW9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:47:01 INFO - Running setup.py (path:/tmp/pip-D2unxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:47:01 INFO - Running setup.py (path:/tmp/pip-IOHbOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:47:01 INFO - Running setup.py (path:/tmp/pip-HHOu7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:47:01 INFO - Running setup.py (path:/tmp/pip-R7RydV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:47:01 INFO - Running setup.py (path:/tmp/pip-sryhCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:47:01 INFO - Running setup.py (path:/tmp/pip-Zq4Bae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:47:01 INFO - Running setup.py (path:/tmp/pip-n6__O8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:47:01 INFO - Running setup.py (path:/tmp/pip-Kf8pK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:47:01 INFO - Running setup.py (path:/tmp/pip-CwzAJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:47:02 INFO - Running setup.py (path:/tmp/pip-TEvBEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:02 INFO - Running setup.py (path:/tmp/pip-aOeT3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:47:02 INFO - Running setup.py (path:/tmp/pip-jl21WP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:47:02 INFO - Running setup.py (path:/tmp/pip-angkNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:47:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:47:02 INFO - Running setup.py install for manifestparser 21:47:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:47:02 INFO - Running setup.py install for mozcrash 21:47:02 INFO - Running setup.py install for mozdebug 21:47:02 INFO - Running setup.py install for mozdevice 21:47:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:47:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:47:02 INFO - Running setup.py install for mozfile 21:47:02 INFO - Running setup.py install for mozhttpd 21:47:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:47:02 INFO - Running setup.py install for mozinfo 21:47:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:47:02 INFO - Running setup.py install for mozInstall 21:47:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:47:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:47:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:47:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:47:03 INFO - Running setup.py install for mozleak 21:47:03 INFO - Running setup.py install for mozlog 21:47:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:47:03 INFO - Running setup.py install for moznetwork 21:47:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:47:03 INFO - Running setup.py install for mozprocess 21:47:03 INFO - Running setup.py install for mozprofile 21:47:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:47:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:47:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:47:03 INFO - Running setup.py install for mozrunner 21:47:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:47:03 INFO - Running setup.py install for mozscreenshot 21:47:03 INFO - Running setup.py install for moztest 21:47:03 INFO - Running setup.py install for mozversion 21:47:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:47:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:47:04 INFO - Cleaning up... 21:47:04 INFO - Return code: 0 21:47:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:47: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')]} 21:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47: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')]} 21:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:04 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 0x7f952ed2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38f60>, '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 0x2c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3a1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', '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 21:47:04 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 21:47:04 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 21:47:04 INFO - Using env: {'DISPLAY': ':0', 21:47:04 INFO - 'HOME': '/home/cltbld', 21:47:04 INFO - 'LANG': 'en_US.UTF-8', 21:47:04 INFO - 'LANGUAGE': 'en_US:en', 21:47:04 INFO - 'LOGNAME': 'cltbld', 21:47:04 INFO - 'MAIL': '/var/mail/cltbld', 21:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:04 INFO - 'MOZ_NO_REMOTE': '1', 21:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:04 INFO - 'NO_EM_RESTART': '1', 21:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:04 INFO - 'PWD': '/builds/slave/test', 21:47:04 INFO - 'SHELL': '/bin/bash', 21:47:04 INFO - 'SHLVL': '1', 21:47:04 INFO - 'TERM': 'linux', 21:47:04 INFO - 'TMOUT': '86400', 21:47:04 INFO - 'USER': 'cltbld', 21:47:04 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', 21:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:04 INFO - '_': '/tools/buildbot/bin/python'} 21:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:47:04 INFO - Running setup.py (path:/tmp/pip-TC4MWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:47:04 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)) 21:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:47:04 INFO - Running setup.py (path:/tmp/pip-IyZumO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:47:04 INFO - Running setup.py (path:/tmp/pip-74h3U1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:47:04 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)) 21:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:47:04 INFO - Running setup.py (path:/tmp/pip-ig9umy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:47:04 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)) 21:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:47:04 INFO - Running setup.py (path:/tmp/pip-fafizZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:47:04 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)) 21:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:47:04 INFO - Running setup.py (path:/tmp/pip-10SQ1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:47:04 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)) 21:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:47:04 INFO - Running setup.py (path:/tmp/pip-aPGEwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:47:04 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)) 21:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:47:04 INFO - Running setup.py (path:/tmp/pip-zYYU7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:47:04 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)) 21:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:47:04 INFO - Running setup.py (path:/tmp/pip-9I1Nbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:47:04 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)) 21:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:47:04 INFO - Running setup.py (path:/tmp/pip-VtMxWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:47:05 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)) 21:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:47:05 INFO - Running setup.py (path:/tmp/pip-R6JLHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:47:05 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)) 21:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:47:05 INFO - Running setup.py (path:/tmp/pip-MIvqki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:47:05 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)) 21:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:47:05 INFO - Running setup.py (path:/tmp/pip-UTCpVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:47:05 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)) 21:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:47:05 INFO - Running setup.py (path:/tmp/pip-FUxM7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:05 INFO - Running setup.py (path:/tmp/pip-Yqrasl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:05 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)) 21:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:47:05 INFO - Running setup.py (path:/tmp/pip-GeDS_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:47:05 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)) 21:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:47:05 INFO - Running setup.py (path:/tmp/pip-9etFby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:47:05 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)) 21:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:47:05 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)) 21:47:05 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)) 21:47:05 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)) 21:47:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:47:05 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 21:47:05 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 21:47:05 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 21:47:05 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 21:47:05 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 21:47:05 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 21:47:07 INFO - Downloading blessings-1.6.tar.gz 21:47:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:47:07 INFO - Installing collected packages: blessings 21:47:07 INFO - Running setup.py install for blessings 21:47:07 INFO - Successfully installed blessings 21:47:07 INFO - Cleaning up... 21:47:07 INFO - Return code: 0 21:47:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:47:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:47:07 INFO - Reading from file tmpfile_stdout 21:47:07 INFO - Current package versions: 21:47:07 INFO - argparse == 1.2.1 21:47:07 INFO - blessings == 1.6 21:47:07 INFO - blobuploader == 1.2.4 21:47:07 INFO - docopt == 0.6.1 21:47:07 INFO - functools32 == 3.2.3-2 21:47:07 INFO - jsonschema == 2.5.1 21:47:07 INFO - manifestparser == 1.1 21:47:07 INFO - mozInstall == 1.12 21:47:07 INFO - mozcrash == 0.17 21:47:07 INFO - mozdebug == 0.1 21:47:07 INFO - mozdevice == 0.48 21:47:07 INFO - mozfile == 1.2 21:47:07 INFO - mozhttpd == 0.7 21:47:07 INFO - mozinfo == 0.9 21:47:07 INFO - mozleak == 0.1 21:47:07 INFO - mozlog == 3.4 21:47:07 INFO - moznetwork == 0.27 21:47:07 INFO - mozprocess == 0.23 21:47:07 INFO - mozprofile == 0.28 21:47:07 INFO - mozrunner == 6.12 21:47:07 INFO - mozscreenshot == 0.1 21:47:07 INFO - mozsystemmonitor == 0.3 21:47:07 INFO - moztest == 0.7 21:47:07 INFO - mozversion == 1.4 21:47:07 INFO - psutil == 3.1.1 21:47:07 INFO - requests == 1.2.3 21:47:07 INFO - wsgiref == 0.1.2 21:47:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:47: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')]} 21:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47: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')]} 21:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:07 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 0x7f952ed2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38f60>, '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 0x2c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3a1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', '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 21:47:07 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 21:47:07 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 21:47:07 INFO - Using env: {'DISPLAY': ':0', 21:47:07 INFO - 'HOME': '/home/cltbld', 21:47:07 INFO - 'LANG': 'en_US.UTF-8', 21:47:07 INFO - 'LANGUAGE': 'en_US:en', 21:47:07 INFO - 'LOGNAME': 'cltbld', 21:47:07 INFO - 'MAIL': '/var/mail/cltbld', 21:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:07 INFO - 'MOZ_NO_REMOTE': '1', 21:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:07 INFO - 'NO_EM_RESTART': '1', 21:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:07 INFO - 'PWD': '/builds/slave/test', 21:47:07 INFO - 'SHELL': '/bin/bash', 21:47:07 INFO - 'SHLVL': '1', 21:47:07 INFO - 'TERM': 'linux', 21:47:07 INFO - 'TMOUT': '86400', 21:47:07 INFO - 'USER': 'cltbld', 21:47:07 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', 21:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:07 INFO - '_': '/tools/buildbot/bin/python'} 21:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:08 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)) 21:47:08 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)) 21:47:08 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)) 21:47:08 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)) 21:47:08 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)) 21:47:08 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)) 21:47:08 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)) 21:47:08 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)) 21:47:08 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)) 21:47:08 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)) 21:47:08 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)) 21:47:08 INFO - Cleaning up... 21:47:08 INFO - Return code: 0 21:47:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952ed2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38f60>, '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 0x2c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3a1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', '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 21:47:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:47:08 INFO - Using env: {'DISPLAY': ':0', 21:47:08 INFO - 'HOME': '/home/cltbld', 21:47:08 INFO - 'LANG': 'en_US.UTF-8', 21:47:08 INFO - 'LANGUAGE': 'en_US:en', 21:47:08 INFO - 'LOGNAME': 'cltbld', 21:47:08 INFO - 'MAIL': '/var/mail/cltbld', 21:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:08 INFO - 'MOZ_NO_REMOTE': '1', 21:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:08 INFO - 'NO_EM_RESTART': '1', 21:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:08 INFO - 'PWD': '/builds/slave/test', 21:47:08 INFO - 'SHELL': '/bin/bash', 21:47:08 INFO - 'SHLVL': '1', 21:47:08 INFO - 'TERM': 'linux', 21:47:08 INFO - 'TMOUT': '86400', 21:47:08 INFO - 'USER': 'cltbld', 21:47:08 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', 21:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:08 INFO - '_': '/tools/buildbot/bin/python'} 21:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:47:08 INFO - Cleaning up... 21:47:08 INFO - Return code: 0 21:47:08 INFO - Running post-action listener: _resource_record_post_action 21:47:08 INFO - Running post-action listener: _start_resource_monitoring 21:47:08 INFO - Starting resource monitoring. 21:47:08 INFO - [mozharness: 2016-10-26 04:47:08.442303Z] Finished create-virtualenv step (success) 21:47:08 INFO - [mozharness: 2016-10-26 04:47:08.442812Z] Running install step. 21:47:08 INFO - Running pre-action listener: _resource_record_pre_action 21:47:08 INFO - Running main action method: install 21:47:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:47:08 INFO - Reading from file tmpfile_stdout 21:47:08 INFO - Detecting whether we're running mozinstall >=1.0... 21:47:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:47:08 INFO - Reading from file tmpfile_stdout 21:47:08 INFO - Output received: 21:47:08 INFO - Usage: mozinstall [options] installer 21:47:08 INFO - Options: 21:47:08 INFO - -h, --help show this help message and exit 21:47:08 INFO - -d DEST, --destination=DEST 21:47:08 INFO - Directory to install application into. [default: 21:47:08 INFO - "/builds/slave/test"] 21:47:08 INFO - --app=APP Application being installed. [default: firefox] 21:47:08 INFO - mkdir: /builds/slave/test/build/application 21:47:08 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'] 21:47:08 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 21:47:25 INFO - Reading from file tmpfile_stdout 21:47:25 INFO - Output received: 21:47:25 INFO - /builds/slave/test/build/application/firefox/firefox 21:47:25 INFO - Running post-action listener: _resource_record_post_action 21:47:25 INFO - [mozharness: 2016-10-26 04:47:25.651538Z] Finished install step (success) 21:47:25 INFO - [mozharness: 2016-10-26 04:47:25.651811Z] Running run-tests step. 21:47:25 INFO - Running pre-action listener: _resource_record_pre_action 21:47:25 INFO - Running main action method: run_tests 21:47:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:47:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:47:25 INFO - Python 2.7.3 21:47:25 INFO - Return code: 0 21:47:25 INFO - grabbing minidump binary from tooltool 21:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:25 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 0x2c38f60>, '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 0x2c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:47:25 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 21:47:25 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 21:47:25 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 21:47:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:47:25 INFO - Return code: 0 21:47:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:47:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:47:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:47:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:47:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:47:25 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/1477445407/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 21:47:25 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/1477445407/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 21:47:25 INFO - Using env: {'DISPLAY': ':0', 21:47:25 INFO - 'HOME': '/home/cltbld', 21:47:25 INFO - 'LANG': 'en_US.UTF-8', 21:47:25 INFO - 'LANGUAGE': 'en_US:en', 21:47:25 INFO - 'LOGNAME': 'cltbld', 21:47:25 INFO - 'MAIL': '/var/mail/cltbld', 21:47:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:47:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:25 INFO - 'MOZ_NO_REMOTE': '1', 21:47:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:25 INFO - 'NO_EM_RESTART': '1', 21:47:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:25 INFO - 'PWD': '/builds/slave/test', 21:47:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:47:25 INFO - 'SHELL': '/bin/bash', 21:47:25 INFO - 'SHLVL': '1', 21:47:25 INFO - 'TERM': 'linux', 21:47:25 INFO - 'TMOUT': '86400', 21:47:25 INFO - 'USER': 'cltbld', 21:47:25 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627', 21:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:25 INFO - '_': '/tools/buildbot/bin/python'} 21:47:25 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/1477445407/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 21:47:25 INFO - mozversion application_buildid: 20161025183007 21:47:25 INFO - mozversion application_changeset: ac6306117c61a56f8446d99415a853becd7a21c0 21:47:25 INFO - mozversion application_display_name: Nightly 21:47:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:47:25 INFO - mozversion application_name: Firefox 21:47:25 INFO - mozversion application_remotingname: firefox 21:47:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:47:25 INFO - mozversion application_vendor: Mozilla 21:47:25 INFO - mozversion application_version: 52.0a1 21:47:25 INFO - mozversion platform_buildid: 20161025183007 21:47:25 INFO - mozversion platform_changeset: ac6306117c61a56f8446d99415a853becd7a21c0 21:47:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:47:25 INFO - mozversion platform_version: 52.0a1 21:47:25 INFO - using testdate: 1477457245 21:47:25 INFO - actual date: 1477457245 21:47:25 INFO - starting webserver on 'localhost:43007' 21:47:25 INFO - SUITE-START | Running 2 tests 21:47:25 INFO - TEST-START | dromaeo_css 21:47:25 INFO - operating with platform_type : linux_ 21:47:25 INFO - Initialising browser for dromaeo_css test... 21:47:25 INFO - TEST-INFO | started process 23872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTWTXFO/profile http://localhost:43007/getInfo.html) 21:47:30 INFO - PROCESS | 23872 | __metrics Screen width/height:1600/1200 21:47:30 INFO - PROCESS | 23872 | colorDepth:24 21:47:30 INFO - PROCESS | 23872 | Browser inner width/height: 1024/697 21:47:30 INFO - PROCESS | 23872 | __metrics 21:47:30 INFO - PROCESS | 23872 | 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" 21:47:30 INFO - PROCESS | 23872 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:47:31 INFO - PROCESS | 23872 | console.error: PushService: 21:47:31 INFO - PROCESS | 23872 | stateChangeProcessEnqueue: Error transitioning state 21:47:31 INFO - PROCESS | 23872 | UnknownError 21:47:32 INFO - TEST-INFO | 23872: exit 0 21:47:32 INFO - Browser initialized. 21:47:32 INFO - Running cycle 1/1 for dromaeo_css test... 21:47:32 INFO - TEST-INFO | started process 23954 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTWTXFO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:47:44 INFO - PROCESS | 23954 | RSS: Main: 171896832 21:47:44 INFO - PROCESS | 23954 | 21:48:35 INFO - PROCESS | 23954 | 1477457315312 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] 21:50:46 INFO - PROCESS | 23954 | Cycle 1(1): loaded http://localhost:43007/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43007/tests/dromaeo/cssquery-ext.html) 21:50:48 INFO - PROCESS | 23954 | RSS: Main: 305430528 21:50:48 INFO - PROCESS | 23954 | 21:53:50 INFO - PROCESS | 23954 | Cycle 1(1): loaded http://localhost:43007/tests/dromaeo/cssquery-ext.html (next: http://localhost:43007/tests/dromaeo/cssquery-jquery.html) 21:53:51 INFO - PROCESS | 23954 | RSS: Main: 275578880 21:53:51 INFO - PROCESS | 23954 | 21:56:53 INFO - PROCESS | 23954 | Cycle 1(1): loaded http://localhost:43007/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43007/tests/dromaeo/cssquery-mootools.html) 21:56:54 INFO - PROCESS | 23954 | RSS: Main: 214999040 21:56:54 INFO - PROCESS | 23954 | 21:59:56 INFO - PROCESS | 23954 | Cycle 1(1): loaded http://localhost:43007/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43007/tests/dromaeo/cssquery-prototype.html) 21:59:56 INFO - PROCESS | 23954 | RSS: Main: 222941184 21:59:56 INFO - PROCESS | 23954 | 22:02:59 INFO - PROCESS | 23954 | Cycle 1(1): loaded http://localhost:43007/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43007/tests/dromaeo/cssquery-yui.html) 22:03:00 INFO - PROCESS | 23954 | RSS: Main: 218320896 22:03:00 INFO - PROCESS | 23954 | 22:06:03 INFO - PROCESS | 23954 | Cycle 1(1): loaded http://localhost:43007/tests/dromaeo/cssquery-yui.html (next: http://localhost:43007/tests/dromaeo/cssquery-dojo.html) 22:06:03 INFO - PROCESS | 23954 | RSS: Main: 308850688 22:06:03 INFO - PROCESS | 23954 | 22:06:03 INFO - PROCESS | 23954 | __start_tp_report 22:06:03 INFO - PROCESS | 23954 | _x_x_mozilla_page_load 22:06:03 INFO - PROCESS | 23954 | _x_x_mozilla_page_load_details 22:06:03 INFO - PROCESS | 23954 | |i|pagename|runs| 22:06:03 INFO - PROCESS | 23954 | |0;dojo.html;3038.6049813524237;3075.169704179873;3082.2602575381907;3109.797863138896;3114.2837147456084;5295.391030031547;5368.033753924292;5400.675959442437;5495.890082198353;5508.3114610673665;5366.597505187107;5374.5700343972485;5385.488378604036;5387.299651045369;5393.352797664285;4838.443578988417;4840.491748366424;4874.195757699975;4909.018196360725;4922.064807686546;4904;4959.380077490314;4960;4960.801567937278;4963.280324352967;4881.609471242292;4904.75476226189;4927.581155601778;4932.383452068491;4939.43196532398;4944.35723355965;4947.282644016634;4955;4960.454350021495;5013.9247911281;4750.358701575277;4787.616990640775;4838.491958344358;4872.853814385574;4878.682885612424;5399.028174928511;5428.61999660024;5431.755570999315;5447.319085114361;5521.806736764234;5769.509591684712;5833.88332233353;5836.649801011953;5840.737166827503;5843;5592.161175823619;5724.4561766632105;5730;5867.970660146715;5881.441263080001;5311.548518375943;5316.415194328621;5329.467053294639;5371.167469042305;5375.973120134374;5861.6189947653265;5872.794452194153;5875.206847075676;5879.911801322984;5879.970600146972;5641.774329026793;5642.7178641067785;5647.1529270609735;5655.830325090254;5656.6888821115235;5605.943940560624;5646.576506761927;5649.435056494318;5703.9429605704245;5706.3722990471015;5624.831255062355;5684.431556844283;5685.602007859493;5686.488216060575;5688.11834165705;5650.26546548946;5665.801696940587;5670.546356291569;5671.1493276008105;5681.630694004876;4390.429244198233;4394.802233899418;4435.112977404532;4435.489918659331;4444.777761111932;3890.6498415142773;3909.7654140751647;3934.09515811365;3936.4488971544006;3963.9405408918888;5433.782648694008;5480.7533660985355;5490.862728431741;5491.670499770026;5533.474319939599;5754.769809207669;5806.2451881255165;5809.099589563624;5829.795957141565;5900.704964751745;5480.177973303957;5503.091989821634;5514.310711161105;5515.558755299567;5523.7790488380815;4875.658703890765;5010.248462730619;5012.924806127911;5019.84940451787;5078.619103567247;5853.209816674695;5928;5936.5844390892225;5974.61165024272;6055;5799.594028417971;5805.8548536286935;5807.8548036299435;5809.82570522885;5811.912821307768;5945.494632956247;5973.104034394875;5992.280926288873;5992.340842507408;5999.760009599567;5604.747786349705;5608.719564021864;5640.238567793295;5656.349519805275;5671.829845104653;5738.885222295614;5791.7683292667825;5792.362840087671;5795.159701843293;5847.94152058474;5645.125005624135;5646.576506761927;5650.773969041193;5653.689047102284;5658.151277308272;5588.441155884379;5602.635828671123;5611;5629.0712032514175;5655.1517272409465;5633;5663.348714897839;5668;5713.428657134254;5730.398308177748;5654.717264136694;5689.544836412994;5694.373618901835;5697.943020569741;5709.34342550612;5440.510354068153;5483;5495.148252020943;5559.6664200148125;5579.107342825291 22:06:03 INFO - PROCESS | 23954 | |1;ext.html;552.7776610595217;565.7538970547812;609.3693027716313;618.6690120785381;621.571115930008;34174.65825341749;42228.78885605572;43004.784976075076;43007.78496107523;46274.30588541166;43321;43739.56260437395;43754.34368484475;43787.34318985218;43938.12123757523;7987.920120798775;8752.29981601472;8895.33285003624;8905;8905.95547022264;8206.876896846523;10421.478926053705;10673.19951003674;10688.412137332483;11023.393713345762;10755.085817705505;10817.405042722647;10821.729456763605;10826.566937322497;10826.67519974402;10672.199585031114;10710.946445267802;10730.356178629307;10739.731506712316;10745.301555398913;10542.841857372145;10608.87822435516;10611.098056665192;10613.41626210558;10616.256862019662;42122.157556849;42401.36397954002;42404.57595424068;42419.1516169678;42475.36286955698;3279.8032118072992;3288.539604455378;3325.2850637112897;3339.5825521809775;3359.718294404305;31232.843835780677;31284.37431251362;31599;31608;32146.517802232986;3980.223856348013;3984.561698213194;4042.9595704042877;4134.524529679095;4160.91678166438;328727;329617;330177;330187;332208.33895830606;51522;51814.48185518172;51835.22247166296;51844;51867.48132518702;61148.69425652932;61179.6941015301;61249.69375153185;61259.69370153121;61301.38698613046;13389.397477113553;13993.230372329619;14027.719445611236;14285.85714142866;14296.785548216785;9606.759831004141;9854.556544955494;10069.54687039085;10373;10495.26533142688;18268.54328641768;18720.438386848415;18728.34450794243;18839.340623078126;18846.71729924052;6925.722971081101;6971.721131154798;6972.163340399185;7119.644017799089;7237.89143162853;876.3996662286354;916.3860213656866;949.7055912667096;1049.1606714628267;1132.937688427128;29177.708222917925;30938.845305773328;30939.535906961413;31230.53154202689;31699.683003170136;1052.3738375666467;1063.6596289187542;1078.1751959750798;1079.3631757263252;1081.3457857995957;15817.209139542976;16374.181290935405;16478.505644830675;16513.33946642145;16699.41552045697;484515;487811;489503;490550;490881;57559;57619.711901441064;57652.71173644105;58227.41772582305;58266.12600810991;1160.6808127764932;1205.4876677412065;1218.0803493362455;1248.6066888929959;1290.1742884553894;28313.71686283193;32515.837420812746;32523.34953300968;32592.02223933286;32955.17612059718;47967.52032479631;48719;48790;48799.26801098057;48820.2676959853;388463;390335;390606;391425;392118;26662.866685666446;27176.320591985357;27473.86263068752;27585.724142758314;28790.856045719636;44864.77567612141;45035;45360.31959520544;45484.31773523466;46826.53173468222;38245.617543824206;38621;38885.02787430337;39849.60150398459;40548.39177412282;38435.80782096072;38802.6119738799;39015.6098439012;40105;40602.79698601488;38546.421803672405;38868;39260.214795704494;39501.802490987364;39563.604363955994;32642.51036234411;35142.29715405728;35651.64348356587;35715.82142089273;35928;26820.329491762863;27106.864465677547;27335.589966150124;27341.53735689551;27468.313292167055 22:06:03 INFO - PROCESS | 23954 | |2;jquery.html;360.7402670077543;368.90408493791614;372.6571554170165;380.4236581578908;394.2824060210418;14716.411343546259;18119.36582219621;18135.818641813577;18451.261949522035;19549.804501954975;16521.173941302917;16999.660006799855;17127.14364281787;17244.655106897855;17314.740278895828;5109.156989096804;5256.290400795881;5290.1006828839;5291.3650361956425;5304.20436934461;3693.593704692495;3808.5810560838286;5175.404828444739;5254.553362964152;5259.658122222062;6286.46565041972;6359.968200159016;6382.680865956683;6392;6394.26465956414;6127.724252408652;6268.341824108471;6299.181106456132;6311.242650881878;6366.458850997671;5592.4407559244155;5594.440555944373;5594.888102237933;5597.272354593917;5599.524040456566;13227;13269.668258293523;13277.86722132776;13288.202707837465;14354.85645143556;2208.061573831131;2262.1766638096283;2289.5077558324874;2304.37781798915;2384.427737343025;9630.47032413217;10068.244881633907;10136.087752102347;12334.629961101182;13499.98750093737;1773.3704534890057;1792.8794503435354;1856.1368963431935;1922.442491677412;2054.95890082199;75303.6234818828;79916;79925;81729.9999999994;83876.58061709713;9937.602495900082;9940.850887236697;10096.949515252376;10236.641717539851;10272.845907311395;13879.403868555044;13892.93053534726;13895.513657021957;13902.652433689238;13908;6891.758788442481;7045.436365090781;7110.466714996396;7216.67524961378;7292.744753933587;6641.701123449359;6672.266050734415;6920.031195632616;6928.44572434204;6932.168139823253;4182.100848317566;4223.957760422418;4226.746395216297;4370.409994650681;4398.3402489626815;1847.5381154711322;1872.157529111905;1890.060955214627;1890.810918908098;1905.8189472000415;898.3980732908967;938.2540880000416;949.6676163342775;980.3333733061587;999.4303247149055;18663.293822395946;19725.901370493055;19819.702704459443;19837.206511739656;20114.295999639944;929.2983797233181;950.6815216902277;961.1685891703626;971.9562619682131;979.7305740921304;9194.310426718022;10876.891231087746;10914.672559823219;10923.672289831318;10970.835437468444;445081;445906;450744;457402;457504;89067;89288;90536.54731726299;90792;92828.53585732164;950.2872845365976;955.861400096982;975.11264749078;983.7196399026243;986.7829077602916;16799.41202057971;17060.829391705924;17255.827441725924;17474.47576572705;17780.733289000935;41769.16461670689;42256.57743422526;42489.78755106204;42867.785661071495;43101.35347969846;53510.4648953521;57716.322480341274;58958.70520647369;59624;59892.40107598868;6834.931650683429;7273.672684729094;7475.813104672427;8145.51126932386;8365.707200247962;11912.344821034927;11959.521619135137;12320.383980800745;12692.936535317263;12810.167339122927;10119.7470063249;10580.20648451354;10780.622678206539;11007.394593297446;11373.943130284295;10544.420056896945;10728.624498142528;10910.836337455103;10923.453827308762;11071.612493562687;10669.146468282674;10834.187435942493;11002.559897604006;11116.833247501456;11315.660530184108;7192.250357718126;7232.204457509775;7497.3252407281425;7540.547567145989;7765.262300081483;9095.863562046707;10150;10607.204459665401;10626.415547144672;10903.29128606638 22:06:03 INFO - PROCESS | 23954 | |3;mootools.html;1299.3178581244852;1447.8914081443888;1490.4783325835956;1582.1456413536691;1736.2794440307273;7329.6701648425815;8296;8400.705975290866;8503.659853605865;8623.223909848113;8446.450980686252;8539.359548033892;8545.359098067638;8549.102344253857;8550.572471376438;2239.675247089171;2256.0862850545473;2274.6815445837597;2277.908883644652;2288.61093614086;2236.563870045342;2278.840481166319;2306.7231932168165;2318.258157389636;2341.110378056345;2252.335561009506;2262.3552287598036;2264.852784568998;2277.3054218463362;2285.337252196869;2161.6973623692697;2211.3255457085584;2226.666000099982;2229.3534874886263;2230.386643672987;2223.177424353;2244.6745221942892;2248.392933907836;2276.6698828669914;2284.771522847702;8419.579021048923;8493.405461617689;8560.186782255676;8564.400491965565;8565.01502327234;4993.325901003354;5181.3782346118705;5200.713960732158;5203.349581302337;5205.557527610158;3311.6853898879567;3348.665133486656;3410.8124053177066;3488.5464889564446;3495.7378196635354;1006.0492834271616;1029.4080903480453;1036.9585216591327;1055.6147006342705;1092.464692300775;11151.776964460747;11157.218994670377;11244.662660120128;11248.887511124947;11271.211015229019;4081.673466122703;4291.763952982616;4352.630026447724;4357.368181613649;4367.606915377632;9387.953060234655;9388.061193880558;9390.295727820441;9392.483413412328;9403.90596094044;4868.780904859219;4873.853784386474;4876.561109500162;4876.707397556087;4879.121758083508;4026.1545075534464;4139.648129908992;4462.843800466968;4554.27131658933;4567.177907976529;3567.4470457079196;3602.351576716164;3687.9631203688155;3717.3494638438706;3729.198222382201;1084.5228099636136;1089.2429761315968;1090.4765712458066;1095.479647167605;1097.9341239525654;854.448880472092;864.8659457784054;876.4346996187423;882.5807741322949;916.876221710074;5469.753861076261;5544.91682624761;5583.330000399978;5736.799212027559;5855.707214639251;909.8043920556979;985.9063388978036;1000.0749306891242;1000.429755039635;1054.167207905746;3696.5194524711615;3726.832292546842;3796.3735983562956;3847.615238476186;3882.107115363482;10152.137068349126;10411.271211015157;10505.31715438494;10508.527116279633;10532.262741608014;10458.111060559786;10465.372077675363;10473;10473.633422830164;10478.895211047944;7444.218357072537;7719.266669666485;7896.565688887052;8021.598920053974;8044.597770111471;5438.293021907285;5650;5660.462256085665;5791.362950075404;5817.185594016756;9391.953040234755;9437.622495100119;9536.189423899046;9596.32825702222;9650.324477286804;9677.70966870995;9790;9865.950670246602;9908.058734420218;9918.30571859963;6759.797206083826;6969.0940177776565;7399.8150046249275;7474.7757567273065;7556.622168891424;8306.87539686893;8312.41813073079;8361.790955225924;8365.665373384996;8371.581420929051;7288.635568221462;7299.233580474186;7417.480776345604;7509.6245187739305;7747;6808.114945057111;7051.964740176266;7087.61018144007;7151.070360853056;7224.313690199423;6367.490600751836;6456.709448074754;6469.514786391133;6471.255805582418;6471.838204044937;4573.153966516205;4614.561616646413;4844.685095468783;4848.10310092634;4938.555530002317;4779;4801.255805350176;4897.7795999180835;4920.089783390084;4953.578945789648 22:06:03 INFO - PROCESS | 23954 | |4;prototype.html;311.7973317343725;320.0717918037692;327.33387556322884;329.2624521072798;333.8130646837771;5200.193969934657;5319.090468505655;5357.30355053843;5378.865528361793;5439.5104440600335;5173.249878767577;5271.942273481382;5275.314209152814;5291.841244762663;5296.484170019239;4151.086760912594;4155.231282212801;4159.750414975111;4161.895952601179;4176.770277634729;3968.9007774805573;4105.835766569334;4182.811773470201;4188.47120800907;4189.706720529564;4041.373587094005;4054.1891621675636;4056.574059723731;4066.369712694537;4067.9186416271655;4045.1707399982934;4057.3711074783455;4059.1881623675235;4061.4110953911813;4070.4504891839665;3569.1790888095884;3569.839357228931;3573.1781690211396;3573.4282514797505;3582.7133829293853;5133.484592549661;5141.228815677641;5159.226116082617;5173.793048278102;5201.061400308851;4614.123316569841;4633.467151277612;4645.999999999966;4654.301854721785;4656.557627025427;5483.7806487740445;5507.862303442406;5515.448455154493;5529.695866727328;5532.446755324476;3787.5644300905196;3859.6333348332146;3881.4371916072296;3884.961150388488;3896.59085795993;5719;5730.627509211888;5737.713114344266;5784.68184249866;5814.895169917702;4033.556308806029;4039.2123535910805;4048.858289959896;4059.837606495707;4067.51189857219;3993.7803420812133;4039.818208180639;4059.4722686050623;4079.469668943078;4115.218108559364;4645.581897629162;4646.907061858811;4655;4660.720356778605;4667.159911215946;5557.749901254453;5557.861053473695;5557.888842223133;5624.606277560613;5647.971760141255;1311.6196303072193;1318.261773406876;1398.7622104242303;1405.9437622494986;1412.8516505766952;862.8533149364498;877.7147427086222;897.9910200898038;904.3850181876255;906.3836591117971;4723.48041715411;4725.125851717443;4730.455997560256;4758.455674830529;4758.666893317434;4996.4503904570465;5040.227874668991;5043.84868453947;5058.317127187856;5062.7468626568525;4414;4775.689580177347;4791.280588620206;4799.616030717534;4806.375171227718;2667.5065112953775;2685.8657067146564;2691.4078902641386;2694;2703.635009273723;5134.2298655201275;5173.430922598511;5176.896462070813;5188.848920863295;5198.506141916512;4841.491643377465;5055.949440505621;5070.783012077075;5095.719735414587;5102.443754654866;5049;5082.237664350377;5101.923471147936;5137.563307118937;5164.922526162186;4943.813484763703;4978.4274808397495;4995.550400463976;5038.924416133687;5128.692278463304;4729.834146730564;4734.952650473451;4867.053178728537;4894.657373983787;4951.9257211142585;5069.264956581349;5141.562967147835;5193.480651934777;5212.270282160424;5242.554382877345;3704.24063067076;3704.8888533344043;3709.1839795245005;3745.194783121642;3754.6808521274907;4811.941372897957;5006;5092.185250359925;5094.643374963865;5168.250603662373;4921;4931.767058235441;4936.629752768628;4939.703617782944;4940.505949405031;4938.851834444972;4963.280324352876;4967;5017.8243761468175;5052.494750524918;4886.633502487399;4886.975565122151;4958.752062396938;5246.31797866275;5604.691741954069;5599.580031497572;5616.213730077874;5621.494065534122;5671.6597004179885;5679.432056794288;5441.455854414685;5499.835004949858;5502.5597952164535;5535.308086489189;5552.50027497511 22:06:03 INFO - PROCESS | 23954 | |5;yui.html;689.6276010954083;699.3391245273216;704.3132945378254;709.6700034483964;748.4723270094584;13496.730065398686;14191.077579957295;14222.715545689105;14280.4287828487;14336.211508367036;13374.331283435813;13524.72950540991;13528.729425411486;13532;13535.458581656721;645.9838504037414;660.224236522087;769.4383100336729;787.7203592724586;805.9959700201491;787.9054513458365;801.6753214947926;802.2378740196837;802.2619190344867;802.6107337941094;853.2875049333813;854.2738672128672;854.7563944275882;854.7692123126752;854.8418542569614;686.3411125319699;705.5378726933867;818.7298191596818;848.5417874347845;853.906070332266;614.2843587220882;617.7683368736724;618.2642655240295;618.5391883047114;618.7184830901929;13856.445742170403;13919.095258808245;14079.859201407957;14081.85918140826;14091.295435228198;13498.59504214875;13566.389512471962;13631.795523067161;13700.725985480334;13744.381502832297;12160.391980400944;12199.20705154171;12217.694557636041;12566.74866502674;12600;4322.527845422975;4457.130859482402;4475.843345482925;4595.2188128018315;4621.1219868224925;66282;67743.66128169328;68000.31999680039;68243;68370;10202.591896324064;10273.845892311621;10277.537510812032;10449.477526123663;10585.947070264754;19769.901150494155;19774.110165042606;19785.10967006488;19789.901050494656;19810.306639267557;7032.472564557678;7939.404544659058;7957.045154581488;7961.880571791427;7965.6017199139815;3843.865464708778;3957.1294315250598;3995.141044675409;4078.1232035112594;4108.630223279919;3222.9838850806063;3308.9172770680925;3318.900432987014;3320.6015278166774;3320.634730179678;578.8842231553706;593.3295376224838;594.5451729426992;599.3706608061605;599.8260504453747;556.3268445181376;566.9206311116448;587.759018802289;590.5334785519477;631.2425089892148;8023.237792409712;8211.58942052907;8374.748757537283;8464.957675211585;8688.571271562849;564.5032371513042;618.730852079347;624.5940138909655;640.2796853539768;656.6454114778062;4187.14163596462;4202.327627579572;4246.72396294246;4299.591538803808;4304.956950430518;82857.58571207106;86213;87900;88203;91023;46873.25013998872;47964.7601761989;58475.415245847;59768.10347844786;75866;70955;71214;71234.64382678054;71371.64314178396;73892.63053684698;8103.240997091949;8342.916570834213;8422.157784221528;8479.279261262614;8796.340274479568;30699.846500767355;39103.2179356417;44030.55969440265;48144.14846812317;49740.751296244736;39800.60199398085;40634.39048414217;51008;58709.70645146747;60564.39435605588;11855.525778968744;11878.406079696153;11892.227005244631;12123.333216672814;12565.623031309075;13358.465661373824;13934.372953217333;13945;13956;14313.57059288223;12890.48438062467;13131.868681313446;13780.862191378359;14085.507007254697;14218.075825071337;12584.30786306762;12707.36463176819;12725.93637031809;12734.808977865525;13412.865871341162;12548.30984295836;13029.283389413673;13273.867261327263;13282.468701252228;13425.664358390728;10419.791604167722;10767.892321077003;10924.453777310944;11125.221234513507;11276.94361528187;9850.408975461496;10209.74475638115;10990.285631433931;10994.725131871768;11027.779444411228 22:06:03 INFO - PROCESS | 23954 | __end_tp_report 22:06:03 INFO - PROCESS | 23954 | __start_cc_report 22:06:03 INFO - PROCESS | 23954 | _x_x_mozilla_cycle_collect,1297 22:06:03 INFO - PROCESS | 23954 | __end_cc_report 22:06:03 INFO - PROCESS | 23954 | __startTimestamp1477458363274__endTimestamp 22:06:03 INFO - PROCESS | 23954 | 22:06:03 INFO - PROCESS | 23954 | ------- Summary: start ------- 22:06:03 INFO - PROCESS | 23954 | Number of tests: 6 22:06:03 INFO - PROCESS | 23954 | 22:06:03 INFO - PROCESS | 23954 | [#0] dojo.html Cycles:165 Average:5357.19 Median:5602.64 stddev:609.55 (10.9%) stddev-sans-first:583.65 22:06:03 INFO - PROCESS | 23954 | Values: 3038.6 3075.2 3082.3 3109.8 3114.3 5295.4 5368.0 5400.7 5495.9 5508.3 5366.6 5374.6 5385.5 5387.3 5393.4 4838.4 4840.5 4874.2 4909.0 4922.1 4904.0 4959.4 4960.0 4960.8 4963.3 4881.6 4904.8 4927.6 4932.4 4939.4 4944.4 4947.3 4955.0 4960.5 5013.9 4750.4 4787.6 4838.5 4872.9 4878.7 5399.0 5428.6 5431.8 5447.3 5521.8 5769.5 5833.9 5836.6 5840.7 5843.0 5592.2 5724.5 5730.0 5868.0 5881.4 5311.5 5316.4 5329.5 5371.2 5376.0 5861.6 5872.8 5875.2 5879.9 5880.0 5641.8 5642.7 5647.2 5655.8 5656.7 5605.9 5646.6 5649.4 5703.9 5706.4 5624.8 5684.4 5685.6 5686.5 5688.1 5650.3 5665.8 5670.5 5671.1 5681.6 4390.4 4394.8 4435.1 4435.5 4444.8 3890.6 3909.8 3934.1 3936.4 3963.9 5433.8 5480.8 5490.9 5491.7 5533.5 5754.8 5806.2 5809.1 5829.8 5900.7 5480.2 5503.1 5514.3 5515.6 5523.8 4875.7 5010.2 5012.9 5019.8 5078.6 5853.2 5928.0 5936.6 5974.6 6055.0 5799.6 5805.9 5807.9 5809.8 5811.9 5945.5 5973.1 5992.3 5992.3 5999.8 5604.7 5608.7 5640.2 5656.3 5671.8 5738.9 5791.8 5792.4 5795.2 5847.9 5645.1 5646.6 5650.8 5653.7 5658.2 5588.4 5602.6 5611.0 5629.1 5655.2 5633.0 5663.3 5668.0 5713.4 5730.4 5654.7 5689.5 5694.4 5697.9 5709.3 5440.5 5483.0 5495.1 5559.7 5579.1 22:06:03 INFO - PROCESS | 23954 | 22:06:03 INFO - PROCESS | 23954 | [#1] ext.html Cycles:180 Average:56455.07 Median:38340.71 stddev:107944.44 (281.5%) stddev-sans-first:108165.65 22:06:03 INFO - PROCESS | 23954 | Values: 552.8 565.8 609.4 618.7 621.6 34174.7 42228.8 43004.8 43007.8 46274.3 43321.0 43739.6 43754.3 43787.3 43938.1 7987.9 8752.3 8895.3 8905.0 8906.0 8206.9 10421.5 10673.2 10688.4 11023.4 10755.1 10817.4 10821.7 10826.6 10826.7 10672.2 10710.9 10730.4 10739.7 10745.3 10542.8 10608.9 10611.1 10613.4 10616.3 42122.2 42401.4 42404.6 42419.2 42475.4 3279.8 3288.5 3325.3 3339.6 3359.7 31232.8 31284.4 31599.0 31608.0 32146.5 3980.2 3984.6 4043.0 4134.5 4160.9 328727.0 329617.0 330177.0 330187.0 332208.3 51522.0 51814.5 51835.2 51844.0 51867.5 61148.7 61179.7 61249.7 61259.7 61301.4 13389.4 13993.2 14027.7 14285.9 14296.8 9606.8 9854.6 10069.5 10373.0 10495.3 18268.5 18720.4 18728.3 18839.3 18846.7 6925.7 6971.7 6972.2 7119.6 7237.9 876.4 916.4 949.7 1049.2 1132.9 29177.7 30938.8 30939.5 31230.5 31699.7 1052.4 1063.7 1078.2 1079.4 1081.3 15817.2 16374.2 16478.5 16513.3 16699.4 484515.0 487811.0 489503.0 490550.0 490881.0 57559.0 57619.7 57652.7 58227.4 58266.1 1160.7 1205.5 1218.1 1248.6 1290.2 28313.7 32515.8 32523.3 32592.0 32955.2 47967.5 48719.0 48790.0 48799.3 48820.3 388463.0 390335.0 390606.0 391425.0 392118.0 26662.9 27176.3 27473.9 27585.7 28790.9 44864.8 45035.0 45360.3 45484.3 46826.5 38245.6 38621.0 38885.0 39849.6 40548.4 38435.8 38802.6 39015.6 40105.0 40602.8 38546.4 38868.0 39260.2 39501.8 39563.6 32642.5 35142.3 35651.6 35715.8 35928.0 26820.3 27106.9 27335.6 27341.5 27468.3 22:06:03 INFO - PROCESS | 23954 | 22:06:03 INFO - PROCESS | 23954 | [#2] jquery.html Cycles:180 Average:27201.75 Median:23241.66 stddev:74726.43 (321.5%) stddev-sans-first:74908.88 22:06:03 INFO - PROCESS | 23954 | Values: 360.7 368.9 372.7 380.4 394.3 14716.4 18119.4 18135.8 18451.3 19549.8 16521.2 16999.7 17127.1 17244.7 17314.7 5109.2 5256.3 5290.1 5291.4 5304.2 3693.6 3808.6 5175.4 5254.6 5259.7 6286.5 6360.0 6382.7 6392.0 6394.3 6127.7 6268.3 6299.2 6311.2 6366.5 5592.4 5594.4 5594.9 5597.3 5599.5 13227.0 13269.7 13277.9 13288.2 14354.9 2208.1 2262.2 2289.5 2304.4 2384.4 9630.5 10068.2 10136.1 12334.6 13500.0 1773.4 1792.9 1856.1 1922.4 2055.0 75303.6 79916.0 79925.0 81730.0 83876.6 9937.6 9940.9 10096.9 10236.6 10272.8 13879.4 13892.9 13895.5 13902.7 13908.0 6891.8 7045.4 7110.5 7216.7 7292.7 6641.7 6672.3 6920.0 6928.4 6932.2 4182.1 4224.0 4226.7 4370.4 4398.3 1847.5 1872.2 1890.1 1890.8 1905.8 898.4 938.3 949.7 980.3 999.4 18663.3 19725.9 19819.7 19837.2 20114.3 929.3 950.7 961.2 972.0 979.7 9194.3 10876.9 10914.7 10923.7 10970.8 445081.0 445906.0 450744.0 457402.0 457504.0 89067.0 89288.0 90536.5 90792.0 92828.5 950.3 955.9 975.1 983.7 986.8 16799.4 17060.8 17255.8 17474.5 17780.7 41769.2 42256.6 42489.8 42867.8 43101.4 53510.5 57716.3 58958.7 59624.0 59892.4 6834.9 7273.7 7475.8 8145.5 8365.7 11912.3 11959.5 12320.4 12692.9 12810.2 10119.7 10580.2 10780.6 11007.4 11373.9 10544.4 10728.6 10910.8 10923.5 11071.6 10669.1 10834.2 11002.6 11116.8 11315.7 7192.3 7232.2 7497.3 7540.5 7765.3 9095.9 10150.0 10607.2 10626.4 10903.3 22:06:03 INFO - PROCESS | 23954 | 22:06:03 INFO - PROCESS | 23954 | [#3] mootools.html Cycles:180 Average:5494.15 Median:4875.21 stddev:3108.99 (63.8%) stddev-sans-first:3101.73 22:06:03 INFO - PROCESS | 23954 | Values: 1299.3 1447.9 1490.5 1582.1 1736.3 7329.7 8296.0 8400.7 8503.7 8623.2 8446.5 8539.4 8545.4 8549.1 8550.6 2239.7 2256.1 2274.7 2277.9 2288.6 2236.6 2278.8 2306.7 2318.3 2341.1 2252.3 2262.4 2264.9 2277.3 2285.3 2161.7 2211.3 2226.7 2229.4 2230.4 2223.2 2244.7 2248.4 2276.7 2284.8 8419.6 8493.4 8560.2 8564.4 8565.0 4993.3 5181.4 5200.7 5203.3 5205.6 3311.7 3348.7 3410.8 3488.5 3495.7 1006.0 1029.4 1037.0 1055.6 1092.5 11151.8 11157.2 11244.7 11248.9 11271.2 4081.7 4291.8 4352.6 4357.4 4367.6 9388.0 9388.1 9390.3 9392.5 9403.9 4868.8 4873.9 4876.6 4876.7 4879.1 4026.2 4139.6 4462.8 4554.3 4567.2 3567.4 3602.4 3688.0 3717.3 3729.2 1084.5 1089.2 1090.5 1095.5 1097.9 854.4 864.9 876.4 882.6 916.9 5469.8 5544.9 5583.3 5736.8 5855.7 909.8 985.9 1000.1 1000.4 1054.2 3696.5 3726.8 3796.4 3847.6 3882.1 10152.1 10411.3 10505.3 10508.5 10532.3 10458.1 10465.4 10473.0 10473.6 10478.9 7444.2 7719.3 7896.6 8021.6 8044.6 5438.3 5650.0 5660.5 5791.4 5817.2 9392.0 9437.6 9536.2 9596.3 9650.3 9677.7 9790.0 9866.0 9908.1 9918.3 6759.8 6969.1 7399.8 7474.8 7556.6 8306.9 8312.4 8361.8 8365.7 8371.6 7288.6 7299.2 7417.5 7509.6 7747.0 6808.1 7052.0 7087.6 7151.1 7224.3 6367.5 6456.7 6469.5 6471.3 6471.8 4573.2 4614.6 4844.7 4848.1 4938.6 4779.0 4801.3 4897.8 4920.1 4953.6 22:06:03 INFO - PROCESS | 23954 | 22:06:03 INFO - PROCESS | 23954 | [#4] prototype.html Cycles:180 Average:4414.32 Median:4937.74 stddev:1269.17 (25.7%) stddev-sans-first:1234.82 22:06:03 INFO - PROCESS | 23954 | Values: 311.8 320.1 327.3 329.3 333.8 5200.2 5319.1 5357.3 5378.9 5439.5 5173.2 5271.9 5275.3 5291.8 5296.5 4151.1 4155.2 4159.8 4161.9 4176.8 3968.9 4105.8 4182.8 4188.5 4189.7 4041.4 4054.2 4056.6 4066.4 4067.9 4045.2 4057.4 4059.2 4061.4 4070.5 3569.2 3569.8 3573.2 3573.4 3582.7 5133.5 5141.2 5159.2 5173.8 5201.1 4614.1 4633.5 4646.0 4654.3 4656.6 5483.8 5507.9 5515.4 5529.7 5532.4 3787.6 3859.6 3881.4 3885.0 3896.6 5719.0 5730.6 5737.7 5784.7 5814.9 4033.6 4039.2 4048.9 4059.8 4067.5 3993.8 4039.8 4059.5 4079.5 4115.2 4645.6 4646.9 4655.0 4660.7 4667.2 5557.7 5557.9 5557.9 5624.6 5648.0 1311.6 1318.3 1398.8 1405.9 1412.9 862.9 877.7 898.0 904.4 906.4 4723.5 4725.1 4730.5 4758.5 4758.7 4996.5 5040.2 5043.8 5058.3 5062.7 4414.0 4775.7 4791.3 4799.6 4806.4 2667.5 2685.9 2691.4 2694.0 2703.6 5134.2 5173.4 5176.9 5188.8 5198.5 4841.5 5055.9 5070.8 5095.7 5102.4 5049.0 5082.2 5101.9 5137.6 5164.9 4943.8 4978.4 4995.6 5038.9 5128.7 4729.8 4735.0 4867.1 4894.7 4951.9 5069.3 5141.6 5193.5 5212.3 5242.6 3704.2 3704.9 3709.2 3745.2 3754.7 4811.9 5006.0 5092.2 5094.6 5168.3 4921.0 4931.8 4936.6 4939.7 4940.5 4938.9 4963.3 4967.0 5017.8 5052.5 4886.6 4887.0 4958.8 5246.3 5604.7 5599.6 5616.2 5621.5 5671.7 5679.4 5441.5 5499.8 5502.6 5535.3 5552.5 22:06:03 INFO - PROCESS | 23954 | 22:06:03 INFO - PROCESS | 23954 | [#5] yui.html Cycles:180 Average:16906.82 Median:4466.49 stddev:22248.56 (498.1%) stddev-sans-first:22277.65 22:06:03 INFO - PROCESS | 23954 | Values: 689.6 699.3 704.3 709.7 748.5 13496.7 14191.1 14222.7 14280.4 14336.2 13374.3 13524.7 13528.7 13532.0 13535.5 646.0 660.2 769.4 787.7 806.0 787.9 801.7 802.2 802.3 802.6 853.3 854.3 854.8 854.8 854.8 686.3 705.5 818.7 848.5 853.9 614.3 617.8 618.3 618.5 618.7 13856.4 13919.1 14079.9 14081.9 14091.3 13498.6 13566.4 13631.8 13700.7 13744.4 12160.4 12199.2 12217.7 12566.7 12600.0 4322.5 4457.1 4475.8 4595.2 4621.1 66282.0 67743.7 68000.3 68243.0 68370.0 10202.6 10273.8 10277.5 10449.5 10585.9 19769.9 19774.1 19785.1 19789.9 19810.3 7032.5 7939.4 7957.0 7961.9 7965.6 3843.9 3957.1 3995.1 4078.1 4108.6 3223.0 3308.9 3318.9 3320.6 3320.6 578.9 593.3 594.5 599.4 599.8 556.3 566.9 587.8 590.5 631.2 8023.2 8211.6 8374.7 8465.0 8688.6 564.5 618.7 624.6 640.3 656.6 4187.1 4202.3 4246.7 4299.6 4305.0 82857.6 86213.0 87900.0 88203.0 91023.0 46873.3 47964.8 58475.4 59768.1 75866.0 70955.0 71214.0 71234.6 71371.6 73892.6 8103.2 8342.9 8422.2 8479.3 8796.3 30699.8 39103.2 44030.6 48144.1 49740.8 39800.6 40634.4 51008.0 58709.7 60564.4 11855.5 11878.4 11892.2 12123.3 12565.6 13358.5 13934.4 13945.0 13956.0 14313.6 12890.5 13131.9 13780.9 14085.5 14218.1 12584.3 12707.4 12725.9 12734.8 13412.9 12548.3 13029.3 13273.9 13282.5 13425.7 10419.8 10767.9 10924.5 11125.2 11276.9 9850.4 10209.7 10990.3 10994.7 11027.8 22:06:03 INFO - PROCESS | 23954 | -------- Summary: end -------- 22:06:03 INFO - PROCESS | 23954 | 22:06:04 INFO - TEST-INFO | 23954: exit 0 22:06:04 INFO - TEST-OK | dromaeo_css | took 1118333ms 22:06:04 INFO - TEST-START | kraken 22:06:04 INFO - operating with platform_type : linux_ 22:06:04 INFO - Initialising browser for kraken test... 22:06:04 INFO - TEST-INFO | started process 24262 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_aQozC/profile http://localhost:43007/getInfo.html) 22:06:08 INFO - PROCESS | 24262 | __metrics Screen width/height:1600/1200 22:06:08 INFO - PROCESS | 24262 | colorDepth:24 22:06:08 INFO - PROCESS | 24262 | Browser inner width/height: 1024/697 22:06:08 INFO - PROCESS | 24262 | __metrics 22:06:08 INFO - PROCESS | 24262 | 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" 22:06:08 INFO - PROCESS | 24262 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:06:09 INFO - PROCESS | 24262 | console.error: PushService: 22:06:09 INFO - PROCESS | 24262 | stateChangeProcessEnqueue: Error transitioning state 22:06:09 INFO - PROCESS | 24262 | UnknownError 22:06:10 INFO - TEST-INFO | 24262: exit 0 22:06:10 INFO - Browser initialized. 22:06:10 INFO - Running cycle 1/1 for kraken test... 22:06:10 INFO - TEST-INFO | started process 24346 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_aQozC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:06:22 INFO - PROCESS | 24346 | RSS: Main: 172146688 22:06:22 INFO - PROCESS | 24346 | 22:06:24 INFO - PROCESS | 24346 | Cycle 1(1): loaded http://localhost:43007/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43007/tests/kraken/driver.html?testName=audio-beat-detection) 22:06:25 INFO - PROCESS | 24346 | RSS: Main: 229462016 22:06:25 INFO - PROCESS | 24346 | 22:06:28 INFO - PROCESS | 24346 | Cycle 1(1): loaded http://localhost:43007/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43007/tests/kraken/driver.html?testName=audio-dft) 22:06:28 INFO - PROCESS | 24346 | RSS: Main: 215773184 22:06:28 INFO - PROCESS | 24346 | 22:06:31 INFO - PROCESS | 24346 | Cycle 1(1): loaded http://localhost:43007/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43007/tests/kraken/driver.html?testName=audio-fft) 22:06:32 INFO - PROCESS | 24346 | RSS: Main: 296792064 22:06:32 INFO - PROCESS | 24346 | 22:06:34 INFO - PROCESS | 24346 | Cycle 1(1): loaded http://localhost:43007/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43007/tests/kraken/driver.html?testName=audio-oscillator) 22:06:35 INFO - PROCESS | 24346 | RSS: Main: 208453632 22:06:35 INFO - PROCESS | 24346 | 22:06:37 INFO - PROCESS | 24346 | Cycle 1(1): loaded http://localhost:43007/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43007/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:06:37 INFO - PROCESS | 24346 | RSS: Main: 212049920 22:06:37 INFO - PROCESS | 24346 | 22:06:40 INFO - PROCESS | 24346 | Cycle 1(1): loaded http://localhost:43007/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43007/tests/kraken/driver.html?testName=imaging-darkroom) 22:06:41 INFO - PROCESS | 24346 | RSS: Main: 247541760 22:06:41 INFO - PROCESS | 24346 | 22:06:44 INFO - PROCESS | 24346 | Cycle 1(1): loaded http://localhost:43007/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43007/tests/kraken/driver.html?testName=imaging-desaturate) 22:06:45 INFO - PROCESS | 24346 | RSS: Main: 246779904 22:06:45 INFO - PROCESS | 24346 | 22:06:47 INFO - PROCESS | 24346 | Cycle 1(1): loaded http://localhost:43007/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43007/tests/kraken/driver.html?testName=json-parse-financial) 22:06:48 INFO - PROCESS | 24346 | RSS: Main: 246210560 22:06:48 INFO - PROCESS | 24346 | 22:06:50 INFO - PROCESS | 24346 | Cycle 1(1): loaded http://localhost:43007/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43007/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:06:50 INFO - PROCESS | 24346 | RSS: Main: 208945152 22:06:50 INFO - PROCESS | 24346 | 22:06:52 INFO - PROCESS | 24346 | Cycle 1(1): loaded http://localhost:43007/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43007/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:06:53 INFO - PROCESS | 24346 | RSS: Main: 215330816 22:06:53 INFO - PROCESS | 24346 | 22:06:55 INFO - PROCESS | 24346 | Cycle 1(1): loaded http://localhost:43007/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43007/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:06:55 INFO - PROCESS | 24346 | RSS: Main: 225357824 22:06:55 INFO - PROCESS | 24346 | 22:06:58 INFO - PROCESS | 24346 | Cycle 1(1): loaded http://localhost:43007/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:06:59 INFO - PROCESS | 24346 | RSS: Main: 233619456 22:06:59 INFO - PROCESS | 24346 | 22:07:01 INFO - PROCESS | 24346 | Cycle 1(1): loaded http://localhost:43007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:07:02 INFO - PROCESS | 24346 | RSS: Main: 230940672 22:07:02 INFO - PROCESS | 24346 | 22:07:04 INFO - PROCESS | 24346 | Cycle 1(1): loaded http://localhost:43007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43007/tests/kraken/driver.html?testName=ai-astar) 22:07:04 INFO - PROCESS | 24346 | RSS: Main: 281432064 22:07:04 INFO - PROCESS | 24346 | 22:07:04 INFO - PROCESS | 24346 | __start_tp_report 22:07:04 INFO - PROCESS | 24346 | _x_x_mozilla_page_load 22:07:04 INFO - PROCESS | 24346 | _x_x_mozilla_page_load_details 22:07:04 INFO - PROCESS | 24346 | |i|pagename|runs| 22:07:04 INFO - PROCESS | 24346 | |0;ai-astar;103;109;111;110;109;110;109;109;109;110 22:07:04 INFO - PROCESS | 24346 | |1;audio-beat-detection;156;123;128;157;126;126;124;124;152;128 22:07:04 INFO - PROCESS | 24346 | |2;audio-dft;160;163;161;162;161;161;162;160;161;163 22:07:04 INFO - PROCESS | 24346 | |3;audio-fft;75;76;76;113;77;85;75;76;107;77 22:07:04 INFO - PROCESS | 24346 | |4;audio-oscillator;83;81;116;82;83;82;112;81;81;117 22:07:04 INFO - PROCESS | 24346 | |5;imaging-gaussian-blur;117;117;116;117;117;118;116;116;117;116 22:07:04 INFO - PROCESS | 24346 | |6;imaging-darkroom;145;145;146;145;145;145;147;146;146;146 22:07:04 INFO - PROCESS | 24346 | |7;imaging-desaturate;85;85;85;85;85;85;85;86;85;85 22:07:04 INFO - PROCESS | 24346 | |8;json-parse-financial;54;53;53;54;53;54;54;55;54;54 22:07:04 INFO - PROCESS | 24346 | |9;json-stringify-tinderbox;64;65;64;64;65;65;64;65;65;65 22:07:04 INFO - PROCESS | 24346 | |10;stanford-crypto-aes;80;84;79;79;80;80;81;87;80;79 22:07:04 INFO - PROCESS | 24346 | |11;stanford-crypto-ccm;133;154;140;137;139;130;127;134;170;131 22:07:04 INFO - PROCESS | 24346 | |12;stanford-crypto-pbkdf2;169;171;175;170;170;166;166;169;166;166 22:07:04 INFO - PROCESS | 24346 | |13;stanford-crypto-sha256-iterative;66;66;67;69;66;65;65;67;66;69 22:07:04 INFO - PROCESS | 24346 | __end_tp_report 22:07:04 INFO - PROCESS | 24346 | __start_cc_report 22:07:04 INFO - PROCESS | 24346 | _x_x_mozilla_cycle_collect,1661 22:07:04 INFO - PROCESS | 24346 | __end_cc_report 22:07:04 INFO - PROCESS | 24346 | __startTimestamp1477458424390__endTimestamp 22:07:04 INFO - PROCESS | 24346 | 22:07:04 INFO - PROCESS | 24346 | ------- Summary: start ------- 22:07:04 INFO - PROCESS | 24346 | Number of tests: 14 22:07:04 INFO - PROCESS | 24346 | 22:07:04 INFO - PROCESS | 24346 | [#0] ai-astar Cycles:10 Average:108.90 Median:109.50 stddev:2.18 (2.0%) stddev-sans-first:0.73 22:07:04 INFO - PROCESS | 24346 | Values: 103.0 109.0 111.0 110.0 109.0 110.0 109.0 109.0 109.0 110.0 22:07:04 INFO - PROCESS | 24346 | 22:07:04 INFO - PROCESS | 24346 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:128.00 stddev:14.36 (11.2%) stddev-sans-first:12.93 22:07:04 INFO - PROCESS | 24346 | Values: 156.0 123.0 128.0 157.0 126.0 126.0 124.0 124.0 152.0 128.0 22:07:04 INFO - PROCESS | 24346 | 22:07:04 INFO - PROCESS | 24346 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.01 22:07:04 INFO - PROCESS | 24346 | Values: 160.0 163.0 161.0 162.0 161.0 161.0 162.0 160.0 161.0 163.0 22:07:04 INFO - PROCESS | 24346 | 22:07:04 INFO - PROCESS | 24346 | [#3] audio-fft Cycles:10 Average:83.70 Median:76.00 stddev:14.23 (18.7%) stddev-sans-first:14.74 22:07:04 INFO - PROCESS | 24346 | Values: 75.0 76.0 76.0 113.0 77.0 85.0 75.0 76.0 107.0 77.0 22:07:04 INFO - PROCESS | 24346 | 22:07:04 INFO - PROCESS | 24346 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:81.50 stddev:16.07 (19.7%) stddev-sans-first:16.73 22:07:04 INFO - PROCESS | 24346 | Values: 83.0 81.0 116.0 82.0 83.0 82.0 112.0 81.0 81.0 117.0 22:07:04 INFO - PROCESS | 24346 | 22:07:04 INFO - PROCESS | 24346 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 22:07:04 INFO - PROCESS | 24346 | Values: 117.0 117.0 116.0 117.0 117.0 118.0 116.0 116.0 117.0 116.0 22:07:04 INFO - PROCESS | 24346 | 22:07:04 INFO - PROCESS | 24346 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 22:07:04 INFO - PROCESS | 24346 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 147.0 146.0 146.0 146.0 22:07:04 INFO - PROCESS | 24346 | 22:07:04 INFO - PROCESS | 24346 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 22:07:04 INFO - PROCESS | 24346 | Values: 85.0 85.0 85.0 85.0 85.0 85.0 85.0 86.0 85.0 85.0 22:07:04 INFO - PROCESS | 24346 | 22:07:04 INFO - PROCESS | 24346 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 22:07:04 INFO - PROCESS | 24346 | Values: 54.0 53.0 53.0 54.0 53.0 54.0 54.0 55.0 54.0 54.0 22:07:04 INFO - PROCESS | 24346 | 22:07:04 INFO - PROCESS | 24346 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 22:07:04 INFO - PROCESS | 24346 | Values: 64.0 65.0 64.0 64.0 65.0 65.0 64.0 65.0 65.0 65.0 22:07:04 INFO - PROCESS | 24346 | 22:07:04 INFO - PROCESS | 24346 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.00 stddev:2.60 (3.3%) stddev-sans-first:2.74 22:07:04 INFO - PROCESS | 24346 | Values: 80.0 84.0 79.0 79.0 80.0 80.0 81.0 87.0 80.0 79.0 22:07:04 INFO - PROCESS | 24346 | 22:07:04 INFO - PROCESS | 24346 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:138.00 stddev:13.07 (9.5%) stddev-sans-first:13.65 22:07:04 INFO - PROCESS | 24346 | Values: 133.0 154.0 140.0 137.0 139.0 130.0 127.0 134.0 170.0 131.0 22:07:04 INFO - PROCESS | 24346 | 22:07:04 INFO - PROCESS | 24346 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:169.50 stddev:2.94 (1.7%) stddev-sans-first:3.11 22:07:04 INFO - PROCESS | 24346 | Values: 169.0 171.0 175.0 170.0 170.0 166.0 166.0 169.0 166.0 166.0 22:07:04 INFO - PROCESS | 24346 | 22:07:04 INFO - PROCESS | 24346 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:1.43 (2.2%) stddev-sans-first:1.50 22:07:04 INFO - PROCESS | 24346 | Values: 66.0 66.0 67.0 69.0 66.0 65.0 65.0 67.0 66.0 69.0 22:07:04 INFO - PROCESS | 24346 | -------- Summary: end -------- 22:07:04 INFO - PROCESS | 24346 | 22:07:05 INFO - TEST-INFO | 24346: exit 0 22:07:05 INFO - TEST-OK | kraken | took 61390ms 22:07:05 INFO - SUITE-END | took 1179s 22:07:06 INFO - Completed test suite (00:19:40) 22:07:06 INFO - javascript benchmark 22:07:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3038.6049813524237, 3075.169704179873, 3082.2602575381907, 3109.797863138896, 3114.2837147456084, 5295.391030031547, 5368.033753924292, 5400.675959442437, 5495.890082198353, 5508.3114610673665, 5366.597505187107, 5374.5700343972485, 5385.488378604036, 5387.299651045369, 5393.352797664285, 4838.443578988417, 4840.491748366424, 4874.195757699975, 4909.018196360725, 4922.064807686546, 4904.0, 4959.380077490314, 4960.0, 4960.801567937278, 4963.280324352967, 4881.609471242292, 4904.75476226189, 4927.581155601778, 4932.383452068491, 4939.43196532398, 4944.35723355965, 4947.282644016634, 4955.0, 4960.454350021495, 5013.9247911281, 4750.358701575277, 4787.616990640775, 4838.491958344358, 4872.853814385574, 4878.682885612424, 5399.028174928511, 5428.61999660024, 5431.755570999315, 5447.319085114361, 5521.806736764234, 5769.509591684712, 5833.88332233353, 5836.649801011953, 5840.737166827503, 5843.0, 5592.161175823619, 5724.4561766632105, 5730.0, 5867.970660146715, 5881.441263080001, 5311.548518375943, 5316.415194328621, 5329.467053294639, 5371.167469042305, 5375.973120134374, 5861.6189947653265, 5872.794452194153, 5875.206847075676, 5879.911801322984, 5879.970600146972, 5641.774329026793, 5642.7178641067785, 5647.1529270609735, 5655.830325090254, 5656.6888821115235, 5605.943940560624, 5646.576506761927, 5649.435056494318, 5703.9429605704245, 5706.3722990471015, 5624.831255062355, 5684.431556844283, 5685.602007859493, 5686.488216060575, 5688.11834165705, 5650.26546548946, 5665.801696940587, 5670.546356291569, 5671.1493276008105, 5681.630694004876, 4390.429244198233, 4394.802233899418, 4435.112977404532, 4435.489918659331, 4444.777761111932, 3890.6498415142773, 3909.7654140751647, 3934.09515811365, 3936.4488971544006, 3963.9405408918888, 5433.782648694008, 5480.7533660985355, 5490.862728431741, 5491.670499770026, 5533.474319939599, 5754.769809207669, 5806.2451881255165, 5809.099589563624, 5829.795957141565, 5900.704964751745, 5480.177973303957, 5503.091989821634, 5514.310711161105, 5515.558755299567, 5523.7790488380815, 4875.658703890765, 5010.248462730619, 5012.924806127911, 5019.84940451787, 5078.619103567247, 5853.209816674695, 5928.0, 5936.5844390892225, 5974.61165024272, 6055.0, 5799.594028417971, 5805.8548536286935, 5807.8548036299435, 5809.82570522885, 5811.912821307768, 5945.494632956247, 5973.104034394875, 5992.280926288873, 5992.340842507408, 5999.760009599567, 5604.747786349705, 5608.719564021864, 5640.238567793295, 5656.349519805275, 5671.829845104653, 5738.885222295614, 5791.7683292667825, 5792.362840087671, 5795.159701843293, 5847.94152058474, 5645.125005624135, 5646.576506761927, 5650.773969041193, 5653.689047102284, 5658.151277308272, 5588.441155884379, 5602.635828671123, 5611.0, 5629.0712032514175, 5655.1517272409465, 5633.0, 5663.348714897839, 5668.0, 5713.428657134254, 5730.398308177748, 5654.717264136694, 5689.544836412994, 5694.373618901835, 5697.943020569741, 5709.34342550612, 5440.510354068153, 5483.0, 5495.148252020943, 5559.6664200148125, 5579.107342825291], "value": 5315.492950133148, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.7776610595217, 565.7538970547812, 609.3693027716313, 618.6690120785381, 621.571115930008, 34174.65825341749, 42228.78885605572, 43004.784976075076, 43007.78496107523, 46274.30588541166, 43321.0, 43739.56260437395, 43754.34368484475, 43787.34318985218, 43938.12123757523, 7987.920120798775, 8752.29981601472, 8895.33285003624, 8905.0, 8905.95547022264, 8206.876896846523, 10421.478926053705, 10673.19951003674, 10688.412137332483, 11023.393713345762, 10755.085817705505, 10817.405042722647, 10821.729456763605, 10826.566937322497, 10826.67519974402, 10672.199585031114, 10710.946445267802, 10730.356178629307, 10739.731506712316, 10745.301555398913, 10542.841857372145, 10608.87822435516, 10611.098056665192, 10613.41626210558, 10616.256862019662, 42122.157556849, 42401.36397954002, 42404.57595424068, 42419.1516169678, 42475.36286955698, 3279.8032118072992, 3288.539604455378, 3325.2850637112897, 3339.5825521809775, 3359.718294404305, 31232.843835780677, 31284.37431251362, 31599.0, 31608.0, 32146.517802232986, 3980.223856348013, 3984.561698213194, 4042.9595704042877, 4134.524529679095, 4160.91678166438, 328727.0, 329617.0, 330177.0, 330187.0, 332208.33895830606, 51522.0, 51814.48185518172, 51835.22247166296, 51844.0, 51867.48132518702, 61148.69425652932, 61179.6941015301, 61249.69375153185, 61259.69370153121, 61301.38698613046, 13389.397477113553, 13993.230372329619, 14027.719445611236, 14285.85714142866, 14296.785548216785, 9606.759831004141, 9854.556544955494, 10069.54687039085, 10373.0, 10495.26533142688, 18268.54328641768, 18720.438386848415, 18728.34450794243, 18839.340623078126, 18846.71729924052, 6925.722971081101, 6971.721131154798, 6972.163340399185, 7119.644017799089, 7237.89143162853, 876.3996662286354, 916.3860213656866, 949.7055912667096, 1049.1606714628267, 1132.937688427128, 29177.708222917925, 30938.845305773328, 30939.535906961413, 31230.53154202689, 31699.683003170136, 1052.3738375666467, 1063.6596289187542, 1078.1751959750798, 1079.3631757263252, 1081.3457857995957, 15817.209139542976, 16374.181290935405, 16478.505644830675, 16513.33946642145, 16699.41552045697, 484515.0, 487811.0, 489503.0, 490550.0, 490881.0, 57559.0, 57619.711901441064, 57652.71173644105, 58227.41772582305, 58266.12600810991, 1160.6808127764932, 1205.4876677412065, 1218.0803493362455, 1248.6066888929959, 1290.1742884553894, 28313.71686283193, 32515.837420812746, 32523.34953300968, 32592.02223933286, 32955.17612059718, 47967.52032479631, 48719.0, 48790.0, 48799.26801098057, 48820.2676959853, 388463.0, 390335.0, 390606.0, 391425.0, 392118.0, 26662.866685666446, 27176.320591985357, 27473.86263068752, 27585.724142758314, 28790.856045719636, 44864.77567612141, 45035.0, 45360.31959520544, 45484.31773523466, 46826.53173468222, 38245.617543824206, 38621.0, 38885.02787430337, 39849.60150398459, 40548.39177412282, 38435.80782096072, 38802.6119738799, 39015.6098439012, 40105.0, 40602.79698601488, 38546.421803672405, 38868.0, 39260.214795704494, 39501.802490987364, 39563.604363955994, 32642.51036234411, 35142.29715405728, 35651.64348356587, 35715.82142089273, 35928.0, 26820.329491762863, 27106.864465677547, 27335.589966150124, 27341.53735689551, 27468.313292167055], "value": 19602.18155257137, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.7402670077543, 368.90408493791614, 372.6571554170165, 380.4236581578908, 394.2824060210418, 14716.411343546259, 18119.36582219621, 18135.818641813577, 18451.261949522035, 19549.804501954975, 16521.173941302917, 16999.660006799855, 17127.14364281787, 17244.655106897855, 17314.740278895828, 5109.156989096804, 5256.290400795881, 5290.1006828839, 5291.3650361956425, 5304.20436934461, 3693.593704692495, 3808.5810560838286, 5175.404828444739, 5254.553362964152, 5259.658122222062, 6286.46565041972, 6359.968200159016, 6382.680865956683, 6392.0, 6394.26465956414, 6127.724252408652, 6268.341824108471, 6299.181106456132, 6311.242650881878, 6366.458850997671, 5592.4407559244155, 5594.440555944373, 5594.888102237933, 5597.272354593917, 5599.524040456566, 13227.0, 13269.668258293523, 13277.86722132776, 13288.202707837465, 14354.85645143556, 2208.061573831131, 2262.1766638096283, 2289.5077558324874, 2304.37781798915, 2384.427737343025, 9630.47032413217, 10068.244881633907, 10136.087752102347, 12334.629961101182, 13499.98750093737, 1773.3704534890057, 1792.8794503435354, 1856.1368963431935, 1922.442491677412, 2054.95890082199, 75303.6234818828, 79916.0, 79925.0, 81729.9999999994, 83876.58061709713, 9937.602495900082, 9940.850887236697, 10096.949515252376, 10236.641717539851, 10272.845907311395, 13879.403868555044, 13892.93053534726, 13895.513657021957, 13902.652433689238, 13908.0, 6891.758788442481, 7045.436365090781, 7110.466714996396, 7216.67524961378, 7292.744753933587, 6641.701123449359, 6672.266050734415, 6920.031195632616, 6928.44572434204, 6932.168139823253, 4182.100848317566, 4223.957760422418, 4226.746395216297, 4370.409994650681, 4398.3402489626815, 1847.5381154711322, 1872.157529111905, 1890.060955214627, 1890.810918908098, 1905.8189472000415, 898.3980732908967, 938.2540880000416, 949.6676163342775, 980.3333733061587, 999.4303247149055, 18663.293822395946, 19725.901370493055, 19819.702704459443, 19837.206511739656, 20114.295999639944, 929.2983797233181, 950.6815216902277, 961.1685891703626, 971.9562619682131, 979.7305740921304, 9194.310426718022, 10876.891231087746, 10914.672559823219, 10923.672289831318, 10970.835437468444, 445081.0, 445906.0, 450744.0, 457402.0, 457504.0, 89067.0, 89288.0, 90536.54731726299, 90792.0, 92828.53585732164, 950.2872845365976, 955.861400096982, 975.11264749078, 983.7196399026243, 986.7829077602916, 16799.41202057971, 17060.829391705924, 17255.827441725924, 17474.47576572705, 17780.733289000935, 41769.16461670689, 42256.57743422526, 42489.78755106204, 42867.785661071495, 43101.35347969846, 53510.4648953521, 57716.322480341274, 58958.70520647369, 59624.0, 59892.40107598868, 6834.931650683429, 7273.672684729094, 7475.813104672427, 8145.51126932386, 8365.707200247962, 11912.344821034927, 11959.521619135137, 12320.383980800745, 12692.936535317263, 12810.167339122927, 10119.7470063249, 10580.20648451354, 10780.622678206539, 11007.394593297446, 11373.943130284295, 10544.420056896945, 10728.624498142528, 10910.836337455103, 10923.453827308762, 11071.612493562687, 10669.146468282674, 10834.187435942493, 11002.559897604006, 11116.833247501456, 11315.660530184108, 7192.250357718126, 7232.204457509775, 7497.3252407281425, 7540.547567145989, 7765.262300081483, 9095.863562046707, 10150.0, 10607.204459665401, 10626.415547144672, 10903.29128606638], "value": 8641.619027216691, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.3178581244852, 1447.8914081443888, 1490.4783325835956, 1582.1456413536691, 1736.2794440307273, 7329.6701648425815, 8296.0, 8400.705975290866, 8503.659853605865, 8623.223909848113, 8446.450980686252, 8539.359548033892, 8545.359098067638, 8549.102344253857, 8550.572471376438, 2239.675247089171, 2256.0862850545473, 2274.6815445837597, 2277.908883644652, 2288.61093614086, 2236.563870045342, 2278.840481166319, 2306.7231932168165, 2318.258157389636, 2341.110378056345, 2252.335561009506, 2262.3552287598036, 2264.852784568998, 2277.3054218463362, 2285.337252196869, 2161.6973623692697, 2211.3255457085584, 2226.666000099982, 2229.3534874886263, 2230.386643672987, 2223.177424353, 2244.6745221942892, 2248.392933907836, 2276.6698828669914, 2284.771522847702, 8419.579021048923, 8493.405461617689, 8560.186782255676, 8564.400491965565, 8565.01502327234, 4993.325901003354, 5181.3782346118705, 5200.713960732158, 5203.349581302337, 5205.557527610158, 3311.6853898879567, 3348.665133486656, 3410.8124053177066, 3488.5464889564446, 3495.7378196635354, 1006.0492834271616, 1029.4080903480453, 1036.9585216591327, 1055.6147006342705, 1092.464692300775, 11151.776964460747, 11157.218994670377, 11244.662660120128, 11248.887511124947, 11271.211015229019, 4081.673466122703, 4291.763952982616, 4352.630026447724, 4357.368181613649, 4367.606915377632, 9387.953060234655, 9388.061193880558, 9390.295727820441, 9392.483413412328, 9403.90596094044, 4868.780904859219, 4873.853784386474, 4876.561109500162, 4876.707397556087, 4879.121758083508, 4026.1545075534464, 4139.648129908992, 4462.843800466968, 4554.27131658933, 4567.177907976529, 3567.4470457079196, 3602.351576716164, 3687.9631203688155, 3717.3494638438706, 3729.198222382201, 1084.5228099636136, 1089.2429761315968, 1090.4765712458066, 1095.479647167605, 1097.9341239525654, 854.448880472092, 864.8659457784054, 876.4346996187423, 882.5807741322949, 916.876221710074, 5469.753861076261, 5544.91682624761, 5583.330000399978, 5736.799212027559, 5855.707214639251, 909.8043920556979, 985.9063388978036, 1000.0749306891242, 1000.429755039635, 1054.167207905746, 3696.5194524711615, 3726.832292546842, 3796.3735983562956, 3847.615238476186, 3882.107115363482, 10152.137068349126, 10411.271211015157, 10505.31715438494, 10508.527116279633, 10532.262741608014, 10458.111060559786, 10465.372077675363, 10473.0, 10473.633422830164, 10478.895211047944, 7444.218357072537, 7719.266669666485, 7896.565688887052, 8021.598920053974, 8044.597770111471, 5438.293021907285, 5650.0, 5660.462256085665, 5791.362950075404, 5817.185594016756, 9391.953040234755, 9437.622495100119, 9536.189423899046, 9596.32825702222, 9650.324477286804, 9677.70966870995, 9790.0, 9865.950670246602, 9908.058734420218, 9918.30571859963, 6759.797206083826, 6969.0940177776565, 7399.8150046249275, 7474.7757567273065, 7556.622168891424, 8306.87539686893, 8312.41813073079, 8361.790955225924, 8365.665373384996, 8371.581420929051, 7288.635568221462, 7299.233580474186, 7417.480776345604, 7509.6245187739305, 7747.0, 6808.114945057111, 7051.964740176266, 7087.61018144007, 7151.070360853056, 7224.313690199423, 6367.490600751836, 6456.709448074754, 6469.514786391133, 6471.255805582418, 6471.838204044937, 4573.153966516205, 4614.561616646413, 4844.685095468783, 4848.10310092634, 4938.555530002317, 4779.0, 4801.255805350176, 4897.7795999180835, 4920.089783390084, 4953.578945789648], "value": 4403.723010007406, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.7973317343725, 320.0717918037692, 327.33387556322884, 329.2624521072798, 333.8130646837771, 5200.193969934657, 5319.090468505655, 5357.30355053843, 5378.865528361793, 5439.5104440600335, 5173.249878767577, 5271.942273481382, 5275.314209152814, 5291.841244762663, 5296.484170019239, 4151.086760912594, 4155.231282212801, 4159.750414975111, 4161.895952601179, 4176.770277634729, 3968.9007774805573, 4105.835766569334, 4182.811773470201, 4188.47120800907, 4189.706720529564, 4041.373587094005, 4054.1891621675636, 4056.574059723731, 4066.369712694537, 4067.9186416271655, 4045.1707399982934, 4057.3711074783455, 4059.1881623675235, 4061.4110953911813, 4070.4504891839665, 3569.1790888095884, 3569.839357228931, 3573.1781690211396, 3573.4282514797505, 3582.7133829293853, 5133.484592549661, 5141.228815677641, 5159.226116082617, 5173.793048278102, 5201.061400308851, 4614.123316569841, 4633.467151277612, 4645.999999999966, 4654.301854721785, 4656.557627025427, 5483.7806487740445, 5507.862303442406, 5515.448455154493, 5529.695866727328, 5532.446755324476, 3787.5644300905196, 3859.6333348332146, 3881.4371916072296, 3884.961150388488, 3896.59085795993, 5719.0, 5730.627509211888, 5737.713114344266, 5784.68184249866, 5814.895169917702, 4033.556308806029, 4039.2123535910805, 4048.858289959896, 4059.837606495707, 4067.51189857219, 3993.7803420812133, 4039.818208180639, 4059.4722686050623, 4079.469668943078, 4115.218108559364, 4645.581897629162, 4646.907061858811, 4655.0, 4660.720356778605, 4667.159911215946, 5557.749901254453, 5557.861053473695, 5557.888842223133, 5624.606277560613, 5647.971760141255, 1311.6196303072193, 1318.261773406876, 1398.7622104242303, 1405.9437622494986, 1412.8516505766952, 862.8533149364498, 877.7147427086222, 897.9910200898038, 904.3850181876255, 906.3836591117971, 4723.48041715411, 4725.125851717443, 4730.455997560256, 4758.455674830529, 4758.666893317434, 4996.4503904570465, 5040.227874668991, 5043.84868453947, 5058.317127187856, 5062.7468626568525, 4414.0, 4775.689580177347, 4791.280588620206, 4799.616030717534, 4806.375171227718, 2667.5065112953775, 2685.8657067146564, 2691.4078902641386, 2694.0, 2703.635009273723, 5134.2298655201275, 5173.430922598511, 5176.896462070813, 5188.848920863295, 5198.506141916512, 4841.491643377465, 5055.949440505621, 5070.783012077075, 5095.719735414587, 5102.443754654866, 5049.0, 5082.237664350377, 5101.923471147936, 5137.563307118937, 5164.922526162186, 4943.813484763703, 4978.4274808397495, 4995.550400463976, 5038.924416133687, 5128.692278463304, 4729.834146730564, 4734.952650473451, 4867.053178728537, 4894.657373983787, 4951.9257211142585, 5069.264956581349, 5141.562967147835, 5193.480651934777, 5212.270282160424, 5242.554382877345, 3704.24063067076, 3704.8888533344043, 3709.1839795245005, 3745.194783121642, 3754.6808521274907, 4811.941372897957, 5006.0, 5092.185250359925, 5094.643374963865, 5168.250603662373, 4921.0, 4931.767058235441, 4936.629752768628, 4939.703617782944, 4940.505949405031, 4938.851834444972, 4963.280324352876, 4967.0, 5017.8243761468175, 5052.494750524918, 4886.633502487399, 4886.975565122151, 4958.752062396938, 5246.31797866275, 5604.691741954069, 5599.580031497572, 5616.213730077874, 5621.494065534122, 5671.6597004179885, 5679.432056794288, 5441.455854414685, 5499.835004949858, 5502.5597952164535, 5535.308086489189, 5552.50027497511], "value": 4011.548799019253, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.6276010954083, 699.3391245273216, 704.3132945378254, 709.6700034483964, 748.4723270094584, 13496.730065398686, 14191.077579957295, 14222.715545689105, 14280.4287828487, 14336.211508367036, 13374.331283435813, 13524.72950540991, 13528.729425411486, 13532.0, 13535.458581656721, 645.9838504037414, 660.224236522087, 769.4383100336729, 787.7203592724586, 805.9959700201491, 787.9054513458365, 801.6753214947926, 802.2378740196837, 802.2619190344867, 802.6107337941094, 853.2875049333813, 854.2738672128672, 854.7563944275882, 854.7692123126752, 854.8418542569614, 686.3411125319699, 705.5378726933867, 818.7298191596818, 848.5417874347845, 853.906070332266, 614.2843587220882, 617.7683368736724, 618.2642655240295, 618.5391883047114, 618.7184830901929, 13856.445742170403, 13919.095258808245, 14079.859201407957, 14081.85918140826, 14091.295435228198, 13498.59504214875, 13566.389512471962, 13631.795523067161, 13700.725985480334, 13744.381502832297, 12160.391980400944, 12199.20705154171, 12217.694557636041, 12566.74866502674, 12600.0, 4322.527845422975, 4457.130859482402, 4475.843345482925, 4595.2188128018315, 4621.1219868224925, 66282.0, 67743.66128169328, 68000.31999680039, 68243.0, 68370.0, 10202.591896324064, 10273.845892311621, 10277.537510812032, 10449.477526123663, 10585.947070264754, 19769.901150494155, 19774.110165042606, 19785.10967006488, 19789.901050494656, 19810.306639267557, 7032.472564557678, 7939.404544659058, 7957.045154581488, 7961.880571791427, 7965.6017199139815, 3843.865464708778, 3957.1294315250598, 3995.141044675409, 4078.1232035112594, 4108.630223279919, 3222.9838850806063, 3308.9172770680925, 3318.900432987014, 3320.6015278166774, 3320.634730179678, 578.8842231553706, 593.3295376224838, 594.5451729426992, 599.3706608061605, 599.8260504453747, 556.3268445181376, 566.9206311116448, 587.759018802289, 590.5334785519477, 631.2425089892148, 8023.237792409712, 8211.58942052907, 8374.748757537283, 8464.957675211585, 8688.571271562849, 564.5032371513042, 618.730852079347, 624.5940138909655, 640.2796853539768, 656.6454114778062, 4187.14163596462, 4202.327627579572, 4246.72396294246, 4299.591538803808, 4304.956950430518, 82857.58571207106, 86213.0, 87900.0, 88203.0, 91023.0, 46873.25013998872, 47964.7601761989, 58475.415245847, 59768.10347844786, 75866.0, 70955.0, 71214.0, 71234.64382678054, 71371.64314178396, 73892.63053684698, 8103.240997091949, 8342.916570834213, 8422.157784221528, 8479.279261262614, 8796.340274479568, 30699.846500767355, 39103.2179356417, 44030.55969440265, 48144.14846812317, 49740.751296244736, 39800.60199398085, 40634.39048414217, 51008.0, 58709.70645146747, 60564.39435605588, 11855.525778968744, 11878.406079696153, 11892.227005244631, 12123.333216672814, 12565.623031309075, 13358.465661373824, 13934.372953217333, 13945.0, 13956.0, 14313.57059288223, 12890.48438062467, 13131.868681313446, 13780.862191378359, 14085.507007254697, 14218.075825071337, 12584.30786306762, 12707.36463176819, 12725.93637031809, 12734.808977865525, 13412.865871341162, 12548.30984295836, 13029.283389413673, 13273.867261327263, 13282.468701252228, 13425.664358390728, 10419.791604167722, 10767.892321077003, 10924.453777310944, 11125.221234513507, 11276.94361528187, 9850.408975461496, 10209.74475638115, 10990.285631433931, 10994.725131871768, 11027.779444411228], "value": 6831.055641722005, "unit": "score"}], "name": "dromaeo_css", "value": 6907.990302878964, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 109.0, 111.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 123.0, 128.0, 157.0, 126.0, 126.0, 124.0, 124.0, 152.0, 128.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 161.0, 162.0, 161.0, 161.0, 162.0, 160.0, 161.0, 163.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 113.0, 77.0, 85.0, 75.0, 76.0, 107.0, 77.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 116.0, 82.0, 83.0, 82.0, 112.0, 81.0, 81.0, 117.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 116.0, 116.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 147.0, 146.0, 146.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 86.0, 85.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 54.0, 53.0, 54.0, 54.0, 55.0, 54.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 79.0, 79.0, 80.0, 80.0, 81.0, 87.0, 80.0, 79.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 154.0, 140.0, 137.0, 139.0, 130.0, 127.0, 134.0, 170.0, 131.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 175.0, 170.0, 170.0, 166.0, 166.0, 169.0, 166.0, 166.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 69.0, 66.0, 65.0, 65.0, 67.0, 66.0, 69.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1501.8, "alertThreshold": 2.0}]} 22:07:06 INFO - Return code: 0 22:07:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:07:06 INFO - # TBPL SUCCESS # 22:07:06 INFO - Running post-action listener: _resource_record_post_action 22:07:06 INFO - [mozharness: 2016-10-26 05:07:06.203654Z] Finished run-tests step (success) 22:07:06 INFO - Running post-run listener: _resource_record_post_run 22:07:06 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391979008; Read time: 144; Write time: 287180 22:07:06 INFO - TinderboxPrint: CPU usage
13.2% 22:07:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 144 22:07:06 INFO - TinderboxPrint: I/O write bytes / time
391,979,008 / 287,180 22:07:06 INFO - TinderboxPrint: CPU idle
8,292.2 (86.8%) 22:07:06 INFO - TinderboxPrint: CPU user
1,206.6 (12.6%) 22:07:06 INFO - TinderboxPrint: Swap in / out
0 / 0 22:07:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 102903808; Read time: 0; Write time: 84464 22:07:06 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288620544; Read time: 144; Write time: 202676 22:07:06 INFO - Running post-run listener: _upload_blobber_files 22:07:06 INFO - Blob upload gear active. 22:07:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:07:06 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 22:07:06 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'] 22:07:06 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 22:07:07 INFO - (blobuploader) - INFO - Open directory for files ... 22:07:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:07:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:07:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:07:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:07:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:07:10 INFO - (blobuploader) - INFO - Done attempting. 22:07:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:07:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:07:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:07:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:07:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:07:11 INFO - (blobuploader) - INFO - Done attempting. 22:07:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:07:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:07:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:07:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:07:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:07:11 INFO - (blobuploader) - INFO - Done attempting. 22:07:11 INFO - (blobuploader) - INFO - Iteration through files over. 22:07:11 INFO - Return code: 0 22:07:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:07:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:07:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1577569269cb9107109133c07085d2d5366f804f9eed19e97e6b61efa0bd2d913b9fbc3eed19147dd54bc31e55bd00909b5ddab10609b9346b71fccddda9eabf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a311bdaa62a8bdb095f6fcea3a8be60a4328d6edd46d3ee6863bb52bc807b3671929f9075ea2fa9576f6a9d2c567719815a71a50e6f20a4909da14d7760f50fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fe934abef4f9213bb403a02ff067852b9d36986ea169b69eaa6fc03c8ea5bf666fbde8ab0c36004c7dfc8d70038c2e6c319c3bc96a87bac15f92623aff8ef18b"} 22:07:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:07:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:07:11 INFO - Contents: 22:07:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1577569269cb9107109133c07085d2d5366f804f9eed19e97e6b61efa0bd2d913b9fbc3eed19147dd54bc31e55bd00909b5ddab10609b9346b71fccddda9eabf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a311bdaa62a8bdb095f6fcea3a8be60a4328d6edd46d3ee6863bb52bc807b3671929f9075ea2fa9576f6a9d2c567719815a71a50e6f20a4909da14d7760f50fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fe934abef4f9213bb403a02ff067852b9d36986ea169b69eaa6fc03c8ea5bf666fbde8ab0c36004c7dfc8d70038c2e6c319c3bc96a87bac15f92623aff8ef18b"} 22:07:11 INFO - Running post-run listener: copy_logs_to_upload_dir 22:07:11 INFO - Copying logs to upload dir... 22:07:11 INFO - mkdir: /builds/slave/test/build/upload/logs 22:07:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.175540 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-25 22:07:11.709387) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 22:07:11.712702) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627 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/1577569269cb9107109133c07085d2d5366f804f9eed19e97e6b61efa0bd2d913b9fbc3eed19147dd54bc31e55bd00909b5ddab10609b9346b71fccddda9eabf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a311bdaa62a8bdb095f6fcea3a8be60a4328d6edd46d3ee6863bb52bc807b3671929f9075ea2fa9576f6a9d2c567719815a71a50e6f20a4909da14d7760f50fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fe934abef4f9213bb403a02ff067852b9d36986ea169b69eaa6fc03c8ea5bf666fbde8ab0c36004c7dfc8d70038c2e6c319c3bc96a87bac15f92623aff8ef18b"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011527 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477445407/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/1577569269cb9107109133c07085d2d5366f804f9eed19e97e6b61efa0bd2d913b9fbc3eed19147dd54bc31e55bd00909b5ddab10609b9346b71fccddda9eabf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a311bdaa62a8bdb095f6fcea3a8be60a4328d6edd46d3ee6863bb52bc807b3671929f9075ea2fa9576f6a9d2c567719815a71a50e6f20a4909da14d7760f50fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fe934abef4f9213bb403a02ff067852b9d36986ea169b69eaa6fc03c8ea5bf666fbde8ab0c36004c7dfc8d70038c2e6c319c3bc96a87bac15f92623aff8ef18b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 22:07:11.738559) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 22:07:11.738869) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1477457192.560932-460426627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 22:07:11.822188) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 22:07:11.822510) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 22:07:11.822798) ========= ========= Total master_lag: 0.17 =========