builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1477842473.98 results: success (0) buildid: 20161030063205 builduid: 63d142cd8a99487c8176b571034eeb49 revision: 9c1b8232382aea0f3443c87966f209c5a86e80ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 08:47:53.984925) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 08:47:53.985377) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 08:47:53.985670) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 08:47:54.000482) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 08:47:54.000842) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-30 08:47:54-- 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% 219M=0s 2016-10-30 08:47:54 (219 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120951 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 08:47:54.136048) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 08:47:54.136432) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014980 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 08:47:54.186387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 08:47:54.186760) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9c1b8232382aea0f3443c87966f209c5a86e80ae --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 9c1b8232382aea0f3443c87966f209c5a86e80ae --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-30 08:47:54,238 truncating revision to first 12 chars 2016-10-30 08:47:54,238 Setting DEBUG logging. 2016-10-30 08:47:54,239 attempt 1/10 2016-10-30 08:47:54,239 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/9c1b8232382a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-30 08:47:54,741 unpacking tar archive at: mozilla-inbound-9c1b8232382a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.828478 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 08:47:55.029187) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 08:47:55.029580) ========= script_repo_revision: 9c1b8232382aea0f3443c87966f209c5a86e80ae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 08:47:55.029975) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 08:47:55.030240) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 08:47:55.040726) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-30 08:47:55.041115) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:47:55 INFO - MultiFileLogger online at 20161030 08:47:55 in /builds/slave/test 08:47:55 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 08:47:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:47:55 INFO - {'append_to_log': False, 08:47:55 INFO - 'base_work_dir': '/builds/slave/test', 08:47:55 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 08:47:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:47:55 INFO - 'branch': 'Mozilla-Inbound', 08:47:55 INFO - 'buildbot_json_path': 'buildprops.json', 08:47:55 INFO - 'config_files': ('talos/linux_config.py',), 08:47:55 INFO - 'default_actions': ('clobber', 08:47:55 INFO - 'read-buildbot-config', 08:47:55 INFO - 'download-and-extract', 08:47:55 INFO - 'populate-webroot', 08:47:55 INFO - 'create-virtualenv', 08:47:55 INFO - 'install', 08:47:55 INFO - 'run-tests'), 08:47:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:47:55 INFO - 'download_minidump_stackwalk': True, 08:47:55 INFO - 'download_symbols': 'ondemand', 08:47:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:47:55 INFO - 'tooltool.py': '/tools/tooltool.py', 08:47:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:47:55 INFO - '/tools/misc-python/virtualenv.py')}, 08:47:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:47:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:47:55 INFO - 'installer_path': 'installer.exe', 08:47:55 INFO - 'log_level': 'info', 08:47:55 INFO - 'log_name': 'talos', 08:47:55 INFO - 'log_to_console': True, 08:47:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:47:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:47:55 INFO - 'opt_config_files': (), 08:47:55 INFO - 'pip_index': False, 08:47:55 INFO - 'sps_profile': False, 08:47:55 INFO - 'sps_profile_interval': 0, 08:47:55 INFO - 'suite': 'dromaeojs', 08:47:55 INFO - 'system_bits': '32', 08:47:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:47:55 INFO - 'title': 'talos-linux64-ix-026', 08:47:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:47:55 INFO - 'use_talos_json': True, 08:47:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:47:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:47:55 INFO - 'work_dir': 'build'} 08:47:55 INFO - [mozharness: 2016-10-30 15:47:55.194478Z] Running clobber step. 08:47:55 INFO - Running pre-action listener: _resource_record_pre_action 08:47:55 INFO - Running main action method: clobber 08:47:55 INFO - rmtree: /builds/slave/test/build 08:47:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:47:56 INFO - Running post-action listener: _resource_record_post_action 08:47:56 INFO - [mozharness: 2016-10-30 15:47:56.170299Z] Finished clobber step (success) 08:47:56 INFO - [mozharness: 2016-10-30 15:47:56.170397Z] Running read-buildbot-config step. 08:47:56 INFO - Running pre-action listener: _resource_record_pre_action 08:47:56 INFO - Running main action method: read_buildbot_config 08:47:56 INFO - Using buildbot properties: 08:47:56 INFO - { 08:47:56 INFO - "project": "", 08:47:56 INFO - "product": "firefox", 08:47:56 INFO - "script_repo_revision": "production", 08:47:56 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 08:47:56 INFO - "repository": "", 08:47:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 08:47:56 INFO - "buildid": "20161030063205", 08:47:56 INFO - "stage_platform": "linux64-pgo", 08:47:56 INFO - "basedir": "/builds/slave/test", 08:47:56 INFO - "buildnumber": 1875, 08:47:56 INFO - "platform": "ubuntu64_hw", 08:47:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:47:56 INFO - "slavebuilddir": "test", 08:47:56 INFO - "branch": "mozilla-inbound", 08:47:56 INFO - "revision": "9c1b8232382aea0f3443c87966f209c5a86e80ae", 08:47:56 INFO - "slavename": "talos-linux64-ix-026", 08:47:56 INFO - "builduid": "63d142cd8a99487c8176b571034eeb49", 08:47:56 INFO - "repo_path": "integration/mozilla-inbound" 08:47:56 INFO - } 08:47:56 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698454/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 08:47:56 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698454/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 08:47:56 INFO - Running post-action listener: _resource_record_post_action 08:47:56 INFO - [mozharness: 2016-10-30 15:47:56.172760Z] Finished read-buildbot-config step (success) 08:47:56 INFO - [mozharness: 2016-10-30 15:47:56.172846Z] Running download-and-extract step. 08:47:56 INFO - Running pre-action listener: _resource_record_pre_action 08:47:56 INFO - Running main action method: download_and_extract 08:47:56 INFO - mkdir: /builds/slave/test/build/tests 08:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:56 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698454/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:47:56 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698454/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 08:47:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698454/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 08:47:56 INFO - Downloaded 1361 bytes. 08:47:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:47:56 INFO - Using the following test package requirements: 08:47:56 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:47:56 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:47:56 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:47:56 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:56 INFO - u'jsshell-linux-x86_64.zip'], 08:47:56 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:47:56 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:47:56 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:47:56 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:47:56 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:47:56 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:47:56 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:47:56 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/1477698454/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:47:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698454/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:47:56 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698454/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:47:56 INFO - Http code: 200 08:47:56 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 08:47:56 INFO - x-amz-cf-id: 2Hjt49v8FFYK6FAhCp7oqVSmluClzBJ9t45faW1rSstqh7oa_P7tDQ== 08:47:56 INFO - x-amz-replication-status: PENDING 08:47:56 INFO - x-amz-version-id: fNRxKA6_Vx3CiT7bnKUsViSo74JomuZC 08:47:56 INFO - Expected file size: 22005783 08:47:56 INFO - Obtained file size: 22005783 08:48:00 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 08:48:00 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/1477698454/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:48:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698454/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:48:00 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698454/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:48:00 INFO - Http code: 200 08:48:00 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 08:48:00 INFO - x-amz-cf-id: wVoUTKB3s7ps5kIcHUliLFNtPz5gPPWLrSz1abIvJEcuDcCDe8OADQ== 08:48:00 INFO - x-amz-replication-status: PENDING 08:48:00 INFO - x-amz-version-id: fNRxKA6_Vx3CiT7bnKUsViSo74JomuZC 08:48:01 INFO - Expected file size: 22005783 08:48:01 INFO - Obtained file size: 22005783 08:48:05 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/1477698454/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 08:48:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698454/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:48:05 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698454/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:48:05 INFO - Http code: 200 08:48:05 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 08:48:05 INFO - x-amz-cf-id: bzjxTiq1-A3zQi98rGOI5ZJlZswhEZMolDToPpXxGH0NuGA89Elg4A== 08:48:05 INFO - x-amz-replication-status: PENDING 08:48:05 INFO - x-amz-version-id: AwSG8PVtBIm6txn801hwf9eknTdzjrNl 08:48:05 INFO - Expected file size: 14409030 08:48:05 INFO - Obtained file size: 14409030 08:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:06 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698454/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:48:06 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698454/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 08:48:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698454/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 08:48:06 INFO - Downloaded 59404109 bytes. 08:48:06 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698454/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:48:06 INFO - mkdir: /builds/slave/test/properties 08:48:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:48:06 INFO - Writing to file /builds/slave/test/properties/build_url 08:48:06 INFO - Contents: 08:48:06 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698454/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:48:06 INFO - Running post-action listener: _resource_record_post_action 08:48:06 INFO - Running post-action listener: set_extra_try_arguments 08:48:06 INFO - [mozharness: 2016-10-30 15:48:06.980488Z] Finished download-and-extract step (success) 08:48:06 INFO - [mozharness: 2016-10-30 15:48:06.980715Z] Running populate-webroot step. 08:48:06 INFO - Running pre-action listener: _resource_record_pre_action 08:48:06 INFO - Running main action method: populate_webroot 08:48:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:48:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:48:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:48:06 INFO - '--tppagecycles', 08:48:06 INFO - '7'], 08:48:06 INFO - 'tests': ['tsvgm']}}, 08:48:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:48:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:48:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:48:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:48:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:48:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:48:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:06 INFO - 'talos_options': ['--disable-e10s'], 08:48:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:06 INFO - 'talos_options': ['--disable-e10s'], 08:48:06 INFO - 'tests': ['damp', 'tps']}, 08:48:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:06 INFO - 'tests': ['damp', 'tps']}, 08:48:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:48:06 INFO - 'tests': ['dromaeo_dom']}, 08:48:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:48:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:48:06 INFO - 'tests': ['basic_compositor_video']}, 08:48:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:48:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:48:06 INFO - 'tests': ['a11yr', 08:48:06 INFO - 'ts_paint', 08:48:06 INFO - 'tpaint', 08:48:06 INFO - 'sessionrestore', 08:48:06 INFO - 'sessionrestore_no_auto_restore', 08:48:06 INFO - 'tabpaint']}, 08:48:06 INFO - 'other-e10s': {'tests': ['a11yr', 08:48:06 INFO - 'ts_paint', 08:48:06 INFO - 'tpaint', 08:48:06 INFO - 'sessionrestore', 08:48:06 INFO - 'sessionrestore_no_auto_restore', 08:48:06 INFO - 'tabpaint']}, 08:48:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:48:06 INFO - 'ts_paint', 08:48:06 INFO - 'tpaint', 08:48:06 INFO - 'sessionrestore', 08:48:06 INFO - 'sessionrestore_no_auto_restore', 08:48:06 INFO - 'tabpaint']}, 08:48:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:48:06 INFO - 'ts_paint', 08:48:06 INFO - 'tpaint', 08:48:06 INFO - 'sessionrestore', 08:48:06 INFO - 'sessionrestore_no_auto_restore', 08:48:06 INFO - 'tabpaint']}, 08:48:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:48:06 INFO - 'tests': ['a11yr', 08:48:06 INFO - 'ts_paint', 08:48:06 INFO - 'tpaint', 08:48:06 INFO - 'sessionrestore', 08:48:06 INFO - 'sessionrestore_no_auto_restore', 08:48:06 INFO - 'tabpaint']}, 08:48:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:48:06 INFO - 'tests': ['a11yr', 08:48:06 INFO - 'ts_paint', 08:48:06 INFO - 'tpaint', 08:48:06 INFO - 'sessionrestore', 08:48:06 INFO - 'sessionrestore_no_auto_restore', 08:48:06 INFO - 'tabpaint']}, 08:48:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:48:06 INFO - 'tests': ['tsvgx', 08:48:06 INFO - 'tsvgr_opacity', 08:48:06 INFO - 'tart', 08:48:06 INFO - 'tscrollx', 08:48:06 INFO - 'cart']}, 08:48:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:48:06 INFO - 'tsvgr_opacity', 08:48:06 INFO - 'tart', 08:48:06 INFO - 'tscrollx', 08:48:06 INFO - 'cart']}, 08:48:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:06 INFO - 'talos_options': ['--disable-e10s'], 08:48:06 INFO - 'tests': ['tp5o']}, 08:48:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:06 INFO - 'tests': ['tp5o']}, 08:48:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:06 INFO - 'talos_options': ['--disable-e10s', 08:48:06 INFO - '--xperf_path', 08:48:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:06 INFO - 'tests': ['tp5n']}, 08:48:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:06 INFO - 'talos_options': ['--xperf_path', 08:48:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:06 INFO - 'tests': ['tp5n']}}, 08:48:06 INFO - 'talos.zip': {'path': '', 08:48:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:48:06 INFO - Running post-action listener: _resource_record_post_action 08:48:06 INFO - [mozharness: 2016-10-30 15:48:06.997039Z] Finished populate-webroot step (success) 08:48:06 INFO - [mozharness: 2016-10-30 15:48:06.997127Z] Running create-virtualenv step. 08:48:06 INFO - Running pre-action listener: _resource_record_pre_action 08:48:06 INFO - Running main action method: create_virtualenv 08:48:06 INFO - Creating virtualenv /builds/slave/test/build/venv 08:48:06 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 08:48:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:48:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:48:07 INFO - Using real prefix '/usr' 08:48:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:48:07 INFO - Installing distribute.............................................................................................................................................................................................done. 08:48:09 INFO - Installing pip.................done. 08:48:09 INFO - Return code: 0 08:48:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:48:09 INFO - Reading from file tmpfile_stdout 08:48:09 INFO - Output received: 08:48:09 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) 08:48:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:48:09 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')]} 08:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:09 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')]} 08:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:09 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 0x7fbe55e54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b50ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4df60>, '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 0x1b4ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', '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 08:48:09 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 08:48:09 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 08:48:09 INFO - Using env: {'DISPLAY': ':0', 08:48:09 INFO - 'HOME': '/home/cltbld', 08:48:09 INFO - 'LANG': 'en_US.UTF-8', 08:48:09 INFO - 'LANGUAGE': 'en_US:en', 08:48:09 INFO - 'LOGNAME': 'cltbld', 08:48:09 INFO - 'MAIL': '/var/mail/cltbld', 08:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:09 INFO - 'MOZ_NO_REMOTE': '1', 08:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:09 INFO - 'NO_EM_RESTART': '1', 08:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:09 INFO - 'PWD': '/builds/slave/test', 08:48:09 INFO - 'SHELL': '/bin/bash', 08:48:09 INFO - 'SHLVL': '1', 08:48:09 INFO - 'TERM': 'linux', 08:48:09 INFO - 'TMOUT': '86400', 08:48:09 INFO - 'USER': 'cltbld', 08:48:09 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', 08:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:09 INFO - '_': '/tools/buildbot/bin/python'} 08:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:09 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 08:48:09 INFO - Cleaning up... 08:48:10 INFO - Return code: 0 08:48:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbe55e54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b50ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4df60>, '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 0x1b4ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', '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 08:48:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:48:10 INFO - Using env: {'DISPLAY': ':0', 08:48:10 INFO - 'HOME': '/home/cltbld', 08:48:10 INFO - 'LANG': 'en_US.UTF-8', 08:48:10 INFO - 'LANGUAGE': 'en_US:en', 08:48:10 INFO - 'LOGNAME': 'cltbld', 08:48:10 INFO - 'MAIL': '/var/mail/cltbld', 08:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:10 INFO - 'MOZ_NO_REMOTE': '1', 08:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:10 INFO - 'NO_EM_RESTART': '1', 08:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:10 INFO - 'PWD': '/builds/slave/test', 08:48:10 INFO - 'SHELL': '/bin/bash', 08:48:10 INFO - 'SHLVL': '1', 08:48:10 INFO - 'TERM': 'linux', 08:48:10 INFO - 'TMOUT': '86400', 08:48:10 INFO - 'USER': 'cltbld', 08:48:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', 08:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:10 INFO - '_': '/tools/buildbot/bin/python'} 08:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:10 INFO - Downloading/unpacking psutil>=3.1.1 08:48:10 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 08:48:10 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 08:48:10 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 08:48:10 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 08:48:10 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 08:48:10 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 08:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:48:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:12 INFO - Installing collected packages: psutil 08:48:12 INFO - Running setup.py install for psutil 08:48:12 INFO - building 'psutil._psutil_linux' extension 08:48:12 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 08:48:12 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 08:48:12 INFO - building 'psutil._psutil_posix' extension 08:48:12 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 08:48:12 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 08:48:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:12 INFO - Successfully installed psutil 08:48:12 INFO - Cleaning up... 08:48:12 INFO - Return code: 0 08:48:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:48:12 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')]} 08:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:12 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')]} 08:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:12 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 0x7fbe55e54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b50ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4df60>, '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 0x1b4ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', '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 08:48:12 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 08:48:12 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 08:48:12 INFO - Using env: {'DISPLAY': ':0', 08:48:12 INFO - 'HOME': '/home/cltbld', 08:48:12 INFO - 'LANG': 'en_US.UTF-8', 08:48:12 INFO - 'LANGUAGE': 'en_US:en', 08:48:12 INFO - 'LOGNAME': 'cltbld', 08:48:12 INFO - 'MAIL': '/var/mail/cltbld', 08:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:12 INFO - 'MOZ_NO_REMOTE': '1', 08:48:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:12 INFO - 'NO_EM_RESTART': '1', 08:48:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:12 INFO - 'PWD': '/builds/slave/test', 08:48:12 INFO - 'SHELL': '/bin/bash', 08:48:12 INFO - 'SHLVL': '1', 08:48:12 INFO - 'TERM': 'linux', 08:48:12 INFO - 'TMOUT': '86400', 08:48:12 INFO - 'USER': 'cltbld', 08:48:12 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', 08:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:12 INFO - '_': '/tools/buildbot/bin/python'} 08:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:48:15 INFO - Installing collected packages: mozsystemmonitor 08:48:15 INFO - Running setup.py install for mozsystemmonitor 08:48:15 INFO - Successfully installed mozsystemmonitor 08:48:15 INFO - Cleaning up... 08:48:15 INFO - Return code: 0 08:48:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe55e54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b50ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4df60>, '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 0x1b4ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', '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 08:48:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:48:15 INFO - Using env: {'DISPLAY': ':0', 08:48:15 INFO - 'HOME': '/home/cltbld', 08:48:15 INFO - 'LANG': 'en_US.UTF-8', 08:48:15 INFO - 'LANGUAGE': 'en_US:en', 08:48:15 INFO - 'LOGNAME': 'cltbld', 08:48:15 INFO - 'MAIL': '/var/mail/cltbld', 08:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:15 INFO - 'MOZ_NO_REMOTE': '1', 08:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:15 INFO - 'NO_EM_RESTART': '1', 08:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:15 INFO - 'PWD': '/builds/slave/test', 08:48:15 INFO - 'SHELL': '/bin/bash', 08:48:15 INFO - 'SHLVL': '1', 08:48:15 INFO - 'TERM': 'linux', 08:48:15 INFO - 'TMOUT': '86400', 08:48:15 INFO - 'USER': 'cltbld', 08:48:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', 08:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:15 INFO - '_': '/tools/buildbot/bin/python'} 08:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:15 INFO - Downloading/unpacking jsonschema==2.5.1 08:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:48:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:48:17 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 08:48:17 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 08:48:17 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 08:48:17 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 08:48:17 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 08:48:17 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 08:48:17 INFO - Downloading functools32-3.2.3-2.tar.gz 08:48:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:48:17 INFO - warning: no files found matching '*.txt' 08:48:17 INFO - no previously-included directories found matching 'build' 08:48:17 INFO - no previously-included directories found matching 'dist' 08:48:17 INFO - no previously-included directories found matching '.git*' 08:48:17 INFO - Installing collected packages: jsonschema, functools32 08:48:17 INFO - Running setup.py install for functools32 08:48:17 INFO - warning: no files found matching '*.txt' 08:48:17 INFO - no previously-included directories found matching 'build' 08:48:17 INFO - no previously-included directories found matching 'dist' 08:48:17 INFO - no previously-included directories found matching '.git*' 08:48:17 INFO - Successfully installed jsonschema functools32 08:48:17 INFO - Cleaning up... 08:48:17 INFO - Return code: 0 08:48:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:48:17 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')]} 08:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:17 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')]} 08:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:17 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 0x7fbe55e54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b50ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4df60>, '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 0x1b4ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', '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 08:48:17 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 08:48:17 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 08:48:17 INFO - Using env: {'DISPLAY': ':0', 08:48:17 INFO - 'HOME': '/home/cltbld', 08:48:17 INFO - 'LANG': 'en_US.UTF-8', 08:48:17 INFO - 'LANGUAGE': 'en_US:en', 08:48:17 INFO - 'LOGNAME': 'cltbld', 08:48:17 INFO - 'MAIL': '/var/mail/cltbld', 08:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:17 INFO - 'MOZ_NO_REMOTE': '1', 08:48:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:17 INFO - 'NO_EM_RESTART': '1', 08:48:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:17 INFO - 'PWD': '/builds/slave/test', 08:48:17 INFO - 'SHELL': '/bin/bash', 08:48:17 INFO - 'SHLVL': '1', 08:48:17 INFO - 'TERM': 'linux', 08:48:17 INFO - 'TMOUT': '86400', 08:48:17 INFO - 'USER': 'cltbld', 08:48:17 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', 08:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:17 INFO - '_': '/tools/buildbot/bin/python'} 08:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:48:18 INFO - Cleaning up... 08:48:18 INFO - Return code: 0 08:48:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:48:18 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')]} 08:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:18 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')]} 08:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:18 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 0x7fbe55e54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b50ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4df60>, '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 0x1b4ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', '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 08:48:18 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 08:48:18 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 08:48:18 INFO - Using env: {'DISPLAY': ':0', 08:48:18 INFO - 'HOME': '/home/cltbld', 08:48:18 INFO - 'LANG': 'en_US.UTF-8', 08:48:18 INFO - 'LANGUAGE': 'en_US:en', 08:48:18 INFO - 'LOGNAME': 'cltbld', 08:48:18 INFO - 'MAIL': '/var/mail/cltbld', 08:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:18 INFO - 'MOZ_NO_REMOTE': '1', 08:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:18 INFO - 'NO_EM_RESTART': '1', 08:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:18 INFO - 'PWD': '/builds/slave/test', 08:48:18 INFO - 'SHELL': '/bin/bash', 08:48:18 INFO - 'SHLVL': '1', 08:48:18 INFO - 'TERM': 'linux', 08:48:18 INFO - 'TMOUT': '86400', 08:48:18 INFO - 'USER': 'cltbld', 08:48:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', 08:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:18 INFO - '_': '/tools/buildbot/bin/python'} 08:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:18 INFO - Downloading/unpacking blobuploader==1.2.4 08:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:20 INFO - Downloading blobuploader-1.2.4.tar.gz 08:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:48:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:48:20 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 08:48:20 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 08:48:20 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 08:48:20 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 08:48:20 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 08:48:20 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 08:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:48:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:48:20 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 08:48:20 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 08:48:20 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 08:48:20 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 08:48:20 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 08:48:20 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 08:48:20 INFO - Downloading docopt-0.6.1.tar.gz 08:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:48:20 INFO - Installing collected packages: blobuploader, requests, docopt 08:48:20 INFO - Running setup.py install for blobuploader 08:48:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:48:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:48:21 INFO - Running setup.py install for requests 08:48:21 INFO - Running setup.py install for docopt 08:48:21 INFO - Successfully installed blobuploader requests docopt 08:48:21 INFO - Cleaning up... 08:48:21 INFO - Return code: 0 08:48:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:21 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 0x7fbe55e54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b50ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4df60>, '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 0x1b4ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', '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 08:48:21 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 08:48:21 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 08:48:21 INFO - Using env: {'DISPLAY': ':0', 08:48:21 INFO - 'HOME': '/home/cltbld', 08:48:21 INFO - 'LANG': 'en_US.UTF-8', 08:48:21 INFO - 'LANGUAGE': 'en_US:en', 08:48:21 INFO - 'LOGNAME': 'cltbld', 08:48:21 INFO - 'MAIL': '/var/mail/cltbld', 08:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:21 INFO - 'MOZ_NO_REMOTE': '1', 08:48:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:21 INFO - 'NO_EM_RESTART': '1', 08:48:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:21 INFO - 'PWD': '/builds/slave/test', 08:48:21 INFO - 'SHELL': '/bin/bash', 08:48:21 INFO - 'SHLVL': '1', 08:48:21 INFO - 'TERM': 'linux', 08:48:21 INFO - 'TMOUT': '86400', 08:48:21 INFO - 'USER': 'cltbld', 08:48:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', 08:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:21 INFO - '_': '/tools/buildbot/bin/python'} 08:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:21 INFO - Running setup.py (path:/tmp/pip-lu3qf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:21 INFO - Running setup.py (path:/tmp/pip-Zp1S6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:21 INFO - Running setup.py (path:/tmp/pip-taPKKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:21 INFO - Running setup.py (path:/tmp/pip-pVsmAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:22 INFO - Running setup.py (path:/tmp/pip-ftkYLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:22 INFO - Running setup.py (path:/tmp/pip-fqr1a2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:22 INFO - Running setup.py (path:/tmp/pip-VmJ6W3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:22 INFO - Running setup.py (path:/tmp/pip-vbPaPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:22 INFO - Running setup.py (path:/tmp/pip-FfVPQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:22 INFO - Running setup.py (path:/tmp/pip-HXYywo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:22 INFO - Running setup.py (path:/tmp/pip-YvmarU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:22 INFO - Running setup.py (path:/tmp/pip-P_t7Gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:22 INFO - Running setup.py (path:/tmp/pip-wqNc2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:22 INFO - Running setup.py (path:/tmp/pip-lFxdit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:22 INFO - Running setup.py (path:/tmp/pip-ovPFBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:22 INFO - Running setup.py (path:/tmp/pip-mKsB8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:22 INFO - Running setup.py (path:/tmp/pip-GDsngR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:48:22 INFO - Running setup.py install for manifestparser 08:48:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:48:23 INFO - Running setup.py install for mozcrash 08:48:23 INFO - Running setup.py install for mozdebug 08:48:23 INFO - Running setup.py install for mozdevice 08:48:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:48:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:48:23 INFO - Running setup.py install for mozfile 08:48:23 INFO - Running setup.py install for mozhttpd 08:48:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:48:23 INFO - Running setup.py install for mozinfo 08:48:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:48:23 INFO - Running setup.py install for mozInstall 08:48:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:48:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:48:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:48:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:48:23 INFO - Running setup.py install for mozleak 08:48:23 INFO - Running setup.py install for mozlog 08:48:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:48:24 INFO - Running setup.py install for moznetwork 08:48:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:48:24 INFO - Running setup.py install for mozprocess 08:48:24 INFO - Running setup.py install for mozprofile 08:48:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:48:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:48:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:48:24 INFO - Running setup.py install for mozrunner 08:48:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:48:24 INFO - Running setup.py install for mozscreenshot 08:48:24 INFO - Running setup.py install for moztest 08:48:24 INFO - Running setup.py install for mozversion 08:48:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:48:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:48:24 INFO - Cleaning up... 08:48:24 INFO - Return code: 0 08:48:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:24 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')]} 08:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:24 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')]} 08:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:24 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 0x7fbe55e54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b50ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4df60>, '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 0x1b4ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', '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 08:48:24 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 08:48:24 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 08:48:24 INFO - Using env: {'DISPLAY': ':0', 08:48:24 INFO - 'HOME': '/home/cltbld', 08:48:24 INFO - 'LANG': 'en_US.UTF-8', 08:48:24 INFO - 'LANGUAGE': 'en_US:en', 08:48:24 INFO - 'LOGNAME': 'cltbld', 08:48:24 INFO - 'MAIL': '/var/mail/cltbld', 08:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:24 INFO - 'MOZ_NO_REMOTE': '1', 08:48:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:24 INFO - 'NO_EM_RESTART': '1', 08:48:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:24 INFO - 'PWD': '/builds/slave/test', 08:48:24 INFO - 'SHELL': '/bin/bash', 08:48:24 INFO - 'SHLVL': '1', 08:48:24 INFO - 'TERM': 'linux', 08:48:24 INFO - 'TMOUT': '86400', 08:48:24 INFO - 'USER': 'cltbld', 08:48:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', 08:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:24 INFO - '_': '/tools/buildbot/bin/python'} 08:48:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:25 INFO - Running setup.py (path:/tmp/pip-edvFpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:25 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)) 08:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:25 INFO - Running setup.py (path:/tmp/pip-psshfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:25 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)) 08:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:25 INFO - Running setup.py (path:/tmp/pip-85LDIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:25 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)) 08:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:25 INFO - Running setup.py (path:/tmp/pip-RN2RkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:25 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)) 08:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:25 INFO - Running setup.py (path:/tmp/pip-V_brqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:25 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)) 08:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:25 INFO - Running setup.py (path:/tmp/pip-Xun0KH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:25 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)) 08:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:25 INFO - Running setup.py (path:/tmp/pip-HuGXbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:25 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)) 08:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:25 INFO - Running setup.py (path:/tmp/pip-25OlyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:25 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)) 08:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:25 INFO - Running setup.py (path:/tmp/pip-CoFWCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:25 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)) 08:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:25 INFO - Running setup.py (path:/tmp/pip-qRYILv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:25 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)) 08:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:25 INFO - Running setup.py (path:/tmp/pip-l0XijM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:25 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)) 08:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:25 INFO - Running setup.py (path:/tmp/pip-IUXnnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:25 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)) 08:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:25 INFO - Running setup.py (path:/tmp/pip-HpM3bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:25 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)) 08:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:25 INFO - Running setup.py (path:/tmp/pip-x9hdOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:26 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)) 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:26 INFO - Running setup.py (path:/tmp/pip-nTo6ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:26 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)) 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:26 INFO - Running setup.py (path:/tmp/pip-lEmZSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:26 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)) 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:26 INFO - Running setup.py (path:/tmp/pip-JWSiQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:26 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)) 08:48:26 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)) 08:48:26 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)) 08:48:26 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)) 08:48:26 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)) 08:48:26 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)) 08:48:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:28 INFO - Downloading blessings-1.6.tar.gz 08:48:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:48:28 INFO - Installing collected packages: blessings 08:48:28 INFO - Running setup.py install for blessings 08:48:28 INFO - Successfully installed blessings 08:48:28 INFO - Cleaning up... 08:48:28 INFO - Return code: 0 08:48:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:48:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:28 INFO - Reading from file tmpfile_stdout 08:48:28 INFO - Current package versions: 08:48:28 INFO - argparse == 1.2.1 08:48:28 INFO - blessings == 1.6 08:48:28 INFO - blobuploader == 1.2.4 08:48:28 INFO - docopt == 0.6.1 08:48:28 INFO - functools32 == 3.2.3-2 08:48:28 INFO - jsonschema == 2.5.1 08:48:28 INFO - manifestparser == 1.1 08:48:28 INFO - mozInstall == 1.12 08:48:28 INFO - mozcrash == 0.17 08:48:28 INFO - mozdebug == 0.1 08:48:28 INFO - mozdevice == 0.48 08:48:28 INFO - mozfile == 1.2 08:48:28 INFO - mozhttpd == 0.7 08:48:28 INFO - mozinfo == 0.9 08:48:28 INFO - mozleak == 0.1 08:48:28 INFO - mozlog == 3.4 08:48:28 INFO - moznetwork == 0.27 08:48:28 INFO - mozprocess == 0.23 08:48:28 INFO - mozprofile == 0.28 08:48:28 INFO - mozrunner == 6.12 08:48:28 INFO - mozscreenshot == 0.1 08:48:28 INFO - mozsystemmonitor == 0.3 08:48:28 INFO - moztest == 0.7 08:48:28 INFO - mozversion == 1.4 08:48:28 INFO - psutil == 3.1.1 08:48:28 INFO - requests == 1.2.3 08:48:28 INFO - wsgiref == 0.1.2 08:48:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:28 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 0x7fbe55e54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b50ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4df60>, '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 0x1b4ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', '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 08:48:28 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 08:48:28 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 08:48:28 INFO - Using env: {'DISPLAY': ':0', 08:48:28 INFO - 'HOME': '/home/cltbld', 08:48:28 INFO - 'LANG': 'en_US.UTF-8', 08:48:28 INFO - 'LANGUAGE': 'en_US:en', 08:48:28 INFO - 'LOGNAME': 'cltbld', 08:48:28 INFO - 'MAIL': '/var/mail/cltbld', 08:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:28 INFO - 'MOZ_NO_REMOTE': '1', 08:48:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:28 INFO - 'NO_EM_RESTART': '1', 08:48:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:28 INFO - 'PWD': '/builds/slave/test', 08:48:28 INFO - 'SHELL': '/bin/bash', 08:48:28 INFO - 'SHLVL': '1', 08:48:28 INFO - 'TERM': 'linux', 08:48:28 INFO - 'TMOUT': '86400', 08:48:28 INFO - 'USER': 'cltbld', 08:48:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', 08:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:28 INFO - '_': '/tools/buildbot/bin/python'} 08:48:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:28 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)) 08:48:28 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)) 08:48:28 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)) 08:48:28 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)) 08:48:28 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)) 08:48:28 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)) 08:48:28 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)) 08:48:28 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)) 08:48:28 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)) 08:48:28 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)) 08:48:28 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)) 08:48:28 INFO - Cleaning up... 08:48:28 INFO - Return code: 0 08:48:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe55e54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b50ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4df60>, '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 0x1b4ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', '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 08:48:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:48:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:48:28 INFO - Using env: {'DISPLAY': ':0', 08:48:28 INFO - 'HOME': '/home/cltbld', 08:48:28 INFO - 'LANG': 'en_US.UTF-8', 08:48:28 INFO - 'LANGUAGE': 'en_US:en', 08:48:28 INFO - 'LOGNAME': 'cltbld', 08:48:28 INFO - 'MAIL': '/var/mail/cltbld', 08:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:28 INFO - 'MOZ_NO_REMOTE': '1', 08:48:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:28 INFO - 'NO_EM_RESTART': '1', 08:48:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:28 INFO - 'PWD': '/builds/slave/test', 08:48:28 INFO - 'SHELL': '/bin/bash', 08:48:28 INFO - 'SHLVL': '1', 08:48:28 INFO - 'TERM': 'linux', 08:48:28 INFO - 'TMOUT': '86400', 08:48:28 INFO - 'USER': 'cltbld', 08:48:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', 08:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:28 INFO - '_': '/tools/buildbot/bin/python'} 08:48:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:48:29 INFO - Cleaning up... 08:48:29 INFO - Return code: 0 08:48:29 INFO - Running post-action listener: _resource_record_post_action 08:48:29 INFO - Running post-action listener: _start_resource_monitoring 08:48:29 INFO - Starting resource monitoring. 08:48:29 INFO - [mozharness: 2016-10-30 15:48:29.151065Z] Finished create-virtualenv step (success) 08:48:29 INFO - [mozharness: 2016-10-30 15:48:29.151578Z] Running install step. 08:48:29 INFO - Running pre-action listener: _resource_record_pre_action 08:48:29 INFO - Running main action method: install 08:48:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:29 INFO - Reading from file tmpfile_stdout 08:48:29 INFO - Detecting whether we're running mozinstall >=1.0... 08:48:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:48:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:48:29 INFO - Reading from file tmpfile_stdout 08:48:29 INFO - Output received: 08:48:29 INFO - Usage: mozinstall [options] installer 08:48:29 INFO - Options: 08:48:29 INFO - -h, --help show this help message and exit 08:48:29 INFO - -d DEST, --destination=DEST 08:48:29 INFO - Directory to install application into. [default: 08:48:29 INFO - "/builds/slave/test"] 08:48:29 INFO - --app=APP Application being installed. [default: firefox] 08:48:29 INFO - mkdir: /builds/slave/test/build/application 08:48:29 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'] 08:48:29 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 08:48:46 INFO - Reading from file tmpfile_stdout 08:48:46 INFO - Output received: 08:48:46 INFO - /builds/slave/test/build/application/firefox/firefox 08:48:46 INFO - Running post-action listener: _resource_record_post_action 08:48:46 INFO - [mozharness: 2016-10-30 15:48:46.359693Z] Finished install step (success) 08:48:46 INFO - [mozharness: 2016-10-30 15:48:46.359939Z] Running run-tests step. 08:48:46 INFO - Running pre-action listener: _resource_record_pre_action 08:48:46 INFO - Running main action method: run_tests 08:48:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:48:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:48:46 INFO - Python 2.7.3 08:48:46 INFO - Return code: 0 08:48:46 INFO - grabbing minidump binary from tooltool 08:48:46 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')]} 08:48:46 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 0x1b4df60>, '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 0x1b4ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:48:46 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 08:48:46 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 08:48:46 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 08:48:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:48:46 INFO - Return code: 0 08:48:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:48:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:48:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:48:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:48:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:48:46 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/1477698454/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:48:46 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/1477698454/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:48:46 INFO - Using env: {'DISPLAY': ':0', 08:48:46 INFO - 'HOME': '/home/cltbld', 08:48:46 INFO - 'LANG': 'en_US.UTF-8', 08:48:46 INFO - 'LANGUAGE': 'en_US:en', 08:48:46 INFO - 'LOGNAME': 'cltbld', 08:48:46 INFO - 'MAIL': '/var/mail/cltbld', 08:48:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:48:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:48:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:46 INFO - 'MOZ_NO_REMOTE': '1', 08:48:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:48:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:46 INFO - 'NO_EM_RESTART': '1', 08:48:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:46 INFO - 'PWD': '/builds/slave/test', 08:48:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:48:46 INFO - 'SHELL': '/bin/bash', 08:48:46 INFO - 'SHLVL': '1', 08:48:46 INFO - 'TERM': 'linux', 08:48:46 INFO - 'TMOUT': '86400', 08:48:46 INFO - 'USER': 'cltbld', 08:48:46 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066', 08:48:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:46 INFO - '_': '/tools/buildbot/bin/python'} 08:48:46 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/1477698454/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:48:46 INFO - mozversion application_buildid: 20161028164734 08:48:46 INFO - mozversion application_changeset: 9c1b8232382aea0f3443c87966f209c5a86e80ae 08:48:46 INFO - mozversion application_display_name: Nightly 08:48:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:48:46 INFO - mozversion application_name: Firefox 08:48:46 INFO - mozversion application_remotingname: firefox 08:48:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:48:46 INFO - mozversion application_vendor: Mozilla 08:48:46 INFO - mozversion application_version: 52.0a1 08:48:46 INFO - mozversion platform_buildid: 20161028164734 08:48:46 INFO - mozversion platform_changeset: 9c1b8232382aea0f3443c87966f209c5a86e80ae 08:48:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:48:46 INFO - mozversion platform_version: 52.0a1 08:48:46 INFO - using testdate: 1477842526 08:48:46 INFO - actual date: 1477842526 08:48:46 INFO - starting webserver on 'localhost:42557' 08:48:46 INFO - SUITE-START | Running 2 tests 08:48:46 INFO - TEST-START | dromaeo_css 08:48:46 INFO - operating with platform_type : linux_ 08:48:46 INFO - Initialising browser for dromaeo_css test... 08:48:46 INFO - TEST-INFO | started process 19194 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS1Yrmi/profile http://localhost:42557/getInfo.html) 08:48:50 INFO - PROCESS | 19194 | __metrics Screen width/height:1600/1200 08:48:50 INFO - PROCESS | 19194 | colorDepth:24 08:48:50 INFO - PROCESS | 19194 | Browser inner width/height: 1024/697 08:48:50 INFO - PROCESS | 19194 | __metrics 08:48:51 INFO - PROCESS | 19194 | 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" 08:48:51 INFO - PROCESS | 19194 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:48:51 INFO - PROCESS | 19194 | console.error: PushService: 08:48:51 INFO - PROCESS | 19194 | stateChangeProcessEnqueue: Error transitioning state 08:48:51 INFO - PROCESS | 19194 | UnknownError 08:48:52 INFO - TEST-INFO | 19194: exit 0 08:48:52 INFO - Browser initialized. 08:48:52 INFO - Running cycle 1/1 for dromaeo_css test... 08:48:52 INFO - TEST-INFO | started process 19277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS1Yrmi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:04 INFO - PROCESS | 19277 | RSS: Main: 172302336 08:49:04 INFO - PROCESS | 19277 | 08:49:55 INFO - PROCESS | 19277 | 1477842595785 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] 08:52:05 INFO - PROCESS | 19277 | Cycle 1(1): loaded http://localhost:42557/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42557/tests/dromaeo/cssquery-ext.html) 08:52:08 INFO - PROCESS | 19277 | RSS: Main: 432115712 08:52:08 INFO - PROCESS | 19277 | 08:55:10 INFO - PROCESS | 19277 | Cycle 1(1): loaded http://localhost:42557/tests/dromaeo/cssquery-ext.html (next: http://localhost:42557/tests/dromaeo/cssquery-jquery.html) 08:55:11 INFO - PROCESS | 19277 | RSS: Main: 279564288 08:55:11 INFO - PROCESS | 19277 | 08:58:13 INFO - PROCESS | 19277 | Cycle 1(1): loaded http://localhost:42557/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42557/tests/dromaeo/cssquery-mootools.html) 08:58:14 INFO - PROCESS | 19277 | RSS: Main: 252010496 08:58:14 INFO - PROCESS | 19277 | 09:01:16 INFO - PROCESS | 19277 | Cycle 1(1): loaded http://localhost:42557/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42557/tests/dromaeo/cssquery-prototype.html) 09:01:16 INFO - PROCESS | 19277 | RSS: Main: 261799936 09:01:16 INFO - PROCESS | 19277 | 09:04:19 INFO - PROCESS | 19277 | Cycle 1(1): loaded http://localhost:42557/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42557/tests/dromaeo/cssquery-yui.html) 09:04:20 INFO - PROCESS | 19277 | RSS: Main: 224313344 09:04:20 INFO - PROCESS | 19277 | 09:07:22 INFO - PROCESS | 19277 | Cycle 1(1): loaded http://localhost:42557/tests/dromaeo/cssquery-yui.html (next: http://localhost:42557/tests/dromaeo/cssquery-dojo.html) 09:07:23 INFO - PROCESS | 19277 | RSS: Main: 310394880 09:07:23 INFO - PROCESS | 19277 | 09:07:23 INFO - PROCESS | 19277 | __start_tp_report 09:07:23 INFO - PROCESS | 19277 | _x_x_mozilla_page_load 09:07:23 INFO - PROCESS | 19277 | _x_x_mozilla_page_load_details 09:07:23 INFO - PROCESS | 19277 | |i|pagename|runs| 09:07:23 INFO - PROCESS | 19277 | |0;dojo.html;2976.7172118648728;3005.053408176423;3033.1658793831693;3045.8781648734052;3048.878044878205;5154.896902061966;5190.636655434121;5254.527092561669;5312.68123912565;5404.594655400846;5278.762455689493;5285.524302812746;5296.046711591912;5299.576033917287;5303.443138470463;4771.069641419916;4792.161371759946;4798.328234047236;4841.661083724141;4883.413990321166;4820.590249828769;4856.3686720726255;4893.41279046515;4894.3147959285725;4928;4893.192623217183;4915.901681966358;4923.630727695419;4947.332110165135;4949.975250123744;496.53717256907095;4895.094407534618;4902.044101400228;4912.89372535316;4957.231629097496;3287.04110398583;4762.404699412574;4802.327674125625;4814.15752243356;4854.2233242681;5266.60500462463;5266.710330931797;5272.077386457393;5273.050850846846;5284.867878303035;5620.437956204388;5688.288963879515;5690.06113991191;5691.573132015074;5698.971505142489;5511.917321240185;5555.8888822223735;5560.833175004756;5617.494425501724;5665.461781130786;5260.763265653055;5278.630495865329;5279.788808447696;5284.894302113975;5303.496167864047;5795.507381872504;5797.159411885337;5802.738876750556;5804.477597016289;5806.622569533051;5422.91865622016;5451.318585176853;5492.725363731797;5495.120780675073;5643.125315576092;5623.212750214973;5638.943610563924;5650.971745141248;5654.264945557051;5695.316562012585;5626.2967129108865;5628.690422026828;5630.014747419185;5631.943680563224;5633.8309850704545;5489.972550137224;5544.500994910397;5579.46995035471;5622.746976386073;5623.971880140655;4376.102898905717;4410.3825464435;4423.181711383404;4424.513303536608;4425.491068527096;3875.748076375027;3890.7665540067687;3895.5909629488497;3932.4297976793778;3937.8424863005157;5253.921191182136;5302.549283310885;5351.57187425005;5352.437994010573;5360.169173777993;5632.690202038845;5634.97182514093;5663.943360566424;5685.232493613392;5769.509591684669;5316.282301889196;5335.653182543122;5355.223492593552;5372.059889519319;5372.382176049804;4906.55840974314;4914.238293064509;4920.163572192736;4921.680090794087;4975.975120124376;5705.600607957486;5748.971255143698;5755.740991655385;5772.884542309214;5824.504917082096;5617.662940223599;5618.185363122406;5625.268715067179;5629;5630.465105814941;5834.124881267844;5846.766129354778;5848.502877255481;5852.94147058524;5852.94147058524;5484.232207491034;5528.55771538284;5529.640573362719;5529.861753456195;5531.585131115102;5606.523445507014;5614.101743720985;5616.073347897551;5617.522510586646;5618.988582055269;5519.613627046068;5529.391766905556;5542.722863856871;5543.085390910616;5546.833594992157;5424.105022671373;5431.565474762088;5452.154915988028;5508.366537848199;5512.503874651301;5486.231927530229;5490.313710786152;5498.175273708815;5500.614956953135;5502.9174562382395;5462.399136094947;5510.035743744908;5556.91664625039;5564.8330550083565;5625.887482250414;5414.404415514212;5462.481064298885;5474.835754927359;5524.088525393265;5532.2254884317035 09:07:23 INFO - PROCESS | 19277 | |1;ext.html;582.7727186397304;590.7784580782206;620.4106099205756;634.9301576826551;638.164005153249;41876.790616046914;43675.344869826935;43760;46150;46217;45364.54635453645;45863.31205031919;45938;45954.77022614882;45961.86343229109;8036.1963803619465;8729.91270087299;8872.556372181398;8876.068012858654;8887.289016878667;8104.5542495162745;8179.304759095484;8183.9590802046205;10359.430231337274;10535.947320263387;10640.148788096934;10704.839427408557;10711.678649640484;10718.142548596132;10718.410487423189;10388.48057597117;10448.686539403754;10448.686539403792;10456.058954694037;10462.163026957825;10468.42423666698;10543.52554135058;10549.314294570828;10552.736181595445;10557;42187;42520.14959700788;42545;42561.57438425607;42568.14863702739;3509.4209455439823;3511.9824400878088;3917.759913934796;3967.3453880109746;4012.578679238667;30987;31706.365872682647;31764.364712705847;31945.840270798497;32204.838975805204;4246.384274280212;4300.075483771005;4365.9739961109435;4508;4551.180787458256;317407.9999999977;317600;318230;318778;318983;57568;58229.70885145632;58276.708616457494;58298;58324.70837645869;62075.37924620696;62432.375676243566;62447;62468.68765656143;62476.68761656163;14581.198034108225;14707.485238016618;14715.411383544753;14719;14727.705445891022;13460.93269533646;13513.256770877499;13524.391402386917;13525.120867143603;13526;15354.539363819104;15650.217489125498;15776.684466310839;16312.776541759415;16323.428679996143;5058.291839142523;5982.670953097534;5996.850078748066;6099.146119543268;6198.574327904607;901.8557030875029;982.6167794560128;1017.414986382818;1035.2028937717914;1096.380544992077;31229.375412491623;31815.68184318127;31973.840130799195;32094.67905320917;32358.514622280683;1102.5589764094427;1112.6105862947904;1121;1130.5816847766214;1199.0407673860877;16393.508194754177;16688.33246670144;16740.41408550695;16804.327826886787;17029.48911532656;473848;478013;478519;479054;480911;50192.49807501951;51427.228591571155;55881.720591396785;58125.70937145372;58540.707296463246;1294.4175121195312;1315.592166428391;1344.2069179184327;1362.6661467940219;1363.0526783885105;30658.540121898637;32833.343333132725;33019.66980330166;33152.1711957203;33818.32363352768;51156.74421627868;51520.42397880166;51578.74210628923;51609;51644;411886;618207;631051;638069;641098;26649;27276.31809204786;27305.863470682518;27653.861730691217;27672.58491122675;47327.52672473231;47414;47926.520734792204;48128;48276.7586162081;39446.3909601821;39665.40501892416;39689.40465893072;41354.793226033675;41361;39064.80467597644;39625.207495850496;39966.20236583411;40262.39606405848;41530.792346039285;39455.80272098621;39595;40632.39051414172;40779.59220407758;40805.59194408137;31051.844740776152;34736;34906.825465872505;35828.8208558966;35864.28271434505;27409.862950685118;27412.314692132855;27510.372616293404;27521.724782752717;27940.720592793812 09:07:23 INFO - PROCESS | 19277 | |2;jquery.html;377.2850448400283;386.2950116038229;396.56576049226095;397.8806358092572;416.81660069569386;12921.30120600784;14858.77711834322;15731.21343932803;18917.432477025675;19007.809921900778;17891.105444727746;18176.1820718068;18464.16911238994;18545.35091271806;18560.814391856078;5178.7669554869935;5370.812021579245;5375.892482150354;5377.784888604451;5378.300820893279;4596.2416201326905;5029.044481548494;5821.126830975345;5862.325832529271;5866.706664666771;5805.216295800076;5808.070708686611;5822.214001109838;5824.271966004249;5832.358440571555;5570.746582019034;5818.679972601505;5848.853778655546;5910.468057874769;5919.2009078774245;5543.556515478752;5646.463585959368;5704.344000439961;5710.14347847822;5723.255976723041;13433.932830335883;13604.727905441836;13622.182669039888;13733.45066197351;18773.34293299728;2362.14962613459;2389.342930694073;2403.591389463778;2423.7939775119135;2451.3381387025584;10127.848082278771;10495.842562361571;12395;13748.793768093487;13797.724045519033;1872.8782629129064;1890.6785846406144;1916.281394477071;1960.558874253296;1968.9507762305914;70147.64926175388;76844.61577692076;77872;79060.60469697672;79619;9819.410835349901;10282.588696452207;10427;10491.94754026225;10785.352878827296;13817.170969741848;13829.446822127002;13834.446622135203;13843.792343114861;13878.93060534711;7774.689012439552;7975.920240797518;7980.68077276914;8245.464044837187;8263.421560490708;7584.924150758422;7678.385729141655;7820.100688420791;7952;7965.4822436541435;4526.185286648435;4551.908961820745;4583.2666773316105;4642.651801114863;4749.002709430989;1576.645254817657;1674.9748753768704;1768.3633891798943;1908.6278175755594;1939.3697048459308;872.7774417523618;951.2247518272586;997.4065431068502;1017.4404077757204;1077.2836064017497;19094.331698390768;19480.805191948184;19607.60784784325;19621.11704973251;19715.704264436044;989.4113002763344;994.3139233928566;998.2662742883974;1010.9696709098739;1095.5836782022939;10408.167346612405;10925.235233533576;10964.506597203144;11008.39453830031;11033.172512061628;407445;415118;420624;420832;424243;69027;85349;86513.56743216244;86876;88384.5580772092;956.6556039825657;979.6718099436769;997.1474389397106;1002.3935519011039;1006.854006169116;16436.096014719304;16642.251098700828;17155.7426638598;17364.82635173632;17758.200880960645;39203;39907;39955.80022099871;40281;40819.38770918379;53620.463795361546;55309.19253478488;55487.72256138694;55986.72006639941;56562;7947.5231486111015;8097.2307630774985;8193.836123277382;8557.914420855712;8744.562771861509;12278.81581776292;12807.80788288195;12840.55058072963;13252.602421927357;13594;10629.20280978945;10643.467826608794;11063.889361106287;11397.145214109141;11787.115966302734;10843.945780271048;11008.229423940247;11054.084104356036;11180.496877640364;11311.604093856675;10804.567817287221;11129.387883666475;11180.10559155282;11202.551897924317;11341.20611557216;8074.232947869943;8201.384896132695;8426.115257898078;8443.66225350979;8478.74563763088;9880.703578892644;11323.71690707706;11629.418529073344;11949.283043017447;12158.088143389457 09:07:23 INFO - PROCESS | 19277 | |3;mootools.html;1451.5282533176717;1487.4793822162244;1587.5237428771366;1705.232645309611;1725.3587848687032;8080.393970452217;8584.442011269262;8584.484930904142;8585.184407481294;8586.270167035795;7502;7699.114601820792;8196.508209507434;8410;8438.535880526568;2303.2053941390236;2330.0330362899376;2342.4495243617735;2347.2840783561005;2348.800351970076;2303.9884800576056;2341.555104530142;2368.6210206366986;2370.893309801063;2375.0737212487143;2244.6745221942892;2270.5118399544094;2276.4764104256033;2280.2019293247395;2293.036924491709;2197.230969160781;2291.20953271122;2298.471351589144;2312.0405031911737;2314.9074037038413;2283.8515496492673;2285.5086156476273;2306.2504685977124;2313.456337760625;2314.166899916029;8297.460665056813;8539.829203415959;8549.529775862326;8565.785855353604;8568.957155214246;5184.948150518484;5262.578993680497;5296.099663057251;5297.231901374279;5343.893122137574;3133.1697100268448;3264.55928449661;3435.587729472479;3442.2599141184514;3459.8443070061658;1081.0864719580734;1092.5192915117402;1101.0971003776906;1111.6498303034518;1175.506287359311;11634.883651163465;11728.824067638992;11741.647750567497;11746.530138794524;11746.941265293619;4344.717593356421;4648.86053418398;4667.883302917454;4700.106979673851;4724.149653062413;9864.753381165528;9924.702258932099;9939.80120397588;9942.30403871722;9949.403035817873;5240.764165612557;5250.527452529214;5261.789528418821;5262.105442074857;5264.0261551613075;4301.569843015736;4374.300111982067;4642.79107440166;4814.662973591815;4828.37231159947;3772.5284339457567;3817.7666065351523;3855.9036024099623;3904.1996390739832;3914.1780226152828;1213.1386715431966;1227.1961864978452;1246.2024304445163;1257.0509265504668;1258.087886282438;859.3383095016802;881.4975463985595;978.2369751593768;987.2250283527396;1031.4224034540682;5842.211301474246;5946.791862284799;5995.5803093783015;6013.368596297413;6187.659678717624;413.52031643293634;424.63693542021747;426.8911427586008;427.05833636830715;428.94852617686075;3886.203328317688;3898.7270891037356;3913.1391093959282;3948.6446219840354;4038.4144299077057;9889.456079915673;10310.896891030994;10474.214433917487;10477.214208934209;10480.580776768997;10305.587776488857;10400.167986561057;10434.530446129942;10437.217208709377;10437.269391142547;7816.53100813953;8018.358531317481;8057.194280572013;8058.0733215679775;8070.1526339734655;5683.772649094155;5736.311642602915;5744.109663002241;5769.53843692512;5909.438603332676;9544.475053872104;9569.521523923915;9569.952150239204;9610.375325603813;9626.807463850824;9657.758556036155;9685.225181985565;9699.5150242489;9826.213902887896;9839.114479696862;6948.305169483214;7143.892841607484;7198.8920166198595;7343.44924130703;7376.852462950818;8190.303824174774;8232.753017409488;8374.413791034569;8382.706605268786;8383.119772424052;7333.963330183528;7374.225706300761;7394.2975417335265;7491.70033198666;7703.922960770321;7238.312360325761;7441.069866266716;7441.92558074434;7456;7505;6569.146011018537;6671.8999215010845;6680.565763225569;6685.264620891795;6687.297833727389;5038.395392552917;5104.132297509506;5116.565091967075;5163.974180129076;5433.402325744244;4969.6769709970185;4999.875003124951;5077.720725360141;5221.530062294411;5408.810691625774 09:07:23 INFO - PROCESS | 19277 | |4;prototype.html;316.24733135138365;320.1563879178365;324.40471734367435;327.1379913926802;329.0605321806243;4997.150484417649;5153.4846515348445;5164.92252616211;5213.635045546808;5255;4964.5780108690715;5025;5041.395032596084;5078.466760990098;5117.872053198672;3994.9600503995025;4009.238244733506;4033.798310084484;4037.9394309085387;4045.1505183911413;3749.2314075614436;3823.6941044716496;4012.899677508071;4021.868409742841;4032.459550483206;3964.2071585682834;3970.8014599270064;3997.160596274786;3999.0602208481127;4003.6797056235578;3948.8420463181437;3950.644442000234;3986.2226865761045;4009.7594144351433;4022.658074063708;3502.7372947029075;3503.8248087595516;3505.8247087645773;3520.1727594015388;3529.7176225901867;4785;4887.120318342697;4957.876053098701;4974.900501989976;4976.601871850244;4579.198640237978;4580.679352445331;4581.725096494188;4587.151376995266;4602.654800889946;5299.920501192485;5332.30680011596;5337.759800808973;5338.252644629755;5341.065313570149;3639.6906262967677;3818.052793075524;3841.1741475582603;3843.4811300474357;3910.5502867170353;5511.641743286674;5521.779128834842;5546.417626149277;5550.611457197998;5553.805616803433;3897.629725176104;3904.355781296111;3910.804459777;3912.315344814703;3919.2749341371937;3896.08442016126;3945.743526670757;3952.980235098806;3984.442178095069;3998.7200895937003;4513.5486451355255;4527.298268768346;4545.681752291798;4546.931796023062;4583.839565615254;5386.165144402624;5387.649802762808;5408.107662235687;5431.533485958769;5441.727913604304;1282.8460584729705;1306.45129045801;1359.2931675528866;1368.1380730139947;1385.7297826923652;851.6891334662928;857.9399442038997;867.2324992381788;874.8626785179368;885.5395194498825;4663.906721865544;4672.766361681903;4693.7653117344;4699.929501057487;4726.858194254178;4698.906468817965;4826.469088400273;4887.535684110004;4893.975530122327;4907.631927605444;4503.977480112579;4542.409486766699;4567.766702990174;4585.747783871919;4591.862244132682;2563.9359016024378;2576.4589436218603;2576.690797104322;2593.597992311195;2645.148396122722;4678.345031695565;4963.607207621209;4978.6017118630425;4994.850154495371;5004.799808007639;4844.77822248201;4851.56335929768;4856.247281671346;4901.970586176872;4904.204603376042;4929.229139708126;4938.654294199371;4944.505549445027;4972.477889821589;4983.6295018870105;4616.192166370939;4785.258284965836;4793.9041219176115;4809.422869255712;4865.36750222483;4825;4831.492693267156;4843.46721860588;4849.80600775965;4854.490278520704;5040.924386134284;5063.443021267732;5079.2127220279435;5087.771050302671;5106.387233532;3573.8927832165077;3576.7496275260482;3599.3521166190335;3600.7839529628304;3614.222942067363;4528.932066018947;4785.306130610972;4809.206480930748;4812.494688057844;4819.445763737075;4681.812727490862;4690.882727931829;4769.833055843029;4791.592714619296;4795.472498025145;4689.413823272091;4704.952950470589;4722.834700785456;4726.834560790356;4746.19314716506;4486.955130448654;4583.358329833759;4698.271767875985;4709.293605959134;4728.503507131702;4744.240921452551;4745.620350372031;4775.761211939459;4876.731779752005;4893.339399181065;4659.157913672725;4665.4168228971375;4678.251479763221;4699.334519075127;4740.2178640523925 09:07:23 INFO - PROCESS | 19277 | |5;yui.html;745.5154149802628;749.9662515186816;756.451572609858;789.8499285135828;821.6836517940591;14636.268186590667;15599.92200039001;15681.451149209779;15701.921490392531;15702.450414235504;13194.208347499156;13317.667058323546;13318.933405332984;13331.53339633113;13340.199588024701;646.4117652935829;663.5421559124189;785.7171418289412;796.5021861336664;797.1351084073787;767.244264399566;793.4049462902823;794.5510786405662;803.3854101612271;808.5108509351845;863.063576020019;864.9264812490945;865.5888452984844;865.7489328094845;865.7748985263845;680.7787469072571;856.3662889461816;860.6858496648741;862.348926560446;863.4085651328828;511.289307862072;590.0735844723786;609.9420555047263;615.704461858306;616.3836163836164;13949.651258718512;13994.30028498571;14003;14015.369308381147;14031.78952315716;13294.601161965156;13315.267660278681;13331.266780327078;13474.595762127152;13749;12185.32980686062;12190;12312;12526.49682038152;13137.934310328483;4290.313549832012;4329.588689074533;4392.714473559208;4432.335149727534;4594.724316541018;60156.69921650407;61224.69387653078;62432.06351904725;62940.370596293906;63484.365156348766;10386.480675966322;10436.165106791439;10562.260641755158;10603.72399771902;10725.83911241332;18685;19753.604927901648;19766.90116549408;19789;19807.405777826687;7945.205479452125;8053.07389650186;8229.177082291722;8232.917670823335;8253.33973282136;3811.313963486544;3968.226195891831;3995.5005624296964;4010.19796040793;4167.166566686675;3327.8169700666213;3399.5240666306736;3412.84642191097;3416.7095796857047;3427.691507764313;608.2184393054903;616.9938300617026;617.675720246874;619.071392910634;622.0482661527869;683.3644710419259;689.4312192441256;699.2972063076576;712.4727701500852;731.6853752886203;8387.538685372363;8403.579821008925;8458.661653533789;8625.396222264506;8824.8676269856;680.7923583307139;681.9590824550543;682.5904457325664;683.1153656015472;703.7712743358429;3874.244522318177;4105.753654780723;4134.289995732737;4146.150039241948;4263.931992983401;65096.674516627114;67013.3298667007;68102.31897680959;75413.622931885;86209.56895215609;42606.633421666535;51672.741636291576;67880.6605966967;69309.30690693129;70649.64675176694;61084.69457652683;62363;63533.68233158897;64225;64486.35513644804;7933.7702656088395;8449.83100338002;8455.915440845512;8519.91480085216;8583.313334933315;41658.58341416547;41794.37308440315;43536.346954795066;43788.781056094514;44209.33685994648;37947.81026094852;56687.433125669864;57065.42934570601;57301;58144;10800.891991079989;11113.944430277797;11159.88840111621;11208.10335173168;11216.495257713586;12618.87381126177;12727.80908286358;12830.807537887125;12914.160579562298;13000.08999370035;10200.3369780964;12024.879751202376;12047.277163370225;12482.812757808459;12495.812562811747;11785.351805650771;12000.519979200733;12028.218165819193;12050.243353803682;12438.440270188044;12080.51677932908;12127.454264558293;12437.62687119388;12465.626031219077;12547.686307842378;9172.266218702622;9241.815163696823;9364.978829302816;10120.544575494268;10211.744706382102;9715.07706767856;10075.899241007495;10117.342372746043;10200.795984080425;10207.183425326104 09:07:23 INFO - PROCESS | 19277 | __end_tp_report 09:07:23 INFO - PROCESS | 19277 | __start_cc_report 09:07:23 INFO - PROCESS | 19277 | _x_x_mozilla_cycle_collect,2867 09:07:23 INFO - PROCESS | 19277 | __end_cc_report 09:07:23 INFO - PROCESS | 19277 | __startTimestamp1477843643209__endTimestamp 09:07:23 INFO - PROCESS | 19277 | 09:07:23 INFO - PROCESS | 19277 | ------- Summary: start ------- 09:07:23 INFO - PROCESS | 19277 | Number of tests: 6 09:07:23 INFO - PROCESS | 19277 | 09:07:23 INFO - PROCESS | 19277 | [#0] dojo.html Cycles:165 Average:5218.11 Median:5462.48 stddev:700.90 (12.8%) stddev-sans-first:680.64 09:07:23 INFO - PROCESS | 19277 | Values: 2976.7 3005.1 3033.2 3045.9 3048.9 5154.9 5190.6 5254.5 5312.7 5404.6 5278.8 5285.5 5296.0 5299.6 5303.4 4771.1 4792.2 4798.3 4841.7 4883.4 4820.6 4856.4 4893.4 4894.3 4928.0 4893.2 4915.9 4923.6 4947.3 4950.0 496.5 4895.1 4902.0 4912.9 4957.2 3287.0 4762.4 4802.3 4814.2 4854.2 5266.6 5266.7 5272.1 5273.1 5284.9 5620.4 5688.3 5690.1 5691.6 5699.0 5511.9 5555.9 5560.8 5617.5 5665.5 5260.8 5278.6 5279.8 5284.9 5303.5 5795.5 5797.2 5802.7 5804.5 5806.6 5422.9 5451.3 5492.7 5495.1 5643.1 5623.2 5638.9 5651.0 5654.3 5695.3 5626.3 5628.7 5630.0 5631.9 5633.8 5490.0 5544.5 5579.5 5622.7 5624.0 4376.1 4410.4 4423.2 4424.5 4425.5 3875.7 3890.8 3895.6 3932.4 3937.8 5253.9 5302.5 5351.6 5352.4 5360.2 5632.7 5635.0 5663.9 5685.2 5769.5 5316.3 5335.7 5355.2 5372.1 5372.4 4906.6 4914.2 4920.2 4921.7 4976.0 5705.6 5749.0 5755.7 5772.9 5824.5 5617.7 5618.2 5625.3 5629.0 5630.5 5834.1 5846.8 5848.5 5852.9 5852.9 5484.2 5528.6 5529.6 5529.9 5531.6 5606.5 5614.1 5616.1 5617.5 5619.0 5519.6 5529.4 5542.7 5543.1 5546.8 5424.1 5431.6 5452.2 5508.4 5512.5 5486.2 5490.3 5498.2 5500.6 5502.9 5462.4 5510.0 5556.9 5564.8 5625.9 5414.4 5462.5 5474.8 5524.1 5532.2 09:07:23 INFO - PROCESS | 19277 | 09:07:23 INFO - PROCESS | 19277 | [#1] ext.html Cycles:180 Average:61842.02 Median:39525.40 stddev:127174.81 (321.8%) stddev-sans-first:127448.40 09:07:23 INFO - PROCESS | 19277 | Values: 582.8 590.8 620.4 634.9 638.2 41876.8 43675.3 43760.0 46150.0 46217.0 45364.5 45863.3 45938.0 45954.8 45961.9 8036.2 8729.9 8872.6 8876.1 8887.3 8104.6 8179.3 8184.0 10359.4 10535.9 10640.1 10704.8 10711.7 10718.1 10718.4 10388.5 10448.7 10448.7 10456.1 10462.2 10468.4 10543.5 10549.3 10552.7 10557.0 42187.0 42520.1 42545.0 42561.6 42568.1 3509.4 3512.0 3917.8 3967.3 4012.6 30987.0 31706.4 31764.4 31945.8 32204.8 4246.4 4300.1 4366.0 4508.0 4551.2 317408.0 317600.0 318230.0 318778.0 318983.0 57568.0 58229.7 58276.7 58298.0 58324.7 62075.4 62432.4 62447.0 62468.7 62476.7 14581.2 14707.5 14715.4 14719.0 14727.7 13460.9 13513.3 13524.4 13525.1 13526.0 15354.5 15650.2 15776.7 16312.8 16323.4 5058.3 5982.7 5996.9 6099.1 6198.6 901.9 982.6 1017.4 1035.2 1096.4 31229.4 31815.7 31973.8 32094.7 32358.5 1102.6 1112.6 1121.0 1130.6 1199.0 16393.5 16688.3 16740.4 16804.3 17029.5 473848.0 478013.0 478519.0 479054.0 480911.0 50192.5 51427.2 55881.7 58125.7 58540.7 1294.4 1315.6 1344.2 1362.7 1363.1 30658.5 32833.3 33019.7 33152.2 33818.3 51156.7 51520.4 51578.7 51609.0 51644.0 411886.0 618207.0 631051.0 638069.0 641098.0 26649.0 27276.3 27305.9 27653.9 27672.6 47327.5 47414.0 47926.5 48128.0 48276.8 39446.4 39665.4 39689.4 41354.8 41361.0 39064.8 39625.2 39966.2 40262.4 41530.8 39455.8 39595.0 40632.4 40779.6 40805.6 31051.8 34736.0 34906.8 35828.8 35864.3 27409.9 27412.3 27510.4 27521.7 27940.7 09:07:23 INFO - PROCESS | 19277 | 09:07:23 INFO - PROCESS | 19277 | [#2] jquery.html Cycles:180 Average:26064.71 Median:19794.65 stddev:69061.80 (348.9%) stddev-sans-first:69228.61 09:07:23 INFO - PROCESS | 19277 | Values: 377.3 386.3 396.6 397.9 416.8 12921.3 14858.8 15731.2 18917.4 19007.8 17891.1 18176.2 18464.2 18545.4 18560.8 5178.8 5370.8 5375.9 5377.8 5378.3 4596.2 5029.0 5821.1 5862.3 5866.7 5805.2 5808.1 5822.2 5824.3 5832.4 5570.7 5818.7 5848.9 5910.5 5919.2 5543.6 5646.5 5704.3 5710.1 5723.3 13433.9 13604.7 13622.2 13733.5 18773.3 2362.1 2389.3 2403.6 2423.8 2451.3 10127.8 10495.8 12395.0 13748.8 13797.7 1872.9 1890.7 1916.3 1960.6 1969.0 70147.6 76844.6 77872.0 79060.6 79619.0 9819.4 10282.6 10427.0 10491.9 10785.4 13817.2 13829.4 13834.4 13843.8 13878.9 7774.7 7975.9 7980.7 8245.5 8263.4 7584.9 7678.4 7820.1 7952.0 7965.5 4526.2 4551.9 4583.3 4642.7 4749.0 1576.6 1675.0 1768.4 1908.6 1939.4 872.8 951.2 997.4 1017.4 1077.3 19094.3 19480.8 19607.6 19621.1 19715.7 989.4 994.3 998.3 1011.0 1095.6 10408.2 10925.2 10964.5 11008.4 11033.2 407445.0 415118.0 420624.0 420832.0 424243.0 69027.0 85349.0 86513.6 86876.0 88384.6 956.7 979.7 997.1 1002.4 1006.9 16436.1 16642.3 17155.7 17364.8 17758.2 39203.0 39907.0 39955.8 40281.0 40819.4 53620.5 55309.2 55487.7 55986.7 56562.0 7947.5 8097.2 8193.8 8557.9 8744.6 12278.8 12807.8 12840.6 13252.6 13594.0 10629.2 10643.5 11063.9 11397.1 11787.1 10843.9 11008.2 11054.1 11180.5 11311.6 10804.6 11129.4 11180.1 11202.6 11341.2 8074.2 8201.4 8426.1 8443.7 8478.7 9880.7 11323.7 11629.4 11949.3 12158.1 09:07:23 INFO - PROCESS | 19277 | 09:07:23 INFO - PROCESS | 19277 | [#3] mootools.html Cycles:180 Average:5600.04 Median:5140.27 stddev:3139.81 (61.1%) stddev-sans-first:3133.14 09:07:23 INFO - PROCESS | 19277 | Values: 1451.5 1487.5 1587.5 1705.2 1725.4 8080.4 8584.4 8584.5 8585.2 8586.3 7502.0 7699.1 8196.5 8410.0 8438.5 2303.2 2330.0 2342.4 2347.3 2348.8 2304.0 2341.6 2368.6 2370.9 2375.1 2244.7 2270.5 2276.5 2280.2 2293.0 2197.2 2291.2 2298.5 2312.0 2314.9 2283.9 2285.5 2306.3 2313.5 2314.2 8297.5 8539.8 8549.5 8565.8 8569.0 5184.9 5262.6 5296.1 5297.2 5343.9 3133.2 3264.6 3435.6 3442.3 3459.8 1081.1 1092.5 1101.1 1111.6 1175.5 11634.9 11728.8 11741.6 11746.5 11746.9 4344.7 4648.9 4667.9 4700.1 4724.1 9864.8 9924.7 9939.8 9942.3 9949.4 5240.8 5250.5 5261.8 5262.1 5264.0 4301.6 4374.3 4642.8 4814.7 4828.4 3772.5 3817.8 3855.9 3904.2 3914.2 1213.1 1227.2 1246.2 1257.1 1258.1 859.3 881.5 978.2 987.2 1031.4 5842.2 5946.8 5995.6 6013.4 6187.7 413.5 424.6 426.9 427.1 428.9 3886.2 3898.7 3913.1 3948.6 4038.4 9889.5 10310.9 10474.2 10477.2 10480.6 10305.6 10400.2 10434.5 10437.2 10437.3 7816.5 8018.4 8057.2 8058.1 8070.2 5683.8 5736.3 5744.1 5769.5 5909.4 9544.5 9569.5 9570.0 9610.4 9626.8 9657.8 9685.2 9699.5 9826.2 9839.1 6948.3 7143.9 7198.9 7343.4 7376.9 8190.3 8232.8 8374.4 8382.7 8383.1 7334.0 7374.2 7394.3 7491.7 7703.9 7238.3 7441.1 7441.9 7456.0 7505.0 6569.1 6671.9 6680.6 6685.3 6687.3 5038.4 5104.1 5116.6 5164.0 5433.4 4969.7 4999.9 5077.7 5221.5 5408.8 09:07:23 INFO - PROCESS | 19277 | 09:07:23 INFO - PROCESS | 19277 | [#4] prototype.html Cycles:180 Average:4228.79 Median:4699.12 stddev:1190.70 (25.3%) stddev-sans-first:1157.26 09:07:23 INFO - PROCESS | 19277 | Values: 316.2 320.2 324.4 327.1 329.1 4997.2 5153.5 5164.9 5213.6 5255.0 4964.6 5025.0 5041.4 5078.5 5117.9 3995.0 4009.2 4033.8 4037.9 4045.2 3749.2 3823.7 4012.9 4021.9 4032.5 3964.2 3970.8 3997.2 3999.1 4003.7 3948.8 3950.6 3986.2 4009.8 4022.7 3502.7 3503.8 3505.8 3520.2 3529.7 4785.0 4887.1 4957.9 4974.9 4976.6 4579.2 4580.7 4581.7 4587.2 4602.7 5299.9 5332.3 5337.8 5338.3 5341.1 3639.7 3818.1 3841.2 3843.5 3910.6 5511.6 5521.8 5546.4 5550.6 5553.8 3897.6 3904.4 3910.8 3912.3 3919.3 3896.1 3945.7 3953.0 3984.4 3998.7 4513.5 4527.3 4545.7 4546.9 4583.8 5386.2 5387.6 5408.1 5431.5 5441.7 1282.8 1306.5 1359.3 1368.1 1385.7 851.7 857.9 867.2 874.9 885.5 4663.9 4672.8 4693.8 4699.9 4726.9 4698.9 4826.5 4887.5 4894.0 4907.6 4504.0 4542.4 4567.8 4585.7 4591.9 2563.9 2576.5 2576.7 2593.6 2645.1 4678.3 4963.6 4978.6 4994.9 5004.8 4844.8 4851.6 4856.2 4902.0 4904.2 4929.2 4938.7 4944.5 4972.5 4983.6 4616.2 4785.3 4793.9 4809.4 4865.4 4825.0 4831.5 4843.5 4849.8 4854.5 5040.9 5063.4 5079.2 5087.8 5106.4 3573.9 3576.7 3599.4 3600.8 3614.2 4528.9 4785.3 4809.2 4812.5 4819.4 4681.8 4690.9 4769.8 4791.6 4795.5 4689.4 4705.0 4722.8 4726.8 4746.2 4487.0 4583.4 4698.3 4709.3 4728.5 4744.2 4745.6 4775.8 4876.7 4893.3 4659.2 4665.4 4678.3 4699.3 4740.2 09:07:23 INFO - PROCESS | 19277 | 09:07:23 INFO - PROCESS | 19277 | [#5] yui.html Cycles:180 Average:16127.24 Median:24320.84 stddev:20439.89 (84.0%) stddev-sans-first:20464.60 09:07:23 INFO - PROCESS | 19277 | Values: 745.5 750.0 756.5 789.8 821.7 14636.3 15599.9 15681.5 15701.9 15702.5 13194.2 13317.7 13318.9 13331.5 13340.2 646.4 663.5 785.7 796.5 797.1 767.2 793.4 794.6 803.4 808.5 863.1 864.9 865.6 865.7 865.8 680.8 856.4 860.7 862.3 863.4 511.3 590.1 609.9 615.7 616.4 13949.7 13994.3 14003.0 14015.4 14031.8 13294.6 13315.3 13331.3 13474.6 13749.0 12185.3 12190.0 12312.0 12526.5 13137.9 4290.3 4329.6 4392.7 4432.3 4594.7 60156.7 61224.7 62432.1 62940.4 63484.4 10386.5 10436.2 10562.3 10603.7 10725.8 18685.0 19753.6 19766.9 19789.0 19807.4 7945.2 8053.1 8229.2 8232.9 8253.3 3811.3 3968.2 3995.5 4010.2 4167.2 3327.8 3399.5 3412.8 3416.7 3427.7 608.2 617.0 617.7 619.1 622.0 683.4 689.4 699.3 712.5 731.7 8387.5 8403.6 8458.7 8625.4 8824.9 680.8 682.0 682.6 683.1 703.8 3874.2 4105.8 4134.3 4146.2 4263.9 65096.7 67013.3 68102.3 75413.6 86209.6 42606.6 51672.7 67880.7 69309.3 70649.6 61084.7 62363.0 63533.7 64225.0 64486.4 7933.8 8449.8 8455.9 8519.9 8583.3 41658.6 41794.4 43536.3 43788.8 44209.3 37947.8 56687.4 57065.4 57301.0 58144.0 10800.9 11113.9 11159.9 11208.1 11216.5 12618.9 12727.8 12830.8 12914.2 13000.1 10200.3 12024.9 12047.3 12482.8 12495.8 11785.4 12000.5 12028.2 12050.2 12438.4 12080.5 12127.5 12437.6 12465.6 12547.7 9172.3 9241.8 9365.0 10120.5 10211.7 9715.1 10075.9 10117.3 10200.8 10207.2 09:07:23 INFO - PROCESS | 19277 | -------- Summary: end -------- 09:07:23 INFO - PROCESS | 19277 | 09:07:24 INFO - TEST-INFO | 19277: exit 0 09:07:24 INFO - TEST-OK | dromaeo_css | took 1117431ms 09:07:24 INFO - TEST-START | kraken 09:07:24 INFO - operating with platform_type : linux_ 09:07:24 INFO - Initialising browser for kraken test... 09:07:24 INFO - TEST-INFO | started process 19581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIP4CDa/profile http://localhost:42557/getInfo.html) 09:07:28 INFO - PROCESS | 19581 | __metrics Screen width/height:1600/1200 09:07:28 INFO - PROCESS | 19581 | colorDepth:24 09:07:28 INFO - PROCESS | 19581 | Browser inner width/height: 1024/697 09:07:28 INFO - PROCESS | 19581 | __metrics 09:07:28 INFO - PROCESS | 19581 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:07:28 INFO - PROCESS | 19581 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:07:29 INFO - PROCESS | 19581 | console.error: PushService: 09:07:29 INFO - PROCESS | 19581 | stateChangeProcessEnqueue: Error transitioning state 09:07:29 INFO - PROCESS | 19581 | UnknownError 09:07:29 INFO - TEST-INFO | 19581: exit 0 09:07:29 INFO - Browser initialized. 09:07:29 INFO - Running cycle 1/1 for kraken test... 09:07:29 INFO - TEST-INFO | started process 19668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIP4CDa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:42 INFO - PROCESS | 19668 | RSS: Main: 172490752 09:07:42 INFO - PROCESS | 19668 | 09:07:44 INFO - PROCESS | 19668 | Cycle 1(1): loaded http://localhost:42557/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42557/tests/kraken/driver.html?testName=audio-beat-detection) 09:07:45 INFO - PROCESS | 19668 | RSS: Main: 229257216 09:07:45 INFO - PROCESS | 19668 | 09:07:48 INFO - PROCESS | 19668 | Cycle 1(1): loaded http://localhost:42557/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42557/tests/kraken/driver.html?testName=audio-dft) 09:07:48 INFO - PROCESS | 19668 | RSS: Main: 215633920 09:07:48 INFO - PROCESS | 19668 | 09:07:51 INFO - PROCESS | 19668 | Cycle 1(1): loaded http://localhost:42557/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42557/tests/kraken/driver.html?testName=audio-fft) 09:07:52 INFO - PROCESS | 19668 | RSS: Main: 297447424 09:07:52 INFO - PROCESS | 19668 | 09:07:54 INFO - PROCESS | 19668 | Cycle 1(1): loaded http://localhost:42557/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42557/tests/kraken/driver.html?testName=audio-oscillator) 09:07:55 INFO - PROCESS | 19668 | RSS: Main: 208379904 09:07:55 INFO - PROCESS | 19668 | 09:07:57 INFO - PROCESS | 19668 | Cycle 1(1): loaded http://localhost:42557/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42557/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:07:57 INFO - PROCESS | 19668 | RSS: Main: 211161088 09:07:57 INFO - PROCESS | 19668 | 09:08:00 INFO - PROCESS | 19668 | Cycle 1(1): loaded http://localhost:42557/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42557/tests/kraken/driver.html?testName=imaging-darkroom) 09:08:01 INFO - PROCESS | 19668 | RSS: Main: 247230464 09:08:01 INFO - PROCESS | 19668 | 09:08:04 INFO - PROCESS | 19668 | Cycle 1(1): loaded http://localhost:42557/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42557/tests/kraken/driver.html?testName=imaging-desaturate) 09:08:05 INFO - PROCESS | 19668 | RSS: Main: 246480896 09:08:05 INFO - PROCESS | 19668 | 09:08:08 INFO - PROCESS | 19668 | Cycle 1(1): loaded http://localhost:42557/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42557/tests/kraken/driver.html?testName=json-parse-financial) 09:08:08 INFO - PROCESS | 19668 | RSS: Main: 246153216 09:08:08 INFO - PROCESS | 19668 | 09:08:10 INFO - PROCESS | 19668 | Cycle 1(1): loaded http://localhost:42557/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42557/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:08:10 INFO - PROCESS | 19668 | RSS: Main: 209178624 09:08:10 INFO - PROCESS | 19668 | 09:08:12 INFO - PROCESS | 19668 | Cycle 1(1): loaded http://localhost:42557/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42557/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:08:13 INFO - PROCESS | 19668 | RSS: Main: 216596480 09:08:13 INFO - PROCESS | 19668 | 09:08:15 INFO - PROCESS | 19668 | Cycle 1(1): loaded http://localhost:42557/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42557/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:08:15 INFO - PROCESS | 19668 | RSS: Main: 225636352 09:08:15 INFO - PROCESS | 19668 | 09:08:18 INFO - PROCESS | 19668 | Cycle 1(1): loaded http://localhost:42557/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42557/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:08:19 INFO - PROCESS | 19668 | RSS: Main: 234078208 09:08:19 INFO - PROCESS | 19668 | 09:08:21 INFO - PROCESS | 19668 | Cycle 1(1): loaded http://localhost:42557/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42557/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:08:22 INFO - PROCESS | 19668 | RSS: Main: 231350272 09:08:22 INFO - PROCESS | 19668 | 09:08:24 INFO - PROCESS | 19668 | Cycle 1(1): loaded http://localhost:42557/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42557/tests/kraken/driver.html?testName=ai-astar) 09:08:24 INFO - PROCESS | 19668 | RSS: Main: 282861568 09:08:24 INFO - PROCESS | 19668 | 09:08:24 INFO - PROCESS | 19668 | __start_tp_report 09:08:24 INFO - PROCESS | 19668 | _x_x_mozilla_page_load 09:08:24 INFO - PROCESS | 19668 | _x_x_mozilla_page_load_details 09:08:24 INFO - PROCESS | 19668 | |i|pagename|runs| 09:08:24 INFO - PROCESS | 19668 | |0;ai-astar;102;110;110;110;111;111;110;110;110;112 09:08:24 INFO - PROCESS | 19668 | |1;audio-beat-detection;144;122;121;157;129;123;123;126;162;123 09:08:24 INFO - PROCESS | 19668 | |2;audio-dft;165;161;161;161;161;163;162;164;161;161 09:08:24 INFO - PROCESS | 19668 | |3;audio-fft;75;76;76;106;77;77;77;77;108;77 09:08:24 INFO - PROCESS | 19668 | |4;audio-oscillator;83;81;125;81;82;82;103;81;82;113 09:08:24 INFO - PROCESS | 19668 | |5;imaging-gaussian-blur;117;117;116;117;117;117;116;117;117;116 09:08:24 INFO - PROCESS | 19668 | |6;imaging-darkroom;147;145;145;146;145;147;145;146;145;146 09:08:24 INFO - PROCESS | 19668 | |7;imaging-desaturate;85;86;85;86;85;86;85;85;85;86 09:08:24 INFO - PROCESS | 19668 | |8;json-parse-financial;51;52;54;52;52;54;52;55;53;53 09:08:24 INFO - PROCESS | 19668 | |9;json-stringify-tinderbox;61;62;62;62;62;62;61;62;62;62 09:08:24 INFO - PROCESS | 19668 | |10;stanford-crypto-aes;81;89;85;80;79;79;80;81;80;80 09:08:24 INFO - PROCESS | 19668 | |11;stanford-crypto-ccm;131;132;131;148;136;131;131;134;175;130 09:08:24 INFO - PROCESS | 19668 | |12;stanford-crypto-pbkdf2;170;163;163;163;163;165;164;160;167;168 09:08:24 INFO - PROCESS | 19668 | |13;stanford-crypto-sha256-iterative;65;65;70;64;63;64;66;63;67;63 09:08:24 INFO - PROCESS | 19668 | __end_tp_report 09:08:24 INFO - PROCESS | 19668 | __start_cc_report 09:08:24 INFO - PROCESS | 19668 | _x_x_mozilla_cycle_collect,1664 09:08:24 INFO - PROCESS | 19668 | __end_cc_report 09:08:24 INFO - PROCESS | 19668 | __startTimestamp1477843704365__endTimestamp 09:08:24 INFO - PROCESS | 19668 | 09:08:24 INFO - PROCESS | 19668 | ------- Summary: start ------- 09:08:24 INFO - PROCESS | 19668 | Number of tests: 14 09:08:24 INFO - PROCESS | 19668 | 09:08:24 INFO - PROCESS | 19668 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:2.76 (2.5%) stddev-sans-first:0.73 09:08:24 INFO - PROCESS | 19668 | Values: 102.0 110.0 110.0 110.0 111.0 111.0 110.0 110.0 110.0 112.0 09:08:24 INFO - PROCESS | 19668 | 09:08:24 INFO - PROCESS | 19668 | [#1] audio-beat-detection Cycles:10 Average:133.00 Median:127.50 stddev:15.52 (12.2%) stddev-sans-first:15.94 09:08:24 INFO - PROCESS | 19668 | Values: 144.0 122.0 121.0 157.0 129.0 123.0 123.0 126.0 162.0 123.0 09:08:24 INFO - PROCESS | 19668 | 09:08:24 INFO - PROCESS | 19668 | [#2] audio-dft Cycles:10 Average:162.00 Median:161.50 stddev:1.49 (0.9%) stddev-sans-first:1.12 09:08:24 INFO - PROCESS | 19668 | Values: 165.0 161.0 161.0 161.0 161.0 163.0 162.0 164.0 161.0 161.0 09:08:24 INFO - PROCESS | 19668 | 09:08:24 INFO - PROCESS | 19668 | [#3] audio-fft Cycles:10 Average:82.60 Median:77.00 stddev:12.89 (16.7%) stddev-sans-first:13.37 09:08:24 INFO - PROCESS | 19668 | Values: 75.0 76.0 76.0 106.0 77.0 77.0 77.0 77.0 108.0 77.0 09:08:24 INFO - PROCESS | 19668 | 09:08:24 INFO - PROCESS | 19668 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:81.50 stddev:16.30 (20.0%) stddev-sans-first:17.01 09:08:24 INFO - PROCESS | 19668 | Values: 83.0 81.0 125.0 81.0 82.0 82.0 103.0 81.0 82.0 113.0 09:08:24 INFO - PROCESS | 19668 | 09:08:24 INFO - PROCESS | 19668 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 09:08:24 INFO - PROCESS | 19668 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 09:08:24 INFO - PROCESS | 19668 | 09:08:24 INFO - PROCESS | 19668 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 09:08:24 INFO - PROCESS | 19668 | Values: 147.0 145.0 145.0 146.0 145.0 147.0 145.0 146.0 145.0 146.0 09:08:24 INFO - PROCESS | 19668 | 09:08:24 INFO - PROCESS | 19668 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 09:08:24 INFO - PROCESS | 19668 | Values: 85.0 86.0 85.0 86.0 85.0 86.0 85.0 85.0 85.0 86.0 09:08:24 INFO - PROCESS | 19668 | 09:08:24 INFO - PROCESS | 19668 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:1.23 (2.3%) stddev-sans-first:1.12 09:08:24 INFO - PROCESS | 19668 | Values: 51.0 52.0 54.0 52.0 52.0 54.0 52.0 55.0 53.0 53.0 09:08:24 INFO - PROCESS | 19668 | 09:08:24 INFO - PROCESS | 19668 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 09:08:24 INFO - PROCESS | 19668 | Values: 61.0 62.0 62.0 62.0 62.0 62.0 61.0 62.0 62.0 62.0 09:08:24 INFO - PROCESS | 19668 | 09:08:24 INFO - PROCESS | 19668 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:80.50 stddev:3.17 (3.9%) stddev-sans-first:3.36 09:08:24 INFO - PROCESS | 19668 | Values: 81.0 89.0 85.0 80.0 79.0 79.0 80.0 81.0 80.0 80.0 09:08:24 INFO - PROCESS | 19668 | 09:08:24 INFO - PROCESS | 19668 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:133.00 stddev:14.08 (10.6%) stddev-sans-first:14.71 09:08:24 INFO - PROCESS | 19668 | Values: 131.0 132.0 131.0 148.0 136.0 131.0 131.0 134.0 175.0 130.0 09:08:24 INFO - PROCESS | 19668 | 09:08:24 INFO - PROCESS | 19668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:164.50 stddev:2.95 (1.8%) stddev-sans-first:2.40 09:08:24 INFO - PROCESS | 19668 | Values: 170.0 163.0 163.0 163.0 163.0 165.0 164.0 160.0 167.0 168.0 09:08:24 INFO - PROCESS | 19668 | 09:08:24 INFO - PROCESS | 19668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:2.21 (3.4%) stddev-sans-first:2.35 09:08:24 INFO - PROCESS | 19668 | Values: 65.0 65.0 70.0 64.0 63.0 64.0 66.0 63.0 67.0 63.0 09:08:24 INFO - PROCESS | 19668 | -------- Summary: end -------- 09:08:24 INFO - PROCESS | 19668 | 09:08:25 INFO - TEST-INFO | 19668: exit 0 09:08:25 INFO - TEST-OK | kraken | took 61539ms 09:08:25 INFO - SUITE-END | took 1178s 09:08:26 INFO - Completed test suite (00:19:39) 09:08:26 INFO - javascript benchmark 09:08:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2976.7172118648728, 3005.053408176423, 3033.1658793831693, 3045.8781648734052, 3048.878044878205, 5154.896902061966, 5190.636655434121, 5254.527092561669, 5312.68123912565, 5404.594655400846, 5278.762455689493, 5285.524302812746, 5296.046711591912, 5299.576033917287, 5303.443138470463, 4771.069641419916, 4792.161371759946, 4798.328234047236, 4841.661083724141, 4883.413990321166, 4820.590249828769, 4856.3686720726255, 4893.41279046515, 4894.3147959285725, 4928.0, 4893.192623217183, 4915.901681966358, 4923.630727695419, 4947.332110165135, 4949.975250123744, 496.53717256907095, 4895.094407534618, 4902.044101400228, 4912.89372535316, 4957.231629097496, 3287.04110398583, 4762.404699412574, 4802.327674125625, 4814.15752243356, 4854.2233242681, 5266.60500462463, 5266.710330931797, 5272.077386457393, 5273.050850846846, 5284.867878303035, 5620.437956204388, 5688.288963879515, 5690.06113991191, 5691.573132015074, 5698.971505142489, 5511.917321240185, 5555.8888822223735, 5560.833175004756, 5617.494425501724, 5665.461781130786, 5260.763265653055, 5278.630495865329, 5279.788808447696, 5284.894302113975, 5303.496167864047, 5795.507381872504, 5797.159411885337, 5802.738876750556, 5804.477597016289, 5806.622569533051, 5422.91865622016, 5451.318585176853, 5492.725363731797, 5495.120780675073, 5643.125315576092, 5623.212750214973, 5638.943610563924, 5650.971745141248, 5654.264945557051, 5695.316562012585, 5626.2967129108865, 5628.690422026828, 5630.014747419185, 5631.943680563224, 5633.8309850704545, 5489.972550137224, 5544.500994910397, 5579.46995035471, 5622.746976386073, 5623.971880140655, 4376.102898905717, 4410.3825464435, 4423.181711383404, 4424.513303536608, 4425.491068527096, 3875.748076375027, 3890.7665540067687, 3895.5909629488497, 3932.4297976793778, 3937.8424863005157, 5253.921191182136, 5302.549283310885, 5351.57187425005, 5352.437994010573, 5360.169173777993, 5632.690202038845, 5634.97182514093, 5663.943360566424, 5685.232493613392, 5769.509591684669, 5316.282301889196, 5335.653182543122, 5355.223492593552, 5372.059889519319, 5372.382176049804, 4906.55840974314, 4914.238293064509, 4920.163572192736, 4921.680090794087, 4975.975120124376, 5705.600607957486, 5748.971255143698, 5755.740991655385, 5772.884542309214, 5824.504917082096, 5617.662940223599, 5618.185363122406, 5625.268715067179, 5629.0, 5630.465105814941, 5834.124881267844, 5846.766129354778, 5848.502877255481, 5852.94147058524, 5852.94147058524, 5484.232207491034, 5528.55771538284, 5529.640573362719, 5529.861753456195, 5531.585131115102, 5606.523445507014, 5614.101743720985, 5616.073347897551, 5617.522510586646, 5618.988582055269, 5519.613627046068, 5529.391766905556, 5542.722863856871, 5543.085390910616, 5546.833594992157, 5424.105022671373, 5431.565474762088, 5452.154915988028, 5508.366537848199, 5512.503874651301, 5486.231927530229, 5490.313710786152, 5498.175273708815, 5500.614956953135, 5502.9174562382395, 5462.399136094947, 5510.035743744908, 5556.91664625039, 5564.8330550083565, 5625.887482250414, 5414.404415514212, 5462.481064298885, 5474.835754927359, 5524.088525393265, 5532.2254884317035], "value": 5174.227745799528, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.7727186397304, 590.7784580782206, 620.4106099205756, 634.9301576826551, 638.164005153249, 41876.790616046914, 43675.344869826935, 43760.0, 46150.0, 46217.0, 45364.54635453645, 45863.31205031919, 45938.0, 45954.77022614882, 45961.86343229109, 8036.1963803619465, 8729.91270087299, 8872.556372181398, 8876.068012858654, 8887.289016878667, 8104.5542495162745, 8179.304759095484, 8183.9590802046205, 10359.430231337274, 10535.947320263387, 10640.148788096934, 10704.839427408557, 10711.678649640484, 10718.142548596132, 10718.410487423189, 10388.48057597117, 10448.686539403754, 10448.686539403792, 10456.058954694037, 10462.163026957825, 10468.42423666698, 10543.52554135058, 10549.314294570828, 10552.736181595445, 10557.0, 42187.0, 42520.14959700788, 42545.0, 42561.57438425607, 42568.14863702739, 3509.4209455439823, 3511.9824400878088, 3917.759913934796, 3967.3453880109746, 4012.578679238667, 30987.0, 31706.365872682647, 31764.364712705847, 31945.840270798497, 32204.838975805204, 4246.384274280212, 4300.075483771005, 4365.9739961109435, 4508.0, 4551.180787458256, 317407.9999999977, 317600.0, 318230.0, 318778.0, 318983.0, 57568.0, 58229.70885145632, 58276.708616457494, 58298.0, 58324.70837645869, 62075.37924620696, 62432.375676243566, 62447.0, 62468.68765656143, 62476.68761656163, 14581.198034108225, 14707.485238016618, 14715.411383544753, 14719.0, 14727.705445891022, 13460.93269533646, 13513.256770877499, 13524.391402386917, 13525.120867143603, 13526.0, 15354.539363819104, 15650.217489125498, 15776.684466310839, 16312.776541759415, 16323.428679996143, 5058.291839142523, 5982.670953097534, 5996.850078748066, 6099.146119543268, 6198.574327904607, 901.8557030875029, 982.6167794560128, 1017.414986382818, 1035.2028937717914, 1096.380544992077, 31229.375412491623, 31815.68184318127, 31973.840130799195, 32094.67905320917, 32358.514622280683, 1102.5589764094427, 1112.6105862947904, 1121.0, 1130.5816847766214, 1199.0407673860877, 16393.508194754177, 16688.33246670144, 16740.41408550695, 16804.327826886787, 17029.48911532656, 473848.0, 478013.0, 478519.0, 479054.0, 480911.0, 50192.49807501951, 51427.228591571155, 55881.720591396785, 58125.70937145372, 58540.707296463246, 1294.4175121195312, 1315.592166428391, 1344.2069179184327, 1362.6661467940219, 1363.0526783885105, 30658.540121898637, 32833.343333132725, 33019.66980330166, 33152.1711957203, 33818.32363352768, 51156.74421627868, 51520.42397880166, 51578.74210628923, 51609.0, 51644.0, 411886.0, 618207.0, 631051.0, 638069.0, 641098.0, 26649.0, 27276.31809204786, 27305.863470682518, 27653.861730691217, 27672.58491122675, 47327.52672473231, 47414.0, 47926.520734792204, 48128.0, 48276.7586162081, 39446.3909601821, 39665.40501892416, 39689.40465893072, 41354.793226033675, 41361.0, 39064.80467597644, 39625.207495850496, 39966.20236583411, 40262.39606405848, 41530.792346039285, 39455.80272098621, 39595.0, 40632.39051414172, 40779.59220407758, 40805.59194408137, 31051.844740776152, 34736.0, 34906.825465872505, 35828.8208558966, 35864.28271434505, 27409.862950685118, 27412.314692132855, 27510.372616293404, 27521.724782752717, 27940.720592793812], "value": 20177.65937667174, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.2850448400283, 386.2950116038229, 396.56576049226095, 397.8806358092572, 416.81660069569386, 12921.30120600784, 14858.77711834322, 15731.21343932803, 18917.432477025675, 19007.809921900778, 17891.105444727746, 18176.1820718068, 18464.16911238994, 18545.35091271806, 18560.814391856078, 5178.7669554869935, 5370.812021579245, 5375.892482150354, 5377.784888604451, 5378.300820893279, 4596.2416201326905, 5029.044481548494, 5821.126830975345, 5862.325832529271, 5866.706664666771, 5805.216295800076, 5808.070708686611, 5822.214001109838, 5824.271966004249, 5832.358440571555, 5570.746582019034, 5818.679972601505, 5848.853778655546, 5910.468057874769, 5919.2009078774245, 5543.556515478752, 5646.463585959368, 5704.344000439961, 5710.14347847822, 5723.255976723041, 13433.932830335883, 13604.727905441836, 13622.182669039888, 13733.45066197351, 18773.34293299728, 2362.14962613459, 2389.342930694073, 2403.591389463778, 2423.7939775119135, 2451.3381387025584, 10127.848082278771, 10495.842562361571, 12395.0, 13748.793768093487, 13797.724045519033, 1872.8782629129064, 1890.6785846406144, 1916.281394477071, 1960.558874253296, 1968.9507762305914, 70147.64926175388, 76844.61577692076, 77872.0, 79060.60469697672, 79619.0, 9819.410835349901, 10282.588696452207, 10427.0, 10491.94754026225, 10785.352878827296, 13817.170969741848, 13829.446822127002, 13834.446622135203, 13843.792343114861, 13878.93060534711, 7774.689012439552, 7975.920240797518, 7980.68077276914, 8245.464044837187, 8263.421560490708, 7584.924150758422, 7678.385729141655, 7820.100688420791, 7952.0, 7965.4822436541435, 4526.185286648435, 4551.908961820745, 4583.2666773316105, 4642.651801114863, 4749.002709430989, 1576.645254817657, 1674.9748753768704, 1768.3633891798943, 1908.6278175755594, 1939.3697048459308, 872.7774417523618, 951.2247518272586, 997.4065431068502, 1017.4404077757204, 1077.2836064017497, 19094.331698390768, 19480.805191948184, 19607.60784784325, 19621.11704973251, 19715.704264436044, 989.4113002763344, 994.3139233928566, 998.2662742883974, 1010.9696709098739, 1095.5836782022939, 10408.167346612405, 10925.235233533576, 10964.506597203144, 11008.39453830031, 11033.172512061628, 407445.0, 415118.0, 420624.0, 420832.0, 424243.0, 69027.0, 85349.0, 86513.56743216244, 86876.0, 88384.5580772092, 956.6556039825657, 979.6718099436769, 997.1474389397106, 1002.3935519011039, 1006.854006169116, 16436.096014719304, 16642.251098700828, 17155.7426638598, 17364.82635173632, 17758.200880960645, 39203.0, 39907.0, 39955.80022099871, 40281.0, 40819.38770918379, 53620.463795361546, 55309.19253478488, 55487.72256138694, 55986.72006639941, 56562.0, 7947.5231486111015, 8097.2307630774985, 8193.836123277382, 8557.914420855712, 8744.562771861509, 12278.81581776292, 12807.80788288195, 12840.55058072963, 13252.602421927357, 13594.0, 10629.20280978945, 10643.467826608794, 11063.889361106287, 11397.145214109141, 11787.115966302734, 10843.945780271048, 11008.229423940247, 11054.084104356036, 11180.496877640364, 11311.604093856675, 10804.567817287221, 11129.387883666475, 11180.10559155282, 11202.551897924317, 11341.20611557216, 8074.232947869943, 8201.384896132695, 8426.115257898078, 8443.66225350979, 8478.74563763088, 9880.703578892644, 11323.71690707706, 11629.418529073344, 11949.283043017447, 12158.088143389457], "value": 8838.998296027754, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.5282533176717, 1487.4793822162244, 1587.5237428771366, 1705.232645309611, 1725.3587848687032, 8080.393970452217, 8584.442011269262, 8584.484930904142, 8585.184407481294, 8586.270167035795, 7502.0, 7699.114601820792, 8196.508209507434, 8410.0, 8438.535880526568, 2303.2053941390236, 2330.0330362899376, 2342.4495243617735, 2347.2840783561005, 2348.800351970076, 2303.9884800576056, 2341.555104530142, 2368.6210206366986, 2370.893309801063, 2375.0737212487143, 2244.6745221942892, 2270.5118399544094, 2276.4764104256033, 2280.2019293247395, 2293.036924491709, 2197.230969160781, 2291.20953271122, 2298.471351589144, 2312.0405031911737, 2314.9074037038413, 2283.8515496492673, 2285.5086156476273, 2306.2504685977124, 2313.456337760625, 2314.166899916029, 8297.460665056813, 8539.829203415959, 8549.529775862326, 8565.785855353604, 8568.957155214246, 5184.948150518484, 5262.578993680497, 5296.099663057251, 5297.231901374279, 5343.893122137574, 3133.1697100268448, 3264.55928449661, 3435.587729472479, 3442.2599141184514, 3459.8443070061658, 1081.0864719580734, 1092.5192915117402, 1101.0971003776906, 1111.6498303034518, 1175.506287359311, 11634.883651163465, 11728.824067638992, 11741.647750567497, 11746.530138794524, 11746.941265293619, 4344.717593356421, 4648.86053418398, 4667.883302917454, 4700.106979673851, 4724.149653062413, 9864.753381165528, 9924.702258932099, 9939.80120397588, 9942.30403871722, 9949.403035817873, 5240.764165612557, 5250.527452529214, 5261.789528418821, 5262.105442074857, 5264.0261551613075, 4301.569843015736, 4374.300111982067, 4642.79107440166, 4814.662973591815, 4828.37231159947, 3772.5284339457567, 3817.7666065351523, 3855.9036024099623, 3904.1996390739832, 3914.1780226152828, 1213.1386715431966, 1227.1961864978452, 1246.2024304445163, 1257.0509265504668, 1258.087886282438, 859.3383095016802, 881.4975463985595, 978.2369751593768, 987.2250283527396, 1031.4224034540682, 5842.211301474246, 5946.791862284799, 5995.5803093783015, 6013.368596297413, 6187.659678717624, 413.52031643293634, 424.63693542021747, 426.8911427586008, 427.05833636830715, 428.94852617686075, 3886.203328317688, 3898.7270891037356, 3913.1391093959282, 3948.6446219840354, 4038.4144299077057, 9889.456079915673, 10310.896891030994, 10474.214433917487, 10477.214208934209, 10480.580776768997, 10305.587776488857, 10400.167986561057, 10434.530446129942, 10437.217208709377, 10437.269391142547, 7816.53100813953, 8018.358531317481, 8057.194280572013, 8058.0733215679775, 8070.1526339734655, 5683.772649094155, 5736.311642602915, 5744.109663002241, 5769.53843692512, 5909.438603332676, 9544.475053872104, 9569.521523923915, 9569.952150239204, 9610.375325603813, 9626.807463850824, 9657.758556036155, 9685.225181985565, 9699.5150242489, 9826.213902887896, 9839.114479696862, 6948.305169483214, 7143.892841607484, 7198.8920166198595, 7343.44924130703, 7376.852462950818, 8190.303824174774, 8232.753017409488, 8374.413791034569, 8382.706605268786, 8383.119772424052, 7333.963330183528, 7374.225706300761, 7394.2975417335265, 7491.70033198666, 7703.922960770321, 7238.312360325761, 7441.069866266716, 7441.92558074434, 7456.0, 7505.0, 6569.146011018537, 6671.8999215010845, 6680.565763225569, 6685.264620891795, 6687.297833727389, 5038.395392552917, 5104.132297509506, 5116.565091967075, 5163.974180129076, 5433.402325744244, 4969.6769709970185, 4999.875003124951, 5077.720725360141, 5221.530062294411, 5408.810691625774], "value": 4432.672428040489, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.24733135138365, 320.1563879178365, 324.40471734367435, 327.1379913926802, 329.0605321806243, 4997.150484417649, 5153.4846515348445, 5164.92252616211, 5213.635045546808, 5255.0, 4964.5780108690715, 5025.0, 5041.395032596084, 5078.466760990098, 5117.872053198672, 3994.9600503995025, 4009.238244733506, 4033.798310084484, 4037.9394309085387, 4045.1505183911413, 3749.2314075614436, 3823.6941044716496, 4012.899677508071, 4021.868409742841, 4032.459550483206, 3964.2071585682834, 3970.8014599270064, 3997.160596274786, 3999.0602208481127, 4003.6797056235578, 3948.8420463181437, 3950.644442000234, 3986.2226865761045, 4009.7594144351433, 4022.658074063708, 3502.7372947029075, 3503.8248087595516, 3505.8247087645773, 3520.1727594015388, 3529.7176225901867, 4785.0, 4887.120318342697, 4957.876053098701, 4974.900501989976, 4976.601871850244, 4579.198640237978, 4580.679352445331, 4581.725096494188, 4587.151376995266, 4602.654800889946, 5299.920501192485, 5332.30680011596, 5337.759800808973, 5338.252644629755, 5341.065313570149, 3639.6906262967677, 3818.052793075524, 3841.1741475582603, 3843.4811300474357, 3910.5502867170353, 5511.641743286674, 5521.779128834842, 5546.417626149277, 5550.611457197998, 5553.805616803433, 3897.629725176104, 3904.355781296111, 3910.804459777, 3912.315344814703, 3919.2749341371937, 3896.08442016126, 3945.743526670757, 3952.980235098806, 3984.442178095069, 3998.7200895937003, 4513.5486451355255, 4527.298268768346, 4545.681752291798, 4546.931796023062, 4583.839565615254, 5386.165144402624, 5387.649802762808, 5408.107662235687, 5431.533485958769, 5441.727913604304, 1282.8460584729705, 1306.45129045801, 1359.2931675528866, 1368.1380730139947, 1385.7297826923652, 851.6891334662928, 857.9399442038997, 867.2324992381788, 874.8626785179368, 885.5395194498825, 4663.906721865544, 4672.766361681903, 4693.7653117344, 4699.929501057487, 4726.858194254178, 4698.906468817965, 4826.469088400273, 4887.535684110004, 4893.975530122327, 4907.631927605444, 4503.977480112579, 4542.409486766699, 4567.766702990174, 4585.747783871919, 4591.862244132682, 2563.9359016024378, 2576.4589436218603, 2576.690797104322, 2593.597992311195, 2645.148396122722, 4678.345031695565, 4963.607207621209, 4978.6017118630425, 4994.850154495371, 5004.799808007639, 4844.77822248201, 4851.56335929768, 4856.247281671346, 4901.970586176872, 4904.204603376042, 4929.229139708126, 4938.654294199371, 4944.505549445027, 4972.477889821589, 4983.6295018870105, 4616.192166370939, 4785.258284965836, 4793.9041219176115, 4809.422869255712, 4865.36750222483, 4825.0, 4831.492693267156, 4843.46721860588, 4849.80600775965, 4854.490278520704, 5040.924386134284, 5063.443021267732, 5079.2127220279435, 5087.771050302671, 5106.387233532, 3573.8927832165077, 3576.7496275260482, 3599.3521166190335, 3600.7839529628304, 3614.222942067363, 4528.932066018947, 4785.306130610972, 4809.206480930748, 4812.494688057844, 4819.445763737075, 4681.812727490862, 4690.882727931829, 4769.833055843029, 4791.592714619296, 4795.472498025145, 4689.413823272091, 4704.952950470589, 4722.834700785456, 4726.834560790356, 4746.19314716506, 4486.955130448654, 4583.358329833759, 4698.271767875985, 4709.293605959134, 4728.503507131702, 4744.240921452551, 4745.620350372031, 4775.761211939459, 4876.731779752005, 4893.339399181065, 4659.157913672725, 4665.4168228971375, 4678.251479763221, 4699.334519075127, 4740.2178640523925], "value": 3854.8079055446765, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.5154149802628, 749.9662515186816, 756.451572609858, 789.8499285135828, 821.6836517940591, 14636.268186590667, 15599.92200039001, 15681.451149209779, 15701.921490392531, 15702.450414235504, 13194.208347499156, 13317.667058323546, 13318.933405332984, 13331.53339633113, 13340.199588024701, 646.4117652935829, 663.5421559124189, 785.7171418289412, 796.5021861336664, 797.1351084073787, 767.244264399566, 793.4049462902823, 794.5510786405662, 803.3854101612271, 808.5108509351845, 863.063576020019, 864.9264812490945, 865.5888452984844, 865.7489328094845, 865.7748985263845, 680.7787469072571, 856.3662889461816, 860.6858496648741, 862.348926560446, 863.4085651328828, 511.289307862072, 590.0735844723786, 609.9420555047263, 615.704461858306, 616.3836163836164, 13949.651258718512, 13994.30028498571, 14003.0, 14015.369308381147, 14031.78952315716, 13294.601161965156, 13315.267660278681, 13331.266780327078, 13474.595762127152, 13749.0, 12185.32980686062, 12190.0, 12312.0, 12526.49682038152, 13137.934310328483, 4290.313549832012, 4329.588689074533, 4392.714473559208, 4432.335149727534, 4594.724316541018, 60156.69921650407, 61224.69387653078, 62432.06351904725, 62940.370596293906, 63484.365156348766, 10386.480675966322, 10436.165106791439, 10562.260641755158, 10603.72399771902, 10725.83911241332, 18685.0, 19753.604927901648, 19766.90116549408, 19789.0, 19807.405777826687, 7945.205479452125, 8053.07389650186, 8229.177082291722, 8232.917670823335, 8253.33973282136, 3811.313963486544, 3968.226195891831, 3995.5005624296964, 4010.19796040793, 4167.166566686675, 3327.8169700666213, 3399.5240666306736, 3412.84642191097, 3416.7095796857047, 3427.691507764313, 608.2184393054903, 616.9938300617026, 617.675720246874, 619.071392910634, 622.0482661527869, 683.3644710419259, 689.4312192441256, 699.2972063076576, 712.4727701500852, 731.6853752886203, 8387.538685372363, 8403.579821008925, 8458.661653533789, 8625.396222264506, 8824.8676269856, 680.7923583307139, 681.9590824550543, 682.5904457325664, 683.1153656015472, 703.7712743358429, 3874.244522318177, 4105.753654780723, 4134.289995732737, 4146.150039241948, 4263.931992983401, 65096.674516627114, 67013.3298667007, 68102.31897680959, 75413.622931885, 86209.56895215609, 42606.633421666535, 51672.741636291576, 67880.6605966967, 69309.30690693129, 70649.64675176694, 61084.69457652683, 62363.0, 63533.68233158897, 64225.0, 64486.35513644804, 7933.7702656088395, 8449.83100338002, 8455.915440845512, 8519.91480085216, 8583.313334933315, 41658.58341416547, 41794.37308440315, 43536.346954795066, 43788.781056094514, 44209.33685994648, 37947.81026094852, 56687.433125669864, 57065.42934570601, 57301.0, 58144.0, 10800.891991079989, 11113.944430277797, 11159.88840111621, 11208.10335173168, 11216.495257713586, 12618.87381126177, 12727.80908286358, 12830.807537887125, 12914.160579562298, 13000.08999370035, 10200.3369780964, 12024.879751202376, 12047.277163370225, 12482.812757808459, 12495.812562811747, 11785.351805650771, 12000.519979200733, 12028.218165819193, 12050.243353803682, 12438.440270188044, 12080.51677932908, 12127.454264558293, 12437.62687119388, 12465.626031219077, 12547.686307842378, 9172.266218702622, 9241.815163696823, 9364.978829302816, 10120.544575494268, 10211.744706382102, 9715.07706767856, 10075.899241007495, 10117.342372746043, 10200.795984080425, 10207.183425326104], "value": 6765.290099609837, "unit": "score"}], "name": "dromaeo_css", "value": 6886.853910277959, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0, 112.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 122.0, 121.0, 157.0, 129.0, 123.0, 123.0, 126.0, 162.0, 123.0], "value": 133.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 161.0, 161.0, 161.0, 163.0, 162.0, 164.0, 161.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 106.0, 77.0, 77.0, 77.0, 77.0, 108.0, 77.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 125.0, 81.0, 82.0, 82.0, 103.0, 81.0, 82.0, 113.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 145.0, 146.0, 145.0, 147.0, 145.0, 146.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 86.0, 85.0, 86.0, 85.0, 85.0, 85.0, 86.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 54.0, 52.0, 52.0, 54.0, 52.0, 55.0, 53.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 89.0, 85.0, 80.0, 79.0, 79.0, 80.0, 81.0, 80.0, 80.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 132.0, 131.0, 148.0, 136.0, 131.0, 131.0, 134.0, 175.0, 130.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 163.0, 163.0, 163.0, 163.0, 165.0, 164.0, 160.0, 167.0, 168.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 70.0, 64.0, 63.0, 64.0, 66.0, 63.0, 67.0, 63.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1489.8000000000002, "alertThreshold": 2.0}]} 09:08:26 INFO - Return code: 0 09:08:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:08:26 INFO - # TBPL SUCCESS # 09:08:26 INFO - Running post-action listener: _resource_record_post_action 09:08:26 INFO - [mozharness: 2016-10-30 16:08:26.153665Z] Finished run-tests step (success) 09:08:26 INFO - Running post-run listener: _resource_record_post_run 09:08:26 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 16384; Write bytes: 407609344; Read time: 392; Write time: 271608 09:08:26 INFO - TinderboxPrint: CPU usage
13.2% 09:08:26 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 392 09:08:26 INFO - TinderboxPrint: I/O write bytes / time
407,609,344 / 271,608 09:08:26 INFO - TinderboxPrint: CPU idle
8,285.0 (86.8%) 09:08:26 INFO - TinderboxPrint: CPU user
1,209.0 (12.7%) 09:08:26 INFO - TinderboxPrint: Swap in / out
0 / 0 09:08:26 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 120135680; Read time: 184; Write time: 88488 09:08:26 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287473664; Read time: 184; Write time: 183120 09:08:26 INFO - Running post-run listener: _upload_blobber_files 09:08:26 INFO - Blob upload gear active. 09:08:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:08:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:08:27 INFO - (blobuploader) - INFO - Open directory for files ... 09:08:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:08:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:08:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:27 INFO - (blobuploader) - INFO - Done attempting. 09:08:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:08:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:08:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:28 INFO - (blobuploader) - INFO - Done attempting. 09:08:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:08:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:08:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:32 INFO - (blobuploader) - INFO - Done attempting. 09:08:32 INFO - (blobuploader) - INFO - Iteration through files over. 09:08:32 INFO - Return code: 0 09:08:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:08:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:08:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c816f7973ee51cd713ec4b3248b0e594eb965efc6b64c5b29d3813fa9a99207ca4936b751d993264e778f2f1991262f29cf63bf4f1a26cee59d83b4e1aa995d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/db4e29989fba293ea3a0ccbe76f9825de6212f86266146b9e50603cb007733d8d7a28a250c637d5750f9850acea8359f322e5bb157398a33d6ee768d9bda8aaf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5e3be22b85a1adadcd97c85d8ee3c9729866b9640240f34ad2f4112cdd50bd7716b9488bfe831366e215b17aa63d88cef29fc5e28c353e75ce776abd1a1e62f1"} 09:08:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:08:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:08:32 INFO - Contents: 09:08:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c816f7973ee51cd713ec4b3248b0e594eb965efc6b64c5b29d3813fa9a99207ca4936b751d993264e778f2f1991262f29cf63bf4f1a26cee59d83b4e1aa995d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/db4e29989fba293ea3a0ccbe76f9825de6212f86266146b9e50603cb007733d8d7a28a250c637d5750f9850acea8359f322e5bb157398a33d6ee768d9bda8aaf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5e3be22b85a1adadcd97c85d8ee3c9729866b9640240f34ad2f4112cdd50bd7716b9488bfe831366e215b17aa63d88cef29fc5e28c353e75ce776abd1a1e62f1"} 09:08:32 INFO - Running post-run listener: copy_logs_to_upload_dir 09:08:32 INFO - Copying logs to upload dir... 09:08:32 INFO - mkdir: /builds/slave/test/build/upload/logs 09:08:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.484419 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-30 09:08:32.543372) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 09:08:32.546914) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066 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/c816f7973ee51cd713ec4b3248b0e594eb965efc6b64c5b29d3813fa9a99207ca4936b751d993264e778f2f1991262f29cf63bf4f1a26cee59d83b4e1aa995d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/db4e29989fba293ea3a0ccbe76f9825de6212f86266146b9e50603cb007733d8d7a28a250c637d5750f9850acea8359f322e5bb157398a33d6ee768d9bda8aaf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5e3be22b85a1adadcd97c85d8ee3c9729866b9640240f34ad2f4112cdd50bd7716b9488bfe831366e215b17aa63d88cef29fc5e28c353e75ce776abd1a1e62f1"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698454/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698454/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/c816f7973ee51cd713ec4b3248b0e594eb965efc6b64c5b29d3813fa9a99207ca4936b751d993264e778f2f1991262f29cf63bf4f1a26cee59d83b4e1aa995d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/db4e29989fba293ea3a0ccbe76f9825de6212f86266146b9e50603cb007733d8d7a28a250c637d5750f9850acea8359f322e5bb157398a33d6ee768d9bda8aaf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5e3be22b85a1adadcd97c85d8ee3c9729866b9640240f34ad2f4112cdd50bd7716b9488bfe831366e215b17aa63d88cef29fc5e28c353e75ce776abd1a1e62f1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 09:08:32.572463) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 09:08:32.572812) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1477842473.315753-149079066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 09:08:32.655416) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 09:08:32.655735) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 09:08:32.656045) ========= ========= Total master_lag: 0.17 =========