builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1480526524.07 results: success (0) buildid: 20161130092106 builduid: 63c09efc492d4df09afce9ca84f0ab70 revision: fcc2e4e18962ccd980f62e5d88f9426c363c1c9f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 09:22:04.075445) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 09:22:04.076208) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 09:22:04.076503) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 09:22:04.108798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 09:22:04.109333) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-30 09:22:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-11-30 09:22:04 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076482 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 09:22:04.203711) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 09:22:04.204162) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021661 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 09:22:04.255508) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-30 09:22:04.255905) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fcc2e4e18962ccd980f62e5d88f9426c363c1c9f --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 fcc2e4e18962ccd980f62e5d88f9426c363c1c9f --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=56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-30 09:22:04,416 truncating revision to first 12 chars 2016-11-30 09:22:04,416 Setting DEBUG logging. 2016-11-30 09:22:04,416 attempt 1/10 2016-11-30 09:22:04,416 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/fcc2e4e18962?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-30 09:22:05,800 unpacking tar archive at: mozilla-inbound-fcc2e4e18962/testing/mozharness/ program finished with exit code 0 elapsedTime=1.738321 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-30 09:22:06.008329) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 09:22:06.008684) ========= script_repo_revision: fcc2e4e18962ccd980f62e5d88f9426c363c1c9f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 09:22:06.009112) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 09:22:06.009449) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 09:22:06.020350) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-30 09:22:06.020982) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:22:06 INFO - MultiFileLogger online at 20161130 09:22:06 in /builds/slave/test 09:22:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:22:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:22:06 INFO - {'append_to_log': False, 09:22:06 INFO - 'base_work_dir': '/builds/slave/test', 09:22:06 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:22:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:22:06 INFO - 'branch': 'Mozilla-Inbound', 09:22:06 INFO - 'buildbot_json_path': 'buildprops.json', 09:22:06 INFO - 'config_files': ('talos/linux_config.py',), 09:22:06 INFO - 'default_actions': ('clobber', 09:22:06 INFO - 'read-buildbot-config', 09:22:06 INFO - 'download-and-extract', 09:22:06 INFO - 'populate-webroot', 09:22:06 INFO - 'create-virtualenv', 09:22:06 INFO - 'install', 09:22:06 INFO - 'run-tests'), 09:22:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:22:06 INFO - 'download_minidump_stackwalk': True, 09:22:06 INFO - 'download_symbols': 'ondemand', 09:22:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:22:06 INFO - 'tooltool.py': '/tools/tooltool.py', 09:22:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:22:06 INFO - '/tools/misc-python/virtualenv.py')}, 09:22:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:22:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:22:06 INFO - 'installer_path': 'installer.exe', 09:22:06 INFO - 'log_level': 'info', 09:22:06 INFO - 'log_name': 'talos', 09:22:06 INFO - 'log_to_console': True, 09:22:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:22:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:22:06 INFO - 'opt_config_files': (), 09:22:06 INFO - 'pip_index': False, 09:22:06 INFO - 'sps_profile': False, 09:22:06 INFO - 'sps_profile_interval': 0, 09:22:06 INFO - 'suite': 'dromaeojs-e10s', 09:22:06 INFO - 'system_bits': '32', 09:22:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:22:06 INFO - 'title': 'talos-linux64-ix-037', 09:22:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:22:06 INFO - 'use_talos_json': True, 09:22:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:22:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:22:06 INFO - 'work_dir': 'build'} 09:22:06 INFO - [mozharness: 2016-11-30 17:22:06.276488Z] Running clobber step. 09:22:06 INFO - Running pre-action listener: _resource_record_pre_action 09:22:06 INFO - Running main action method: clobber 09:22:06 INFO - rmtree: /builds/slave/test/build 09:22:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:22:06 INFO - Running post-action listener: _resource_record_post_action 09:22:06 INFO - [mozharness: 2016-11-30 17:22:06.738899Z] Finished clobber step (success) 09:22:06 INFO - [mozharness: 2016-11-30 17:22:06.738998Z] Running read-buildbot-config step. 09:22:06 INFO - Running pre-action listener: _resource_record_pre_action 09:22:06 INFO - Running main action method: read_buildbot_config 09:22:06 INFO - Using buildbot properties: 09:22:06 INFO - { 09:22:06 INFO - "project": "", 09:22:06 INFO - "product": "firefox", 09:22:06 INFO - "script_repo_revision": "production", 09:22:06 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 09:22:06 INFO - "repository": "", 09:22:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 09:22:06 INFO - "buildid": "20161130092106", 09:22:06 INFO - "stage_platform": "linux64-pgo", 09:22:06 INFO - "basedir": "/builds/slave/test", 09:22:06 INFO - "buildnumber": 2183, 09:22:06 INFO - "platform": "ubuntu64_hw", 09:22:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:22:06 INFO - "slavebuilddir": "test", 09:22:06 INFO - "branch": "mozilla-inbound", 09:22:06 INFO - "revision": "fcc2e4e18962ccd980f62e5d88f9426c363c1c9f", 09:22:06 INFO - "slavename": "talos-linux64-ix-037", 09:22:06 INFO - "builduid": "63c09efc492d4df09afce9ca84f0ab70", 09:22:06 INFO - "repo_path": "integration/mozilla-inbound" 09:22:06 INFO - } 09:22:06 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 09:22:06 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 09:22:06 INFO - Running post-action listener: _resource_record_post_action 09:22:06 INFO - [mozharness: 2016-11-30 17:22:06.741368Z] Finished read-buildbot-config step (success) 09:22:06 INFO - [mozharness: 2016-11-30 17:22:06.741456Z] Running download-and-extract step. 09:22:06 INFO - Running pre-action listener: _resource_record_pre_action 09:22:06 INFO - Running main action method: download_and_extract 09:22:06 INFO - mkdir: /builds/slave/test/build/tests 09:22: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')]} 09:22:06 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:22:06 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:22:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:22:06 INFO - Downloaded 1361 bytes. 09:22:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:22:06 INFO - Using the following test package requirements: 09:22:06 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 09:22:06 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:22:06 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:22:06 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:06 INFO - u'jsshell-linux-x86_64.zip'], 09:22:06 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:22:06 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 09:22:06 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:22:06 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:22:06 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:22:06 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:22:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:22:06 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/1480505403/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 09:22:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:22:06 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:22:06 INFO - Http code: 200 09:22:06 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 09:22:06 INFO - x-amz-cf-id: XiU1dRgmHbM1WzkLtXh6i61sU-mI4iKHqPsUa1kJ_jTei7yuqD2tCg== 09:22:06 INFO - x-amz-replication-status: COMPLETED 09:22:06 INFO - x-amz-version-id: PGy.voT7TUROTj2wwZlpk8ix3DjjOmqW 09:22:07 INFO - Expected file size: 21783183 09:22:07 INFO - Obtained file size: 21783183 09:22:11 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:22:11 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/1480505403/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 09:22:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:22:11 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:22:11 INFO - Http code: 200 09:22:11 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 09:22:11 INFO - x-amz-cf-id: TxDTuaVccikvPOFi56l401o-jcfxdilxmOyRHwMFadd-vrMDGXsrww== 09:22:11 INFO - x-amz-replication-status: COMPLETED 09:22:11 INFO - x-amz-version-id: PGy.voT7TUROTj2wwZlpk8ix3DjjOmqW 09:22:11 INFO - Expected file size: 21783183 09:22:11 INFO - Obtained file size: 21783183 09:22:15 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/1480505403/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 09:22:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:22:15 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:22:15 INFO - Http code: 200 09:22:15 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 09:22:15 INFO - x-amz-cf-id: 69sCcHWUAPBpqpAePVW6DNDyDeDntJOQG6JWI3_mP2XnhbTbxmAauw== 09:22:15 INFO - x-amz-replication-status: COMPLETED 09:22:15 INFO - x-amz-version-id: M41MZHZMwUOdx3tilZHyTSL_OGlfpoUn 09:22:16 INFO - Expected file size: 14409702 09:22:16 INFO - Obtained file size: 14409702 09:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:16 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:22:16 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:22:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:22:16 INFO - Downloaded 59776050 bytes. 09:22:16 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:22:16 INFO - mkdir: /builds/slave/test/properties 09:22:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:22:16 INFO - Writing to file /builds/slave/test/properties/build_url 09:22:16 INFO - Contents: 09:22:16 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:22:17 INFO - Running post-action listener: _resource_record_post_action 09:22:17 INFO - Running post-action listener: set_extra_try_arguments 09:22:17 INFO - [mozharness: 2016-11-30 17:22:17.063122Z] Finished download-and-extract step (success) 09:22:17 INFO - [mozharness: 2016-11-30 17:22:17.063351Z] Running populate-webroot step. 09:22:17 INFO - Running pre-action listener: _resource_record_pre_action 09:22:17 INFO - Running main action method: populate_webroot 09:22:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:22:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:22:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:22:17 INFO - '--tppagecycles', 09:22:17 INFO - '7'], 09:22:17 INFO - 'tests': ['tsvgm']}}, 09:22:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:22:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:22:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:22:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:22:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:22:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:22:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:22:17 INFO - 'talos_options': ['--disable-e10s'], 09:22:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:22:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:22:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:22:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:22:17 INFO - 'talos_options': ['--disable-e10s'], 09:22:17 INFO - 'tests': ['damp', 'tps']}, 09:22:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:22:17 INFO - 'tests': ['damp', 'tps']}, 09:22:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:22:17 INFO - 'tests': ['dromaeo_dom']}, 09:22:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:22:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:22:17 INFO - 'tests': ['basic_compositor_video']}, 09:22:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:22:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:22:17 INFO - 'tests': ['a11yr', 09:22:17 INFO - 'ts_paint', 09:22:17 INFO - 'tpaint', 09:22:17 INFO - 'sessionrestore', 09:22:17 INFO - 'sessionrestore_no_auto_restore', 09:22:17 INFO - 'tabpaint']}, 09:22:17 INFO - 'other-e10s': {'tests': ['a11yr', 09:22:17 INFO - 'ts_paint', 09:22:17 INFO - 'tpaint', 09:22:17 INFO - 'sessionrestore', 09:22:17 INFO - 'sessionrestore_no_auto_restore', 09:22:17 INFO - 'tabpaint']}, 09:22:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:22:17 INFO - 'ts_paint', 09:22:17 INFO - 'tpaint', 09:22:17 INFO - 'sessionrestore', 09:22:17 INFO - 'sessionrestore_no_auto_restore', 09:22:17 INFO - 'tabpaint']}, 09:22:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:22:17 INFO - 'ts_paint', 09:22:17 INFO - 'tpaint', 09:22:17 INFO - 'sessionrestore', 09:22:17 INFO - 'sessionrestore_no_auto_restore', 09:22:17 INFO - 'tabpaint']}, 09:22:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:22:17 INFO - 'tests': ['a11yr', 09:22:17 INFO - 'ts_paint', 09:22:17 INFO - 'tpaint', 09:22:17 INFO - 'sessionrestore', 09:22:17 INFO - 'sessionrestore_no_auto_restore', 09:22:17 INFO - 'tabpaint']}, 09:22:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:22:17 INFO - 'tests': ['a11yr', 09:22:17 INFO - 'ts_paint', 09:22:17 INFO - 'tpaint', 09:22:17 INFO - 'sessionrestore', 09:22:17 INFO - 'sessionrestore_no_auto_restore', 09:22:17 INFO - 'tabpaint']}, 09:22:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:22:17 INFO - 'tests': ['tsvgx', 09:22:17 INFO - 'tsvgr_opacity', 09:22:17 INFO - 'tart', 09:22:17 INFO - 'tscrollx', 09:22:17 INFO - 'cart', 09:22:17 INFO - 'tsvg_static']}, 09:22:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:22:17 INFO - 'tsvgr_opacity', 09:22:17 INFO - 'tart', 09:22:17 INFO - 'tscrollx', 09:22:17 INFO - 'cart', 09:22:17 INFO - 'tsvg_static']}, 09:22:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:22:17 INFO - 'talos_options': ['--disable-e10s'], 09:22:17 INFO - 'tests': ['tp5o']}, 09:22:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:22:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:22:17 INFO - 'talos_options': ['--disable-e10s', 09:22:17 INFO - '--xperf_path', 09:22:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:22:17 INFO - 'tests': ['tp5n']}, 09:22:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:22:17 INFO - 'talos_options': ['--xperf_path', 09:22:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:22:17 INFO - 'tests': ['tp5n']}}, 09:22:17 INFO - 'talos.zip': {'path': '', 09:22:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:22:17 INFO - Running post-action listener: _resource_record_post_action 09:22:17 INFO - [mozharness: 2016-11-30 17:22:17.082525Z] Finished populate-webroot step (success) 09:22:17 INFO - [mozharness: 2016-11-30 17:22:17.082613Z] Running create-virtualenv step. 09:22:17 INFO - Running pre-action listener: _resource_record_pre_action 09:22:17 INFO - Running main action method: create_virtualenv 09:22:17 INFO - Creating virtualenv /builds/slave/test/build/venv 09:22:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:22:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:22:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:22:17 INFO - Using real prefix '/usr' 09:22:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:22:17 INFO - Installing distribute.............................................................................................................................................................................................done. 09:22:19 INFO - Installing pip.................done. 09:22:19 INFO - Return code: 0 09:22:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:22:19 INFO - Reading from file tmpfile_stdout 09:22:19 INFO - Output received: 09:22:19 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:22:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:19 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 0x7ff407b6fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f3fc0>, '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 0x17f4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f5350>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:22:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:22:19 INFO - Using env: {'DISPLAY': ':0', 09:22:19 INFO - 'HOME': '/home/cltbld', 09:22:19 INFO - 'LANG': 'en_US.UTF-8', 09:22:19 INFO - 'LANGUAGE': 'en_US:en', 09:22:19 INFO - 'LOGNAME': 'cltbld', 09:22:19 INFO - 'MAIL': '/var/mail/cltbld', 09:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:19 INFO - 'MOZ_NO_REMOTE': '1', 09:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:19 INFO - 'NO_EM_RESTART': '1', 09:22:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:19 INFO - 'PWD': '/builds/slave/test', 09:22:19 INFO - 'SHELL': '/bin/bash', 09:22:19 INFO - 'SHLVL': '1', 09:22:19 INFO - 'TERM': 'linux', 09:22:19 INFO - 'TMOUT': '86400', 09:22:19 INFO - 'USER': 'cltbld', 09:22:19 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 09:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:19 INFO - '_': '/tools/buildbot/bin/python'} 09:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:22:20 INFO - Cleaning up... 09:22:20 INFO - Return code: 0 09:22:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:20 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 0x7ff407b6fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f3fc0>, '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 0x17f4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f5350>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:22:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:22:20 INFO - Using env: {'DISPLAY': ':0', 09:22:20 INFO - 'HOME': '/home/cltbld', 09:22:20 INFO - 'LANG': 'en_US.UTF-8', 09:22:20 INFO - 'LANGUAGE': 'en_US:en', 09:22:20 INFO - 'LOGNAME': 'cltbld', 09:22:20 INFO - 'MAIL': '/var/mail/cltbld', 09:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:20 INFO - 'MOZ_NO_REMOTE': '1', 09:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:20 INFO - 'NO_EM_RESTART': '1', 09:22:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:20 INFO - 'PWD': '/builds/slave/test', 09:22:20 INFO - 'SHELL': '/bin/bash', 09:22:20 INFO - 'SHLVL': '1', 09:22:20 INFO - 'TERM': 'linux', 09:22:20 INFO - 'TMOUT': '86400', 09:22:20 INFO - 'USER': 'cltbld', 09:22:20 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 09:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:20 INFO - '_': '/tools/buildbot/bin/python'} 09:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:20 INFO - Downloading/unpacking psutil>=3.1.1 09:22: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 09:22: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 09:22: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 09:22: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 09:22: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 09:22: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 09:22:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:22:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:22:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:22:22 INFO - Installing collected packages: psutil 09:22:22 INFO - Running setup.py install for psutil 09:22:22 INFO - building 'psutil._psutil_linux' extension 09:22:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:22:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:22:22 INFO - building 'psutil._psutil_posix' extension 09:22:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:22:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:22:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:22:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:22:22 INFO - Successfully installed psutil 09:22:22 INFO - Cleaning up... 09:22:22 INFO - Return code: 0 09:22:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:22 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 0x7ff407b6fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f3fc0>, '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 0x17f4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f5350>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:22:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:22:22 INFO - Using env: {'DISPLAY': ':0', 09:22:22 INFO - 'HOME': '/home/cltbld', 09:22:22 INFO - 'LANG': 'en_US.UTF-8', 09:22:22 INFO - 'LANGUAGE': 'en_US:en', 09:22:22 INFO - 'LOGNAME': 'cltbld', 09:22:22 INFO - 'MAIL': '/var/mail/cltbld', 09:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:22 INFO - 'MOZ_NO_REMOTE': '1', 09:22:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:22 INFO - 'NO_EM_RESTART': '1', 09:22:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:22 INFO - 'PWD': '/builds/slave/test', 09:22:22 INFO - 'SHELL': '/bin/bash', 09:22:22 INFO - 'SHLVL': '1', 09:22:22 INFO - 'TERM': 'linux', 09:22:22 INFO - 'TMOUT': '86400', 09:22:22 INFO - 'USER': 'cltbld', 09:22:22 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 09:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:22 INFO - '_': '/tools/buildbot/bin/python'} 09:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:22:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:22:25 INFO - Installing collected packages: mozsystemmonitor 09:22:25 INFO - Running setup.py install for mozsystemmonitor 09:22:25 INFO - Successfully installed mozsystemmonitor 09:22:25 INFO - Cleaning up... 09:22:25 INFO - Return code: 0 09:22:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:22:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff407b6fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f3fc0>, '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 0x17f4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f5350>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:22:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:22:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:22:25 INFO - Using env: {'DISPLAY': ':0', 09:22:25 INFO - 'HOME': '/home/cltbld', 09:22:25 INFO - 'LANG': 'en_US.UTF-8', 09:22:25 INFO - 'LANGUAGE': 'en_US:en', 09:22:25 INFO - 'LOGNAME': 'cltbld', 09:22:25 INFO - 'MAIL': '/var/mail/cltbld', 09:22:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:25 INFO - 'MOZ_NO_REMOTE': '1', 09:22:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:25 INFO - 'NO_EM_RESTART': '1', 09:22:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:25 INFO - 'PWD': '/builds/slave/test', 09:22:25 INFO - 'SHELL': '/bin/bash', 09:22:25 INFO - 'SHLVL': '1', 09:22:25 INFO - 'TERM': 'linux', 09:22:25 INFO - 'TMOUT': '86400', 09:22:25 INFO - 'USER': 'cltbld', 09:22:25 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 09:22:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:25 INFO - '_': '/tools/buildbot/bin/python'} 09:22:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:25 INFO - Downloading/unpacking jsonschema==2.5.1 09:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:22:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:27 INFO - Downloading functools32-3.2.3-2.tar.gz 09:22:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:22:27 INFO - warning: no files found matching '*.txt' 09:22:27 INFO - no previously-included directories found matching 'build' 09:22:27 INFO - no previously-included directories found matching 'dist' 09:22:27 INFO - no previously-included directories found matching '.git*' 09:22:27 INFO - Installing collected packages: jsonschema, functools32 09:22:27 INFO - Running setup.py install for functools32 09:22:27 INFO - warning: no files found matching '*.txt' 09:22:27 INFO - no previously-included directories found matching 'build' 09:22:27 INFO - no previously-included directories found matching 'dist' 09:22:27 INFO - no previously-included directories found matching '.git*' 09:22:27 INFO - Successfully installed jsonschema functools32 09:22:27 INFO - Cleaning up... 09:22:27 INFO - Return code: 0 09:22:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:27 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 0x7ff407b6fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f3fc0>, '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 0x17f4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f5350>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:22:27 INFO - Using env: {'DISPLAY': ':0', 09:22:27 INFO - 'HOME': '/home/cltbld', 09:22:27 INFO - 'LANG': 'en_US.UTF-8', 09:22:27 INFO - 'LANGUAGE': 'en_US:en', 09:22:27 INFO - 'LOGNAME': 'cltbld', 09:22:27 INFO - 'MAIL': '/var/mail/cltbld', 09:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:27 INFO - 'MOZ_NO_REMOTE': '1', 09:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:27 INFO - 'NO_EM_RESTART': '1', 09:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:27 INFO - 'PWD': '/builds/slave/test', 09:22:27 INFO - 'SHELL': '/bin/bash', 09:22:27 INFO - 'SHLVL': '1', 09:22:27 INFO - 'TERM': 'linux', 09:22:27 INFO - 'TMOUT': '86400', 09:22:27 INFO - 'USER': 'cltbld', 09:22:27 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 09:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:27 INFO - '_': '/tools/buildbot/bin/python'} 09:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:22:28 INFO - Cleaning up... 09:22:28 INFO - Return code: 0 09:22:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:22: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')]} 09:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22: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')]} 09:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22: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', '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 0x7ff407b6fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f3fc0>, '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 0x17f4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f5350>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:22: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:22: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 blobuploader==1.2.4 09:22:28 INFO - Using env: {'DISPLAY': ':0', 09:22:28 INFO - 'HOME': '/home/cltbld', 09:22:28 INFO - 'LANG': 'en_US.UTF-8', 09:22:28 INFO - 'LANGUAGE': 'en_US:en', 09:22:28 INFO - 'LOGNAME': 'cltbld', 09:22:28 INFO - 'MAIL': '/var/mail/cltbld', 09:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:28 INFO - 'MOZ_NO_REMOTE': '1', 09:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:28 INFO - 'NO_EM_RESTART': '1', 09:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:28 INFO - 'PWD': '/builds/slave/test', 09:22:28 INFO - 'SHELL': '/bin/bash', 09:22:28 INFO - 'SHLVL': '1', 09:22:28 INFO - 'TERM': 'linux', 09:22:28 INFO - 'TMOUT': '86400', 09:22:28 INFO - 'USER': 'cltbld', 09:22:28 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 09:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:28 INFO - '_': '/tools/buildbot/bin/python'} 09:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:28 INFO - Downloading/unpacking blobuploader==1.2.4 09:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:30 INFO - Downloading blobuploader-1.2.4.tar.gz 09:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:22:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:22:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:31 INFO - Downloading docopt-0.6.1.tar.gz 09:22:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:22:31 INFO - Installing collected packages: blobuploader, requests, docopt 09:22:31 INFO - Running setup.py install for blobuploader 09:22:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:22:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:22:31 INFO - Running setup.py install for requests 09:22:31 INFO - Running setup.py install for docopt 09:22:31 INFO - Successfully installed blobuploader requests docopt 09:22:31 INFO - Cleaning up... 09:22:31 INFO - Return code: 0 09:22:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:31 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 0x7ff407b6fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f3fc0>, '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 0x17f4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f5350>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:22:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:22:31 INFO - Using env: {'DISPLAY': ':0', 09:22:31 INFO - 'HOME': '/home/cltbld', 09:22:31 INFO - 'LANG': 'en_US.UTF-8', 09:22:31 INFO - 'LANGUAGE': 'en_US:en', 09:22:31 INFO - 'LOGNAME': 'cltbld', 09:22:31 INFO - 'MAIL': '/var/mail/cltbld', 09:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:31 INFO - 'MOZ_NO_REMOTE': '1', 09:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:31 INFO - 'NO_EM_RESTART': '1', 09:22:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:31 INFO - 'PWD': '/builds/slave/test', 09:22:31 INFO - 'SHELL': '/bin/bash', 09:22:31 INFO - 'SHLVL': '1', 09:22:31 INFO - 'TERM': 'linux', 09:22:31 INFO - 'TMOUT': '86400', 09:22:31 INFO - 'USER': 'cltbld', 09:22:31 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 09:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:31 INFO - '_': '/tools/buildbot/bin/python'} 09:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:22:31 INFO - Running setup.py (path:/tmp/pip-BHXpYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:22:32 INFO - Running setup.py (path:/tmp/pip-KVcVYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:22:32 INFO - Running setup.py (path:/tmp/pip-NmMu8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:22:32 INFO - Running setup.py (path:/tmp/pip-OwHV2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:22:32 INFO - Running setup.py (path:/tmp/pip-9vZs8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:22:32 INFO - Running setup.py (path:/tmp/pip-iPqIa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:22:32 INFO - Running setup.py (path:/tmp/pip-fR9IoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:22:32 INFO - Running setup.py (path:/tmp/pip-WGNczK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:22:32 INFO - Running setup.py (path:/tmp/pip-RXH975-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:22:32 INFO - Running setup.py (path:/tmp/pip-2y0zHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:22:32 INFO - Running setup.py (path:/tmp/pip-tQUYl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:22:32 INFO - Running setup.py (path:/tmp/pip-GNmsk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:22:32 INFO - Running setup.py (path:/tmp/pip-nvt_ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:22:32 INFO - Running setup.py (path:/tmp/pip-KCerlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:33 INFO - Running setup.py (path:/tmp/pip-ZAn66h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:22:33 INFO - Running setup.py (path:/tmp/pip-XW0EIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:22:33 INFO - Running setup.py (path:/tmp/pip-NN14nB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:22:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:22:33 INFO - Running setup.py install for manifestparser 09:22:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:22:33 INFO - Running setup.py install for mozcrash 09:22:33 INFO - Running setup.py install for mozdebug 09:22:33 INFO - Running setup.py install for mozdevice 09:22:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:22:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:22:33 INFO - Running setup.py install for mozfile 09:22:33 INFO - Running setup.py install for mozhttpd 09:22:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:22:33 INFO - Running setup.py install for mozinfo 09:22:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:22:33 INFO - Running setup.py install for mozInstall 09:22:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:22:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:22:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:22:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:22:34 INFO - Running setup.py install for mozleak 09:22:34 INFO - Running setup.py install for mozlog 09:22:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:22:34 INFO - Running setup.py install for moznetwork 09:22:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:22:34 INFO - Running setup.py install for mozprocess 09:22:34 INFO - Running setup.py install for mozprofile 09:22:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:22:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:22:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:22:34 INFO - Running setup.py install for mozrunner 09:22:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:22:34 INFO - Running setup.py install for mozscreenshot 09:22:34 INFO - Running setup.py install for moztest 09:22:34 INFO - Running setup.py install for mozversion 09:22:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:22:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:22:35 INFO - Cleaning up... 09:22:35 INFO - Return code: 0 09:22:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:35 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 0x7ff407b6fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f3fc0>, '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 0x17f4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f5350>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:22:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:22:35 INFO - Using env: {'DISPLAY': ':0', 09:22:35 INFO - 'HOME': '/home/cltbld', 09:22:35 INFO - 'LANG': 'en_US.UTF-8', 09:22:35 INFO - 'LANGUAGE': 'en_US:en', 09:22:35 INFO - 'LOGNAME': 'cltbld', 09:22:35 INFO - 'MAIL': '/var/mail/cltbld', 09:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:35 INFO - 'MOZ_NO_REMOTE': '1', 09:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:35 INFO - 'NO_EM_RESTART': '1', 09:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:35 INFO - 'PWD': '/builds/slave/test', 09:22:35 INFO - 'SHELL': '/bin/bash', 09:22:35 INFO - 'SHLVL': '1', 09:22:35 INFO - 'TERM': 'linux', 09:22:35 INFO - 'TMOUT': '86400', 09:22:35 INFO - 'USER': 'cltbld', 09:22:35 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 09:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:35 INFO - '_': '/tools/buildbot/bin/python'} 09:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:22:35 INFO - Running setup.py (path:/tmp/pip-YfXG7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:22:35 INFO - Running setup.py (path:/tmp/pip-AxDFpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:22:35 INFO - Running setup.py (path:/tmp/pip-O_4SYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:22:35 INFO - Running setup.py (path:/tmp/pip-c3mCfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:22:35 INFO - Running setup.py (path:/tmp/pip-Rru5xF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:22:35 INFO - Running setup.py (path:/tmp/pip-Lql1S3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:22:35 INFO - Running setup.py (path:/tmp/pip-Bl3mYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:22:35 INFO - Running setup.py (path:/tmp/pip-FPxXx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:22:35 INFO - Running setup.py (path:/tmp/pip-NuKJU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:22:35 INFO - Running setup.py (path:/tmp/pip-4YplYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:22:35 INFO - Running setup.py (path:/tmp/pip-tffeEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:22:36 INFO - Running setup.py (path:/tmp/pip-GQFRyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:22:36 INFO - Running setup.py (path:/tmp/pip-gAXNaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:22:36 INFO - Running setup.py (path:/tmp/pip-kXyrOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:36 INFO - Running setup.py (path:/tmp/pip-HkZICt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:22:36 INFO - Running setup.py (path:/tmp/pip-pTr9C9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:22:36 INFO - Running setup.py (path:/tmp/pip-xWIdlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:22:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:38 INFO - Downloading blessings-1.6.tar.gz 09:22:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:22:38 INFO - Installing collected packages: blessings 09:22:38 INFO - Running setup.py install for blessings 09:22:38 INFO - Successfully installed blessings 09:22:38 INFO - Cleaning up... 09:22:38 INFO - Return code: 0 09:22:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:22:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:22:38 INFO - Reading from file tmpfile_stdout 09:22:38 INFO - Current package versions: 09:22:38 INFO - argparse == 1.2.1 09:22:38 INFO - blessings == 1.6 09:22:38 INFO - blobuploader == 1.2.4 09:22:38 INFO - docopt == 0.6.1 09:22:38 INFO - functools32 == 3.2.3-2 09:22:38 INFO - jsonschema == 2.5.1 09:22:38 INFO - manifestparser == 1.1 09:22:38 INFO - mozInstall == 1.12 09:22:38 INFO - mozcrash == 1.0 09:22:38 INFO - mozdebug == 0.1 09:22:38 INFO - mozdevice == 0.49 09:22:38 INFO - mozfile == 1.2 09:22:38 INFO - mozhttpd == 0.7 09:22:38 INFO - mozinfo == 0.9 09:22:38 INFO - mozleak == 0.1 09:22:38 INFO - mozlog == 3.4 09:22:38 INFO - moznetwork == 0.27 09:22:38 INFO - mozprocess == 0.23 09:22:38 INFO - mozprofile == 0.28 09:22:38 INFO - mozrunner == 6.13 09:22:38 INFO - mozscreenshot == 0.1 09:22:38 INFO - mozsystemmonitor == 0.3 09:22:38 INFO - moztest == 0.7 09:22:38 INFO - mozversion == 1.4 09:22:38 INFO - psutil == 3.1.1 09:22:38 INFO - requests == 1.2.3 09:22:38 INFO - wsgiref == 0.1.2 09:22:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:38 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 0x7ff407b6fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f3fc0>, '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 0x17f4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f5350>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:22:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:22:38 INFO - Using env: {'DISPLAY': ':0', 09:22:38 INFO - 'HOME': '/home/cltbld', 09:22:38 INFO - 'LANG': 'en_US.UTF-8', 09:22:38 INFO - 'LANGUAGE': 'en_US:en', 09:22:38 INFO - 'LOGNAME': 'cltbld', 09:22:38 INFO - 'MAIL': '/var/mail/cltbld', 09:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:38 INFO - 'MOZ_NO_REMOTE': '1', 09:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:38 INFO - 'NO_EM_RESTART': '1', 09:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:38 INFO - 'PWD': '/builds/slave/test', 09:22:38 INFO - 'SHELL': '/bin/bash', 09:22:38 INFO - 'SHLVL': '1', 09:22:38 INFO - 'TERM': 'linux', 09:22:38 INFO - 'TMOUT': '86400', 09:22:38 INFO - 'USER': 'cltbld', 09:22:38 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 09:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:38 INFO - '_': '/tools/buildbot/bin/python'} 09:22:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:22:39 INFO - Cleaning up... 09:22:39 INFO - Return code: 0 09:22:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:39 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 0x7ff407b6fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f3fc0>, '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 0x17f4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f5350>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:22:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:22:39 INFO - Using env: {'DISPLAY': ':0', 09:22:39 INFO - 'HOME': '/home/cltbld', 09:22:39 INFO - 'LANG': 'en_US.UTF-8', 09:22:39 INFO - 'LANGUAGE': 'en_US:en', 09:22:39 INFO - 'LOGNAME': 'cltbld', 09:22:39 INFO - 'MAIL': '/var/mail/cltbld', 09:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:39 INFO - 'MOZ_NO_REMOTE': '1', 09:22:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:39 INFO - 'NO_EM_RESTART': '1', 09:22:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:39 INFO - 'PWD': '/builds/slave/test', 09:22:39 INFO - 'SHELL': '/bin/bash', 09:22:39 INFO - 'SHLVL': '1', 09:22:39 INFO - 'TERM': 'linux', 09:22:39 INFO - 'TMOUT': '86400', 09:22:39 INFO - 'USER': 'cltbld', 09:22:39 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 09:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:39 INFO - '_': '/tools/buildbot/bin/python'} 09:22:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:22:39 INFO - Cleaning up... 09:22:39 INFO - Return code: 0 09:22:39 INFO - Running post-action listener: _resource_record_post_action 09:22:39 INFO - Running post-action listener: _start_resource_monitoring 09:22:39 INFO - Starting resource monitoring. 09:22:39 INFO - [mozharness: 2016-11-30 17:22:39.409611Z] Finished create-virtualenv step (success) 09:22:39 INFO - [mozharness: 2016-11-30 17:22:39.410086Z] Running install step. 09:22:39 INFO - Running pre-action listener: _resource_record_pre_action 09:22:39 INFO - Running main action method: install 09:22:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:22:39 INFO - Reading from file tmpfile_stdout 09:22:39 INFO - Detecting whether we're running mozinstall >=1.0... 09:22:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:22:39 INFO - Reading from file tmpfile_stdout 09:22:39 INFO - Output received: 09:22:39 INFO - Usage: mozinstall [options] installer 09:22:39 INFO - Options: 09:22:39 INFO - -h, --help show this help message and exit 09:22:39 INFO - -d DEST, --destination=DEST 09:22:39 INFO - Directory to install application into. [default: 09:22:39 INFO - "/builds/slave/test"] 09:22:39 INFO - --app=APP Application being installed. [default: firefox] 09:22:39 INFO - mkdir: /builds/slave/test/build/application 09:22:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:22:56 INFO - Reading from file tmpfile_stdout 09:22:56 INFO - Output received: 09:22:56 INFO - /builds/slave/test/build/application/firefox/firefox 09:22:56 INFO - Running post-action listener: _resource_record_post_action 09:22:56 INFO - [mozharness: 2016-11-30 17:22:56.691920Z] Finished install step (success) 09:22:56 INFO - [mozharness: 2016-11-30 17:22:56.692195Z] Running run-tests step. 09:22:56 INFO - Running pre-action listener: _resource_record_pre_action 09:22:56 INFO - Running main action method: run_tests 09:22:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:22:56 INFO - Python 2.7.3 09:22:56 INFO - Return code: 0 09:22:56 INFO - grabbing minidump binary from tooltool 09:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:56 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 0x17f3fc0>, '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 0x17f4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f5350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:22:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:22:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:22:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:22:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:22:56 INFO - Return code: 0 09:22:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:22:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:22:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:22:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:22:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:22:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:22:56 INFO - Using env: {'DISPLAY': ':0', 09:22:56 INFO - 'HOME': '/home/cltbld', 09:22:56 INFO - 'LANG': 'en_US.UTF-8', 09:22:56 INFO - 'LANGUAGE': 'en_US:en', 09:22:56 INFO - 'LOGNAME': 'cltbld', 09:22:56 INFO - 'MAIL': '/var/mail/cltbld', 09:22:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:22:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:56 INFO - 'MOZ_NO_REMOTE': '1', 09:22:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:56 INFO - 'NO_EM_RESTART': '1', 09:22:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:56 INFO - 'PWD': '/builds/slave/test', 09:22:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:22:56 INFO - 'SHELL': '/bin/bash', 09:22:56 INFO - 'SHLVL': '1', 09:22:56 INFO - 'TERM': 'linux', 09:22:56 INFO - 'TMOUT': '86400', 09:22:56 INFO - 'USER': 'cltbld', 09:22:56 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070', 09:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:56 INFO - '_': '/tools/buildbot/bin/python'} 09:22:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:22:56 INFO - mozversion application_buildid: 20161130033003 09:22:56 INFO - mozversion application_changeset: fcc2e4e18962ccd980f62e5d88f9426c363c1c9f 09:22:56 INFO - mozversion application_display_name: Nightly 09:22:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:22:56 INFO - mozversion application_name: Firefox 09:22:56 INFO - mozversion application_remotingname: firefox 09:22:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:22:56 INFO - mozversion application_vendor: Mozilla 09:22:56 INFO - mozversion application_version: 53.0a1 09:22:56 INFO - mozversion platform_buildid: 20161130033003 09:22:56 INFO - mozversion platform_changeset: fcc2e4e18962ccd980f62e5d88f9426c363c1c9f 09:22:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:22:56 INFO - mozversion platform_version: 53.0a1 09:22:56 INFO - using testdate: 1480526576 09:22:56 INFO - actual date: 1480526576 09:22:56 INFO - starting webserver on 'localhost:44362' 09:22:56 INFO - SUITE-START | Running 2 tests 09:22:56 INFO - TEST-START | dromaeo_css 09:22:56 INFO - operating with platform_type : linux_ 09:22:56 INFO - Initialising browser for dromaeo_css test... 09:22:56 INFO - TEST-INFO | started process 9010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW20zqe/profile http://localhost:44362/getInfo.html) 09:23:01 INFO - PROCESS | 9010 | __metrics Screen width/height:1600/1200 09:23:01 INFO - PROCESS | 9010 | colorDepth:24 09:23:01 INFO - PROCESS | 9010 | Browser inner width/height: 1024/697 09:23:01 INFO - PROCESS | 9010 | __metrics 09:23:01 ERROR - PROCESS | 9010 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 09:23:02 INFO - TEST-INFO | 9010: exit 0 09:23:02 INFO - Browser initialized. 09:23:02 INFO - Running cycle 1/1 for dromaeo_css test... 09:23:02 INFO - TEST-INFO | started process 9133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW20zqe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:23:14 INFO - PROCESS | 9133 | RSS: Main: 186343424 09:23:14 INFO - PROCESS | 9133 | 09:24:04 INFO - PROCESS | 9133 | 1480526644590 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] 09:26:16 INFO - PROCESS | 9133 | Cycle 1(1): loaded http://localhost:44362/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44362/tests/dromaeo/cssquery-ext.html) 09:26:17 INFO - PROCESS | 9133 | RSS: Main: 198463488 09:26:17 INFO - PROCESS | 9133 | 09:29:20 INFO - PROCESS | 9133 | Cycle 1(1): loaded http://localhost:44362/tests/dromaeo/cssquery-ext.html (next: http://localhost:44362/tests/dromaeo/cssquery-jquery.html) 09:29:20 INFO - PROCESS | 9133 | RSS: Main: 196898816 09:29:20 INFO - PROCESS | 9133 | 09:32:22 INFO - PROCESS | 9133 | Cycle 1(1): loaded http://localhost:44362/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44362/tests/dromaeo/cssquery-mootools.html) 09:32:23 INFO - PROCESS | 9133 | RSS: Main: 198598656 09:32:23 INFO - PROCESS | 9133 | 09:35:25 INFO - PROCESS | 9133 | Cycle 1(1): loaded http://localhost:44362/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44362/tests/dromaeo/cssquery-prototype.html) 09:35:25 INFO - PROCESS | 9133 | RSS: Main: 195727360 09:35:25 INFO - PROCESS | 9133 | 09:38:28 INFO - PROCESS | 9133 | Cycle 1(1): loaded http://localhost:44362/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44362/tests/dromaeo/cssquery-yui.html) 09:38:29 INFO - PROCESS | 9133 | RSS: Main: 199426048 09:38:29 INFO - PROCESS | 9133 | 09:41:32 INFO - PROCESS | 9133 | Cycle 1(1): loaded http://localhost:44362/tests/dromaeo/cssquery-yui.html (next: http://localhost:44362/tests/dromaeo/cssquery-dojo.html) 09:41:32 INFO - PROCESS | 9133 | RSS: Main: 199368704 09:41:32 INFO - PROCESS | 9133 | 09:41:32 INFO - PROCESS | 9133 | __start_tp_report 09:41:32 INFO - PROCESS | 9133 | _x_x_mozilla_page_load 09:41:32 INFO - PROCESS | 9133 | _x_x_mozilla_page_load_details 09:41:32 INFO - PROCESS | 9133 | |i|pagename|runs| 09:41:32 INFO - PROCESS | 9133 | |0;dojo.html;3154.70030347117;3163.43058249515;3165.3985742708883;3200.3119329344186;3211.2453573410257;5304.124819404794;5423.4034256231835;5463.644863083901;5477.370102438221;5481.945180548193;5385.865353366168;5441.564674826014;5520.503154716075;5552.278203833496;5619.4942455179025;4960.454350021495;4969.503049695038;5038.093143234217;5056.595472362203;5086.186210206368;4938.456769755342;5060.620453465986;5183.559397451221;5188.195829646411;5209.531142197202;4888.560029597318;5098.97450512745;5122.257272695439;5136.332276804011;5168.9224661630105;4901.803927842882;4975.203967365241;5002.849914502534;5029.220470827027;5100.183970564692;4964.900701985976;4973.204287314013;4975.651704380694;5002.224655178453;5005.674631148963;5469.316335458067;5507.642003269774;5514.6139770216105;5525.171224316345;5530.281063461724;5721.828345149652;5743.310802703702;5754.424557544254;5838.065909454509;5841.4450627190345;5886.7939622113445;5904.881902361929;5908.734106965197;5908.911366329508;5911.970440147772;5429.077056900336;5465.836024919259;5505.559555235572;5529.557635389159;5608.439156084359;6036.9698151508965;6059.121427393004;6089.756409743649;6103.542234332354;6108.633481991094;5858.677772722456;5862.677552734555;5864.882702345929;5868.9706551467825;5870.823875283749;5688.488036076773;5702.714864256771;5715.942840571541;5800.8259752207505;5810.244668193108;5708.71456427177;5743.885122297531;5773.566982476331;5795;5811.593188476851;5840.766369345263;5851.824445266649;5871.882562348729;5874.559408044413;5925.555583331267;4495.370648109268;4507;4509.706869053501;4510.887227819265;4547.363369128325;3937.7440466369594;3969;4018.778967156776;4025.295573274665;4028.9597104028585;5685.630434021776;5693;5702.914456283159;5704.058830293038;5719.971400143056;5947.821565353046;5994.280686317583;6013.939860601338;6015.488683461955;6015.939840601538;5362.892742145135;5407.107827208467;5416.160495123183;5606.327240731139;5662.5753068520025;5010.2735103409805;5095.031943930641;5113.897722045613;5116.641835071584;5159.484051594885;6164.7842325518395;6176.197094377792;6179.258488981351;6179.320274769681;6181.196444462281;5914.290285165635;5953.851153721192;5955.702214889152;5961.940380596138;5971.104334349882;5855.59010869235;5902.1441890926435;5904.261967254093;5965.224520812267;5986.580939334205;5732.828015159552;5870.236869206976;5876.764929402776;5878;5936.1689363488285;5630.352509461464;5709.800156994485;5710.943475457054;5780;5793.826185214451;5683.460071293221;5710.486056254957;5749.13762935563;5776.537876969916;5832.679202643895;5722.570807189394;5754.683492407958;5762.567807414544;5781.392953739965;5783.045797443543;5522.5858060644805;5540.695261760642;5550.27846379968;5628.324601047737;5716.085426331767;5731.971340143273;5817.680027598522;5822.563307752021;5863.296404431496;5867.794627188028;5664.546836253007;5669.6314739541795;5673.347565030074;5695.544356451557;5704.3154821421695 09:41:32 INFO - PROCESS | 9133 | |1;ext.html;553.5903431460719;559.1138046196778;572.3789688188318;581.9796307129249;592.1000079878582;32097.19757006076;33860.15349616261;41638.791806040965;42592.361114583306;42608.360874586826;42343.78828105855;42884.356734649;42947;43014.78492607533;43075.13849723004;8610.182032706914;8744.081871403507;8780.868286975701;8790.428622139572;8798;8513.276371508398;10141.543630536644;10401.37591744494;10430.63492777753;10641.467926603678;10391.480425978709;10447.320924139907;10453.320534165294;10485.213608979318;10491.947540262288;10212.2851400402;10250.282480226424;10251.48742562869;10253;10350.068493835515;10225.233107516966;10313.484325783757;10333.276670633059;10378.169746420268;10394.688159355232;39602;39673;39871;39877.80061099676;39957;3424.434968230239;3440.3807314683345;3445.207602251471;3488.982555087234;3573.249617580311;29633.851830740707;30102.096937091923;30537.541936870966;30625.846870765727;31506.80137777264;3994.900127496807;4117.75293482392;4169.541350451448;4212;4254.489461264637;333560;338320;341455;341554;342965;58118.41881581215;58230.4176958225;58316.12525812116;58348;58684.41315586789;60534.0919886202;60649.69675151596;60753;60785;61145;15379.384824607114;15848.68302633941;15859;15870.20648967547;15928.76106858398;12100.57647982334;12103.697407564881;12183.939080304543;12208.633740987785;12307.20003199789;18322.541936451697;18549.81450185508;18657.346992855455;18844.15201315944;18858.52853678669;6730.629815360105;6844.691988860513;7000.299970002959;7053.612051337226;7082.362587367059;862.2584577263548;934.1825902335456;971.2327261463506;1084.5011294804478;1138.6242539961793;30280;31122.84438577838;31163.376732465225;31480;31637.84181079126;1074.9677509674723;1090.4057288777635;1104.8511741536718;1155.5493357590547;1162.9823904083926;15889.52331430059;16246.75629865553;16526.83473165277;16592.2533485991;16789.41237056697;483584;493998;494912;495030;495509;54906.72546637321;55798;55840.720796395755;55893;55945;1290.851552071505;1306.8366454193226;1351.216294549159;1355.728854229158;1362.1010133311966;29479.26301842471;30280.84859575776;30715.539266910568;31208.531872021485;31488.685113148575;43984;44254.11491770211;44583.77708111569;44723;44741.77629111834;414654.2672866405;414774;416063;416105;417384.82615174673;24273.878630606734;25104.37239069038;26100.869495653158;27243.455130897666;27258.318542036606;42672;43027.63819095512;43468.56531434645;43921.34117988169;44278.77860610676;36266.81866590756;36672.449913251854;37080.44379334258;37124.44313335356;37304.44043339298;36986;37085.25829483341;37099.62900370962;37562.624373757004;38284;36775.448368275036;37170.07074823151;37423;37525.6247437533;37906.620933790306;31743;33723.32553348968;34308.14229644279;34427.65572344245;34461.79383721558;25980.22059338223;26457.735422645528;26536.601950970366;26738;26776.7322326782 09:41:32 INFO - PROCESS | 9133 | |2;jquery.html;369.735639018102;370.5830940192282;375.70507151885766;379.70003697079306;396.34602905206407;18025.549361265974;18072.18675159618;18430.539236519093;18681.906590467046;18830.43508694738;11664.183507154503;12029.278243305407;12030.398480076004;12072.2756634602;12072.879271207285;4906.803727850882;5264.236685680574;5306.6550674206055;5308.460546441546;5310.176922576988;5179.067767801795;5388.164834450647;5705.942940570603;5735.2544169257935;5774.971125144369;5726.112452569859;5738.8278351649515;5746.454086861741;5765.509931655814;5786.479216870481;5560.388357280696;5687.6303040302455;5736.397678243766;5747.683877386742;5763.279590051244;4988.575971042465;5561.165825126223;5566.165075238706;5569.805056822992;5571.944280557183;12764.170328928683;13299.601011969657;13418.932905335509;13439.529616463376;13442.596722098255;2330.6620540021772;2348.2602980061224;2382.1900553811615;2440.060576677974;2565.4227798745133;9357.953210233973;9680.806383872354;9681.70954871355;10174.236932230038;10408.739781505446;1853.898035608041;1860.6278744251204;1928.9294441584914;1932.3236867096543;1958.9510262243416;77958.61020694918;82801.17198827995;83761;85333.57333213295;86459.56770216172;10193.184545236512;10220.795584088277;10629.4153821539;10663.680089597325;10740.409277489656;14911.478098266509;14930.40278388874;14955.775663365059;15013.249337533298;15088.924555377153;7438.256174382626;7590.962045189739;7741.148473667892;7990.960045199853;8024;7645.923540764632;7693.346065584488;7717.151113377524;7863.803404914923;7963.721269755531;4270.935935960963;4295.978520107379;4308.719933204332;4336.284513055373;4351.564843515623;1653.6775328811007;1805.5395874052294;1821.0526840105222;1823.392548655409;1842.134196927442;945.7588314979773;956.8229877472689;998.8152191844532;1027.2141811514198;1031.2265800649513;17578.736318955227;18857.339993100177;19111.235550578098;19210;19550.120244589027;981.788915383196;985.9507024648882;993.9304248702522;1003.4180175498193;1016.8423894296396;10341.017603327671;10652.573897044187;10909.236353455182;10947.726306842393;10949.4525273736;341459;346322;347052;420747;440978;81790.59104704438;98065.50967245118;98406;101126;102112.48943755383;993.6273897288517;1021.99489002556;1054.2409465185208;1057.1648397765832;1064.499685147979;17299.827001730326;17408.564785880455;17972.910135449238;18074;18296.908515457337;33763.493547597296;41586.376204356355;41985.79007104945;42003.57996419997;43251.13497729965;56227.71886140543;56261.718691406284;57194.7140264296;59061.70469147627;59712.402875970685;8257.256846883809;8352.87470687928;8455.619497122521;8479.745607631781;8855.73432797017;12722.300273484678;12835;12851.22892626408;13446.260455675032;13754.793678095037;11397.202195846212;11442.37066961325;11671.941640292083;11767;12010.219335743148;11314.321140731583;11350.659480215607;11412.201145919706;11776.76446471083;12069.155159138776;11675.766484670428;11712.765744685228;11835.881641183478;11948.283103013848;12069.879301206876;8286.875696864672;8319.792005199919;8576;8596.484210947363;8716.694915677921;11325.830112548154;11333.376664283214;11642.068634509389;11729.765404692029;11759.353235572125 09:41:32 INFO - PROCESS | 9133 | |3;mootools.html;1420.9431622735087;1471.6394483351578;1565.9620336547098;1723.3192888808912;1725.982740172598;7871.448998570102;8174.305184059363;8382.119877412868;8425.410221284512;8566.57167141642;8501.702440414587;8645.61094750736;8650.56747162641;8673.95663021684;8674.045854955966;2270.2962081754667;2298.689676893615;2307.411610039446;2317.721873375189;2318.281332786833;2304.9078036878504;2345.695059642244;2356.611159158737;2370.8577485350934;2372.1697405907967;2259.175400978639;2272.681824544565;2274.215395688485;2285.897134628946;2286.565552545011;2215.0586000949693;2267.353804165813;2284.954300913989;2286.5998450271304;2294.8393612447053;2256.3231030690727;2263.9207627733117;2268.6823844661762;2282.4978504728933;2292.86242825431;8484.872726909101;8549.358798090107;8570.057293697688;8570.871436928452;8593.441426307332;5079.111155547801;5121.436641969381;5138.229265610188;5154.433012368637;5199.350081239845;3126.4685003549453;3166.509191075364;3364.4616861302075;3409.1647546351055;3417.3165366926714;1050.8318669012997;1069.2675517270695;1086.7228856641584;1091.1052936591998;1106.8339749037627;11438.999999999916;11462.484188211467;11475.483603237873;11571.132165087567;11594.826077608843;4311.331743579687;4466.754328511963;4551.8634440966825;4564.612007979293;4590;9084;9144.908550914539;9165.725028249164;9166;9167.174954254016;5201.921971170435;5211.5830733541225;5212.765425555859;5213.68717876921;5214.608904332114;4664.020555683277;4703.129920964632;4844.515548445127;4913.410390753133;4945.901081978341;3731.1231860512758;3822.7132965027736;3836.3094642963974;3871.903202419962;3913.6477717005605;1182.5388098641536;1209.7096696792707;1214.1197631717112;1219.1039585904352;1221.773971815217;810.9635066422026;872.3195907192273;947.7204224753576;948.4688574398222;964.1322809471532;5908.734106965197;5918.556108291896;5999.340072592011;6001.939980600226;6061.393860613992;444.89544956935094;445.03649598619273;445.2830942183083;456.0468620582997;459.53357342297596;3940.389239667856;3960.2277555876904;4000.879973600797;4012.7792971386853;4045.838166473367;10112;10408.115310198567;10411.583536658449;10421.218408619385;10438.478076096164;10345.793084138275;10355.275130740927;10377.117944974761;10390.064894159563;10393.584256629802;7564.335846113846;7648.541087534654;7710.884336734954;7727.497712648772;7758;5692.886142277214;5744.167095771173;5751.166080918159;5763.567732420169;5926.703664816656;9439.575219115019;9446.197073248852;9544.85682714746;9569.760755981157;9639.855402169112;9552.90447095548;9578.201678407017;9598.088181622734;9668.9033109668;9782.706518804447;6231.5637905348;6431.839204019937;6841.315868413119;7107.786766397016;7198.856022879618;7860.4104692147175;8070.919290807017;8114.959425202836;8176.83646327082;8188.754337369888;7269.127704675473;7355.77932662021;7401;7457.813554661177;7638.770836874903;7052.8589428210125;7184.9640751795905;7190.388816950618;7372.63136843145;7414.073240844895;6772.11962444879;6867.141607299088;6886.758963436256;6917.481188910952;6920.238773734985;4985.501449854985;5002.949970500394;5139.383274007143;5296.285001524745;5354.3842458117815;5112.872178195575;5177.792888284426;5200.921986170135;5255.13290307095;5261.89476210466 09:41:32 INFO - PROCESS | 9133 | |4;prototype.html;293.63295880149815;309.3673437819659;310.59002117205296;312.6389020681114;319.431412086486;5465.972670136649;5502.642328248661;5592.245046918665;5595.664260144395;5602.747876345564;5423.566114710824;5450.91823622646;5464.644798088131;5465.672059676413;5492.368377636573;4089.7750623715683;4125.731827431222;4182.121754431573;4243.384709217177;4268.87193384199;4247.069522029805;4259.16946195492;4260.7656578888145;4275.828966841338;4293.248681480744;4221.113566151112;4229.471316085489;4234.9153016939645;4240.3851441540955;4260.1266740318315;4137.296659567895;4197.580241975808;4213.178430206111;4227.302495088306;4227.323628219486;3703.203811180609;3708.479523395422;3714.517112775349;3714.9442758358646;3717.4609681596016;5328.147496400596;5368.463153684639;5379.623426360156;5397.352317721859;5400.541853699479;4699.921551383849;4776.785044672998;4825.276208568707;4826.517348265181;4861;5683.630564013326;5697.344805347397;5708.343540492813;5736.168255602956;5738.942610573882;4043.1711499142607;4049.1496785675045;4051.4327994080854;4056.4320995060716;4058.6144316289906;5728.541716662657;5858.707064646751;5935.258092738408;5980.282366116094;5982.341942386334;4095.2219078375015;4096.795160242035;4102.815373308149;4110.7328023678365;4125.071858831739;4170.436086467575;4173.64524015456;4205.939089845953;4258.510271318838;4260.701750877471;4554;4765.714057156512;4845.854624361275;4878.390201224847;4881.9511804881495;5701.258836351248;5719.19931209631;5733.4519679686255;5744.822311426147;5824.504917082011;1368.3773882883265;1378.3459848182222;1378.3521744779937;1382.025671901307;1382.7165431086603;877.3507604372846;925.3522534225934;946.7065209784988;946.9337146399823;954.2604481526733;5202.271681964528;5241.191788832846;5301.761420736076;5321.308229930161;5353.705546194997;5620.690862002629;5655;5683.403242659544;5688.374278829326;5707.8858422832145;5164.32863727713;5325.794132449103;5334.333208348957;5400.702961337164;5417.729113544386;3024.7126522980284;3029.560713696502;3032.969670303313;3037.9392412151633;3047.3143542703156;5875.559333050039;5881.3530511643685;5896.823095307148;5897.115432685132;5918.852028699231;5526.104096611879;5733.598648094593;5750.6837123958585;5758;5780.277465316835;5777.88444231113;5828.213191219216;5837.307180917572;5859.5936975126515;5869.295684517885;5584.664920104807;5601.439856014366;5668.234788303526;5678.545716342765;5871.266091738533;5802.854928626818;5878.470937615635;5892.026171232685;5906.468417842415;5914.585978981602;6138.416850399205;6179.28938172116;6182;6188.8762224754355;6196.318404975359;3903.1998440320235;4051.655609273127;4105.281575724296;4110.445089912943;4149.232392007489;5870.354261031198;5902.940970590411;5908.586398952032;5916.319623243382;5984.401559843981;5540.889182216414;5720.113515431023;5777.306723193244;5803.419658034331;5816.82549523515;5664.773409063756;5687.289088863892;5692.097030514385;5705.971470142788;5725.421611492817;5669.829905102853;5687.459691329483;5695.658260504383;5722.771089156554;5731.8567035824435;5577.219189313419;5804.912926306024;5814.331351894417;5820.563457740602;5847.26909136358;5694.686792226467;5703.372629010722;5724.79963201286;5733.559864081684;5738.282714660668 09:41:32 INFO - PROCESS | 9133 | |5;yui.html;676.9187697476303;683.9863202735945;694.3369082526189;734.9930595084735;800.7157459102019;15001;15009.399624015026;15494.302756375962;15938.920305398486;15949.920250398747;14713.337899794507;14766.261686915665;14868.107913525197;14888.478903238389;14897.03169293995;785.2736218997433;797.330242596219;797.3461761355691;798.1340245833278;799.3804801278997;787.8227398835273;819.1317203764029;819.4550623835142;825.6532256452274;825.7192554531458;858.3733874271785;860.3031544449017;861.8190180062163;862.7282406042077;865.1910463716446;856.9742907712747;857.9099194584542;859.7807559072459;859.866720658299;860.7460799064291;624.7782037376711;625.4183609243402;626.2735227136545;626.9811905642838;628.7107930352043;15408.844336674794;15668.921655391765;15750.606234844221;15839.12884791336;15897.841021589751;13432;14117.235345581803;14646.780298295535;14671.55985320442;14915.850841491663;12516.249025058434;12955;13036.217826930415;13280.800787988188;13524.32378381077;4287.356896465524;4315.093830295642;4337.674674399433;4571.9085618287445;4585.426821647294;82549.9999999994;82776.58611706963;83031.5848420754;83226.58386708089;83577.58211208905;10768.318154401355;11107;11197;11255.268407553483;11322.26405283654;20335.694964575545;20665.58668826615;20912.058957346955;21020;21070.15719371208;7468.887966680504;7681.961590192125;7783.727569535039;7976.840463190703;8019.719309824245;4451.666125040635;4543.227651299287;4578.45058592971;4603.286490593963;4615.561521655437;3450.654934506529;3562.4656301554974;3573.6605022522817;3592.6227746086283;3609.675129238381;615.3446579392933;621.9626822390671;626.0609086370445;626.6021076616381;630.8107567729663;580.2833500626723;641.3169973977699;642.6529673976;645.8579112595221;660.3561527510735;9196.632134714537;9242.76893077665;9398.718038458721;9404.38871473352;9678.322517423712;585.379497732405;595.7110801261384;605.12257227021;637.200313606421;688.5490004047357;4450.977745111254;4554.476235232991;4596.448426188878;4802.711837289774;5006.799728010911;83899.5805020971;85236.57381713176;85247.57376213079;85912.57043714741;87129;74990;75304;75521;75814.62092689502;76657.23342766613;55784.442155577926;66142.66928665325;68233;69477.65261173763;71185.28814711787;9781.168600668738;9801.362911410735;9861.887684611344;10017.599296028076;10147.644832431124;44889.77555112204;44912;45783;46134.30798537957;46965.47758918163;64711.67644161749;65753.34246657472;66421.66789166024;67348;68010.15867937136;12631.621051368473;12743.49026038948;13039.869601304244;13094;13099.158068303666;13561;13862;14256.215908124737;15419.812399908238;15568.532944011698;12500.812487812509;12750.553730619384;12821.423035963591;12851.293178875252;13269.459888800482;13004.349782510648;14466.349014294172;14512.1292722437;14531.491397801026;14894.925525372304;13023.674408139872;13447.193168409536;13449.125806822525;13911.165330080228;13941.163530188222;10941.28881622692;11119.388433636228;11394.886051139383;11413.162888245082;11619.498815609026;9979.643562775522;10493.344554386395;11448.771024579295;11628.127890408085;11737.823932641188 09:41:32 INFO - PROCESS | 9133 | __end_tp_report 09:41:32 INFO - PROCESS | 9133 | __start_cc_report 09:41:32 INFO - PROCESS | 9133 | _x_x_mozilla_cycle_collect,331 09:41:32 INFO - PROCESS | 9133 | __end_cc_report 09:41:32 INFO - PROCESS | 9133 | __startTimestamp1480527692634__endTimestamp 09:41:32 INFO - PROCESS | 9133 | 09:41:32 INFO - PROCESS | 9133 | ------- Summary: start ------- 09:41:32 INFO - PROCESS | 9133 | Number of tests: 6 09:41:32 INFO - PROCESS | 9133 | 09:41:32 INFO - PROCESS | 9133 | [#0] dojo.html Cycles:165 Average:5466.29 Median:5695.54 stddev:616.54 (10.8%) stddev-sans-first:591.16 09:41:32 INFO - PROCESS | 9133 | Values: 3154.7 3163.4 3165.4 3200.3 3211.2 5304.1 5423.4 5463.6 5477.4 5481.9 5385.9 5441.6 5520.5 5552.3 5619.5 4960.5 4969.5 5038.1 5056.6 5086.2 4938.5 5060.6 5183.6 5188.2 5209.5 4888.6 5099.0 5122.3 5136.3 5168.9 4901.8 4975.2 5002.8 5029.2 5100.2 4964.9 4973.2 4975.7 5002.2 5005.7 5469.3 5507.6 5514.6 5525.2 5530.3 5721.8 5743.3 5754.4 5838.1 5841.4 5886.8 5904.9 5908.7 5908.9 5912.0 5429.1 5465.8 5505.6 5529.6 5608.4 6037.0 6059.1 6089.8 6103.5 6108.6 5858.7 5862.7 5864.9 5869.0 5870.8 5688.5 5702.7 5715.9 5800.8 5810.2 5708.7 5743.9 5773.6 5795.0 5811.6 5840.8 5851.8 5871.9 5874.6 5925.6 4495.4 4507.0 4509.7 4510.9 4547.4 3937.7 3969.0 4018.8 4025.3 4029.0 5685.6 5693.0 5702.9 5704.1 5720.0 5947.8 5994.3 6013.9 6015.5 6015.9 5362.9 5407.1 5416.2 5606.3 5662.6 5010.3 5095.0 5113.9 5116.6 5159.5 6164.8 6176.2 6179.3 6179.3 6181.2 5914.3 5953.9 5955.7 5961.9 5971.1 5855.6 5902.1 5904.3 5965.2 5986.6 5732.8 5870.2 5876.8 5878.0 5936.2 5630.4 5709.8 5710.9 5780.0 5793.8 5683.5 5710.5 5749.1 5776.5 5832.7 5722.6 5754.7 5762.6 5781.4 5783.0 5522.6 5540.7 5550.3 5628.3 5716.1 5732.0 5817.7 5822.6 5863.3 5867.8 5664.5 5669.6 5673.3 5695.5 5704.3 09:41:32 INFO - PROCESS | 9133 | 09:41:32 INFO - PROCESS | 9133 | [#1] ext.html Cycles:180 Average:57040.37 Median:18975.39 stddev:111347.68 (586.8%) stddev-sans-first:111579.27 09:41:32 INFO - PROCESS | 9133 | Values: 553.6 559.1 572.4 582.0 592.1 32097.2 33860.2 41638.8 42592.4 42608.4 42343.8 42884.4 42947.0 43014.8 43075.1 8610.2 8744.1 8780.9 8790.4 8798.0 8513.3 10141.5 10401.4 10430.6 10641.5 10391.5 10447.3 10453.3 10485.2 10491.9 10212.3 10250.3 10251.5 10253.0 10350.1 10225.2 10313.5 10333.3 10378.2 10394.7 39602.0 39673.0 39871.0 39877.8 39957.0 3424.4 3440.4 3445.2 3489.0 3573.2 29633.9 30102.1 30537.5 30625.8 31506.8 3994.9 4117.8 4169.5 4212.0 4254.5 333560.0 338320.0 341455.0 341554.0 342965.0 58118.4 58230.4 58316.1 58348.0 58684.4 60534.1 60649.7 60753.0 60785.0 61145.0 15379.4 15848.7 15859.0 15870.2 15928.8 12100.6 12103.7 12183.9 12208.6 12307.2 18322.5 18549.8 18657.3 18844.2 18858.5 6730.6 6844.7 7000.3 7053.6 7082.4 862.3 934.2 971.2 1084.5 1138.6 30280.0 31122.8 31163.4 31480.0 31637.8 1075.0 1090.4 1104.9 1155.5 1163.0 15889.5 16246.8 16526.8 16592.3 16789.4 483584.0 493998.0 494912.0 495030.0 495509.0 54906.7 55798.0 55840.7 55893.0 55945.0 1290.9 1306.8 1351.2 1355.7 1362.1 29479.3 30280.8 30715.5 31208.5 31488.7 43984.0 44254.1 44583.8 44723.0 44741.8 414654.3 414774.0 416063.0 416105.0 417384.8 24273.9 25104.4 26100.9 27243.5 27258.3 42672.0 43027.6 43468.6 43921.3 44278.8 36266.8 36672.4 37080.4 37124.4 37304.4 36986.0 37085.3 37099.6 37562.6 38284.0 36775.4 37170.1 37423.0 37525.6 37906.6 31743.0 33723.3 34308.1 34427.7 34461.8 25980.2 26457.7 26536.6 26738.0 26776.7 09:41:32 INFO - PROCESS | 9133 | 09:41:32 INFO - PROCESS | 9133 | [#2] jquery.html Cycles:180 Average:25480.33 Median:2502.74 stddev:63997.22 (2557.1%) stddev-sans-first:64148.97 09:41:32 INFO - PROCESS | 9133 | Values: 369.7 370.6 375.7 379.7 396.3 18025.5 18072.2 18430.5 18681.9 18830.4 11664.2 12029.3 12030.4 12072.3 12072.9 4906.8 5264.2 5306.7 5308.5 5310.2 5179.1 5388.2 5705.9 5735.3 5775.0 5726.1 5738.8 5746.5 5765.5 5786.5 5560.4 5687.6 5736.4 5747.7 5763.3 4988.6 5561.2 5566.2 5569.8 5571.9 12764.2 13299.6 13418.9 13439.5 13442.6 2330.7 2348.3 2382.2 2440.1 2565.4 9358.0 9680.8 9681.7 10174.2 10408.7 1853.9 1860.6 1928.9 1932.3 1959.0 77958.6 82801.2 83761.0 85333.6 86459.6 10193.2 10220.8 10629.4 10663.7 10740.4 14911.5 14930.4 14955.8 15013.2 15088.9 7438.3 7591.0 7741.1 7991.0 8024.0 7645.9 7693.3 7717.2 7863.8 7963.7 4270.9 4296.0 4308.7 4336.3 4351.6 1653.7 1805.5 1821.1 1823.4 1842.1 945.8 956.8 998.8 1027.2 1031.2 17578.7 18857.3 19111.2 19210.0 19550.1 981.8 986.0 993.9 1003.4 1016.8 10341.0 10652.6 10909.2 10947.7 10949.5 341459.0 346322.0 347052.0 420747.0 440978.0 81790.6 98065.5 98406.0 101126.0 102112.5 993.6 1022.0 1054.2 1057.2 1064.5 17299.8 17408.6 17972.9 18074.0 18296.9 33763.5 41586.4 41985.8 42003.6 43251.1 56227.7 56261.7 57194.7 59061.7 59712.4 8257.3 8352.9 8455.6 8479.7 8855.7 12722.3 12835.0 12851.2 13446.3 13754.8 11397.2 11442.4 11671.9 11767.0 12010.2 11314.3 11350.7 11412.2 11776.8 12069.2 11675.8 11712.8 11835.9 11948.3 12069.9 8286.9 8319.8 8576.0 8596.5 8716.7 11325.8 11333.4 11642.1 11729.8 11759.4 09:41:32 INFO - PROCESS | 9133 | 09:41:32 INFO - PROCESS | 9133 | [#3] mootools.html Cycles:180 Average:5546.66 Median:5138.81 stddev:3092.01 (60.2%) stddev-sans-first:3085.14 09:41:32 INFO - PROCESS | 9133 | Values: 1420.9 1471.6 1566.0 1723.3 1726.0 7871.4 8174.3 8382.1 8425.4 8566.6 8501.7 8645.6 8650.6 8674.0 8674.0 2270.3 2298.7 2307.4 2317.7 2318.3 2304.9 2345.7 2356.6 2370.9 2372.2 2259.2 2272.7 2274.2 2285.9 2286.6 2215.1 2267.4 2285.0 2286.6 2294.8 2256.3 2263.9 2268.7 2282.5 2292.9 8484.9 8549.4 8570.1 8570.9 8593.4 5079.1 5121.4 5138.2 5154.4 5199.4 3126.5 3166.5 3364.5 3409.2 3417.3 1050.8 1069.3 1086.7 1091.1 1106.8 11439.0 11462.5 11475.5 11571.1 11594.8 4311.3 4466.8 4551.9 4564.6 4590.0 9084.0 9144.9 9165.7 9166.0 9167.2 5201.9 5211.6 5212.8 5213.7 5214.6 4664.0 4703.1 4844.5 4913.4 4945.9 3731.1 3822.7 3836.3 3871.9 3913.6 1182.5 1209.7 1214.1 1219.1 1221.8 811.0 872.3 947.7 948.5 964.1 5908.7 5918.6 5999.3 6001.9 6061.4 444.9 445.0 445.3 456.0 459.5 3940.4 3960.2 4000.9 4012.8 4045.8 10112.0 10408.1 10411.6 10421.2 10438.5 10345.8 10355.3 10377.1 10390.1 10393.6 7564.3 7648.5 7710.9 7727.5 7758.0 5692.9 5744.2 5751.2 5763.6 5926.7 9439.6 9446.2 9544.9 9569.8 9639.9 9552.9 9578.2 9598.1 9668.9 9782.7 6231.6 6431.8 6841.3 7107.8 7198.9 7860.4 8070.9 8115.0 8176.8 8188.8 7269.1 7355.8 7401.0 7457.8 7638.8 7052.9 7185.0 7190.4 7372.6 7414.1 6772.1 6867.1 6886.8 6917.5 6920.2 4985.5 5002.9 5139.4 5296.3 5354.4 5112.9 5177.8 5200.9 5255.1 5261.9 09:41:32 INFO - PROCESS | 9133 | 09:41:32 INFO - PROCESS | 9133 | [#4] prototype.html Cycles:180 Average:4777.92 Median:5497.51 stddev:1423.03 (25.9%) stddev-sans-first:1386.65 09:41:32 INFO - PROCESS | 9133 | Values: 293.6 309.4 310.6 312.6 319.4 5466.0 5502.6 5592.2 5595.7 5602.7 5423.6 5450.9 5464.6 5465.7 5492.4 4089.8 4125.7 4182.1 4243.4 4268.9 4247.1 4259.2 4260.8 4275.8 4293.2 4221.1 4229.5 4234.9 4240.4 4260.1 4137.3 4197.6 4213.2 4227.3 4227.3 3703.2 3708.5 3714.5 3714.9 3717.5 5328.1 5368.5 5379.6 5397.4 5400.5 4699.9 4776.8 4825.3 4826.5 4861.0 5683.6 5697.3 5708.3 5736.2 5738.9 4043.2 4049.1 4051.4 4056.4 4058.6 5728.5 5858.7 5935.3 5980.3 5982.3 4095.2 4096.8 4102.8 4110.7 4125.1 4170.4 4173.6 4205.9 4258.5 4260.7 4554.0 4765.7 4845.9 4878.4 4882.0 5701.3 5719.2 5733.5 5744.8 5824.5 1368.4 1378.3 1378.4 1382.0 1382.7 877.4 925.4 946.7 946.9 954.3 5202.3 5241.2 5301.8 5321.3 5353.7 5620.7 5655.0 5683.4 5688.4 5707.9 5164.3 5325.8 5334.3 5400.7 5417.7 3024.7 3029.6 3033.0 3037.9 3047.3 5875.6 5881.4 5896.8 5897.1 5918.9 5526.1 5733.6 5750.7 5758.0 5780.3 5777.9 5828.2 5837.3 5859.6 5869.3 5584.7 5601.4 5668.2 5678.5 5871.3 5802.9 5878.5 5892.0 5906.5 5914.6 6138.4 6179.3 6182.0 6188.9 6196.3 3903.2 4051.7 4105.3 4110.4 4149.2 5870.4 5902.9 5908.6 5916.3 5984.4 5540.9 5720.1 5777.3 5803.4 5816.8 5664.8 5687.3 5692.1 5706.0 5725.4 5669.8 5687.5 5695.7 5722.8 5731.9 5577.2 5804.9 5814.3 5820.6 5847.3 5694.7 5703.4 5724.8 5733.6 5738.3 09:41:32 INFO - PROCESS | 9133 | 09:41:32 INFO - PROCESS | 9133 | [#5] yui.html Cycles:180 Average:18590.18 Median:25368.80 stddev:24536.38 (96.7%) stddev-sans-first:24568.34 09:41:32 INFO - PROCESS | 9133 | Values: 676.9 684.0 694.3 735.0 800.7 15001.0 15009.4 15494.3 15938.9 15949.9 14713.3 14766.3 14868.1 14888.5 14897.0 785.3 797.3 797.3 798.1 799.4 787.8 819.1 819.5 825.7 825.7 858.4 860.3 861.8 862.7 865.2 857.0 857.9 859.8 859.9 860.7 624.8 625.4 626.3 627.0 628.7 15408.8 15668.9 15750.6 15839.1 15897.8 13432.0 14117.2 14646.8 14671.6 14915.9 12516.2 12955.0 13036.2 13280.8 13524.3 4287.4 4315.1 4337.7 4571.9 4585.4 82550.0 82776.6 83031.6 83226.6 83577.6 10768.3 11107.0 11197.0 11255.3 11322.3 20335.7 20665.6 20912.1 21020.0 21070.2 7468.9 7682.0 7783.7 7976.8 8019.7 4451.7 4543.2 4578.5 4603.3 4615.6 3450.7 3562.5 3573.7 3592.6 3609.7 615.3 622.0 626.1 626.6 630.8 580.3 641.3 642.7 645.9 660.4 9196.6 9242.8 9398.7 9404.4 9678.3 585.4 595.7 605.1 637.2 688.5 4451.0 4554.5 4596.4 4802.7 5006.8 83899.6 85236.6 85247.6 85912.6 87129.0 74990.0 75304.0 75521.0 75814.6 76657.2 55784.4 66142.7 68233.0 69477.7 71185.3 9781.2 9801.4 9861.9 10017.6 10147.6 44889.8 44912.0 45783.0 46134.3 46965.5 64711.7 65753.3 66421.7 67348.0 68010.2 12631.6 12743.5 13039.9 13094.0 13099.2 13561.0 13862.0 14256.2 15419.8 15568.5 12500.8 12750.6 12821.4 12851.3 13269.5 13004.3 14466.3 14512.1 14531.5 14894.9 13023.7 13447.2 13449.1 13911.2 13941.2 10941.3 11119.4 11394.9 11413.2 11619.5 9979.6 10493.3 11448.8 11628.1 11737.8 09:41:32 INFO - PROCESS | 9133 | -------- Summary: end -------- 09:41:32 INFO - PROCESS | 9133 | 09:41:33 INFO - TEST-INFO | 9133: exit 0 09:41:33 INFO - TEST-OK | dromaeo_css | took 1116707ms 09:41:33 INFO - TEST-START | kraken 09:41:33 INFO - operating with platform_type : linux_ 09:41:33 INFO - Initialising browser for kraken test... 09:41:33 INFO - TEST-INFO | started process 9493 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2FtvDJ/profile http://localhost:44362/getInfo.html) 09:41:37 INFO - PROCESS | 9493 | __metrics Screen width/height:1600/1200 09:41:37 INFO - PROCESS | 9493 | colorDepth:24 09:41:37 INFO - PROCESS | 9493 | Browser inner width/height: 1024/697 09:41:37 INFO - PROCESS | 9493 | __metrics 09:41:38 ERROR - PROCESS | 9493 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 09:41:39 INFO - TEST-INFO | 9493: exit 0 09:41:39 INFO - Browser initialized. 09:41:39 INFO - Running cycle 1/1 for kraken test... 09:41:39 INFO - TEST-INFO | started process 9615 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2FtvDJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:41:51 INFO - PROCESS | 9615 | RSS: Main: 186601472 09:41:51 INFO - PROCESS | 9615 | 09:41:54 INFO - PROCESS | 9615 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44362/tests/kraken/driver.html?testName=audio-beat-detection) 09:41:55 INFO - PROCESS | 9615 | RSS: Main: 199471104 09:41:55 INFO - PROCESS | 9615 | 09:41:57 INFO - PROCESS | 9615 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44362/tests/kraken/driver.html?testName=audio-dft) 09:41:58 INFO - PROCESS | 9615 | RSS: Main: 197734400 09:41:58 INFO - PROCESS | 9615 | 09:42:01 INFO - PROCESS | 9615 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44362/tests/kraken/driver.html?testName=audio-fft) 09:42:02 INFO - PROCESS | 9615 | RSS: Main: 193847296 09:42:02 INFO - PROCESS | 9615 | 09:42:04 INFO - PROCESS | 9615 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44362/tests/kraken/driver.html?testName=audio-oscillator) 09:42:04 INFO - PROCESS | 9615 | RSS: Main: 194371584 09:42:04 INFO - PROCESS | 9615 | 09:42:06 INFO - PROCESS | 9615 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44362/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:42:07 INFO - PROCESS | 9615 | RSS: Main: 194723840 09:42:07 INFO - PROCESS | 9615 | 09:42:10 INFO - PROCESS | 9615 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44362/tests/kraken/driver.html?testName=imaging-darkroom) 09:42:11 INFO - PROCESS | 9615 | RSS: Main: 200159232 09:42:11 INFO - PROCESS | 9615 | 09:42:14 INFO - PROCESS | 9615 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44362/tests/kraken/driver.html?testName=imaging-desaturate) 09:42:15 INFO - PROCESS | 9615 | RSS: Main: 196599808 09:42:15 INFO - PROCESS | 9615 | 09:42:18 INFO - PROCESS | 9615 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44362/tests/kraken/driver.html?testName=json-parse-financial) 09:42:18 INFO - PROCESS | 9615 | RSS: Main: 198041600 09:42:18 INFO - PROCESS | 9615 | 09:42:20 INFO - PROCESS | 9615 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44362/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:42:21 INFO - PROCESS | 9615 | RSS: Main: 197971968 09:42:21 INFO - PROCESS | 9615 | 09:42:22 INFO - PROCESS | 9615 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44362/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:42:23 INFO - PROCESS | 9615 | RSS: Main: 198078464 09:42:23 INFO - PROCESS | 9615 | 09:42:25 INFO - PROCESS | 9615 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44362/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:42:26 INFO - PROCESS | 9615 | RSS: Main: 198242304 09:42:26 INFO - PROCESS | 9615 | 09:42:28 INFO - PROCESS | 9615 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:42:29 INFO - PROCESS | 9615 | RSS: Main: 198230016 09:42:29 INFO - PROCESS | 9615 | 09:42:32 INFO - PROCESS | 9615 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:42:33 INFO - PROCESS | 9615 | RSS: Main: 198451200 09:42:33 INFO - PROCESS | 9615 | 09:42:34 INFO - PROCESS | 9615 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44362/tests/kraken/driver.html?testName=ai-astar) 09:42:35 INFO - PROCESS | 9615 | RSS: Main: 199729152 09:42:35 INFO - PROCESS | 9615 | 09:42:35 INFO - PROCESS | 9615 | __start_tp_report 09:42:35 INFO - PROCESS | 9615 | _x_x_mozilla_page_load 09:42:35 INFO - PROCESS | 9615 | _x_x_mozilla_page_load_details 09:42:35 INFO - PROCESS | 9615 | |i|pagename|runs| 09:42:35 INFO - PROCESS | 9615 | |0;ai-astar;105;111;113;112;113;112;113;112;111;111 09:42:35 INFO - PROCESS | 9615 | |1;audio-beat-detection;150;130;130;173;128;131;130;127;152;133 09:42:35 INFO - PROCESS | 9615 | |2;audio-dft;162;164;163;169;167;162;166;163;165;162 09:42:35 INFO - PROCESS | 9615 | |3;audio-fft;75;77;76;109;77;75;76;76;95;76 09:42:35 INFO - PROCESS | 9615 | |4;audio-oscillator;82;82;103;83;83;83;102;82;83;99 09:42:35 INFO - PROCESS | 9615 | |5;imaging-gaussian-blur;119;117;117;117;118;117;118;121;118;118 09:42:35 INFO - PROCESS | 9615 | |6;imaging-darkroom;147;147;147;149;147;147;147;148;148;147 09:42:35 INFO - PROCESS | 9615 | |7;imaging-desaturate;96;97;95;97;96;95;96;96;96;96 09:42:35 INFO - PROCESS | 9615 | |8;json-parse-financial;57;53;53;53;54;53;56;54;54;57 09:42:35 INFO - PROCESS | 9615 | |9;json-stringify-tinderbox;63;62;62;63;63;63;63;62;64;63 09:42:35 INFO - PROCESS | 9615 | |10;stanford-crypto-aes;84;85;81;81;82;82;82;82;81;82 09:42:35 INFO - PROCESS | 9615 | |11;stanford-crypto-ccm;137;144;137;142;134;146;139;134;182;136 09:42:35 INFO - PROCESS | 9615 | |12;stanford-crypto-pbkdf2;170;176;170;169;177;171;174;172;175;176 09:42:35 INFO - PROCESS | 9615 | |13;stanford-crypto-sha256-iterative;68;72;69;70;67;67;67;70;67;65 09:42:35 INFO - PROCESS | 9615 | __end_tp_report 09:42:35 INFO - PROCESS | 9615 | __start_cc_report 09:42:35 INFO - PROCESS | 9615 | _x_x_mozilla_cycle_collect,841 09:42:35 INFO - PROCESS | 9615 | __end_cc_report 09:42:35 INFO - PROCESS | 9615 | __startTimestamp1480527755173__endTimestamp 09:42:35 INFO - PROCESS | 9615 | 09:42:35 INFO - PROCESS | 9615 | ------- Summary: start ------- 09:42:35 INFO - PROCESS | 9615 | Number of tests: 14 09:42:35 INFO - PROCESS | 9615 | 09:42:35 INFO - PROCESS | 9615 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.36 (2.1%) stddev-sans-first:0.87 09:42:35 INFO - PROCESS | 9615 | Values: 105.0 111.0 113.0 112.0 113.0 112.0 113.0 112.0 111.0 111.0 09:42:35 INFO - PROCESS | 9615 | 09:42:35 INFO - PROCESS | 9615 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:132.00 stddev:15.09 (11.4%) stddev-sans-first:15.41 09:42:35 INFO - PROCESS | 9615 | Values: 150.0 130.0 130.0 173.0 128.0 131.0 130.0 127.0 152.0 133.0 09:42:35 INFO - PROCESS | 9615 | 09:42:35 INFO - PROCESS | 9615 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:2.41 (1.5%) stddev-sans-first:2.40 09:42:35 INFO - PROCESS | 9615 | Values: 162.0 164.0 163.0 169.0 167.0 162.0 166.0 163.0 165.0 162.0 09:42:35 INFO - PROCESS | 9615 | 09:42:35 INFO - PROCESS | 9615 | [#3] audio-fft Cycles:10 Average:81.20 Median:76.00 stddev:11.47 (15.1%) stddev-sans-first:11.94 09:42:35 INFO - PROCESS | 9615 | Values: 75.0 77.0 76.0 109.0 77.0 75.0 76.0 76.0 95.0 76.0 09:42:35 INFO - PROCESS | 9615 | 09:42:35 INFO - PROCESS | 9615 | [#4] audio-oscillator Cycles:10 Average:88.20 Median:83.00 stddev:9.13 (11.0%) stddev-sans-first:9.40 09:42:35 INFO - PROCESS | 9615 | Values: 82.0 82.0 103.0 83.0 83.0 83.0 102.0 82.0 83.0 99.0 09:42:35 INFO - PROCESS | 9615 | 09:42:35 INFO - PROCESS | 9615 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.25 (1.1%) stddev-sans-first:1.27 09:42:35 INFO - PROCESS | 9615 | Values: 119.0 117.0 117.0 117.0 118.0 117.0 118.0 121.0 118.0 118.0 09:42:35 INFO - PROCESS | 9615 | 09:42:35 INFO - PROCESS | 9615 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 09:42:35 INFO - PROCESS | 9615 | Values: 147.0 147.0 147.0 149.0 147.0 147.0 147.0 148.0 148.0 147.0 09:42:35 INFO - PROCESS | 9615 | 09:42:35 INFO - PROCESS | 9615 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:42:35 INFO - PROCESS | 9615 | Values: 96.0 97.0 95.0 97.0 96.0 95.0 96.0 96.0 96.0 96.0 09:42:35 INFO - PROCESS | 9615 | 09:42:35 INFO - PROCESS | 9615 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:1.65 (3.0%) stddev-sans-first:1.45 09:42:35 INFO - PROCESS | 9615 | Values: 57.0 53.0 53.0 53.0 54.0 53.0 56.0 54.0 54.0 57.0 09:42:35 INFO - PROCESS | 9615 | 09:42:35 INFO - PROCESS | 9615 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 09:42:35 INFO - PROCESS | 9615 | Values: 63.0 62.0 62.0 63.0 63.0 63.0 63.0 62.0 64.0 63.0 09:42:35 INFO - PROCESS | 9615 | 09:42:35 INFO - PROCESS | 9615 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:1.32 (1.6%) stddev-sans-first:1.22 09:42:35 INFO - PROCESS | 9615 | Values: 84.0 85.0 81.0 81.0 82.0 82.0 82.0 82.0 81.0 82.0 09:42:35 INFO - PROCESS | 9615 | 09:42:35 INFO - PROCESS | 9615 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:140.50 stddev:14.26 (10.2%) stddev-sans-first:14.96 09:42:35 INFO - PROCESS | 9615 | Values: 137.0 144.0 137.0 142.0 134.0 146.0 139.0 134.0 182.0 136.0 09:42:35 INFO - PROCESS | 9615 | 09:42:35 INFO - PROCESS | 9615 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:174.50 stddev:2.94 (1.7%) stddev-sans-first:2.92 09:42:35 INFO - PROCESS | 9615 | Values: 170.0 176.0 170.0 169.0 177.0 171.0 174.0 172.0 175.0 176.0 09:42:35 INFO - PROCESS | 9615 | 09:42:35 INFO - PROCESS | 9615 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:2.04 (3.0%) stddev-sans-first:2.17 09:42:35 INFO - PROCESS | 9615 | Values: 68.0 72.0 69.0 70.0 67.0 67.0 67.0 70.0 67.0 65.0 09:42:35 INFO - PROCESS | 9615 | -------- Summary: end -------- 09:42:35 INFO - PROCESS | 9615 | 09:42:36 INFO - TEST-INFO | 9615: exit 0 09:42:36 INFO - TEST-OK | kraken | took 62684ms 09:42:36 INFO - SUITE-END | took 1179s 09:42:36 INFO - Completed test suite (00:19:39) 09:42:36 INFO - javascript benchmark 09:42:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7107.095485151725, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3154.70030347117, 3163.43058249515, 3165.3985742708883, 3200.3119329344186, 3211.2453573410257, 5304.124819404794, 5423.4034256231835, 5463.644863083901, 5477.370102438221, 5481.945180548193, 5385.865353366168, 5441.564674826014, 5520.503154716075, 5552.278203833496, 5619.4942455179025, 4960.454350021495, 4969.503049695038, 5038.093143234217, 5056.595472362203, 5086.186210206368, 4938.456769755342, 5060.620453465986, 5183.559397451221, 5188.195829646411, 5209.531142197202, 4888.560029597318, 5098.97450512745, 5122.257272695439, 5136.332276804011, 5168.9224661630105, 4901.803927842882, 4975.203967365241, 5002.849914502534, 5029.220470827027, 5100.183970564692, 4964.900701985976, 4973.204287314013, 4975.651704380694, 5002.224655178453, 5005.674631148963, 5469.316335458067, 5507.642003269774, 5514.6139770216105, 5525.171224316345, 5530.281063461724, 5721.828345149652, 5743.310802703702, 5754.424557544254, 5838.065909454509, 5841.4450627190345, 5886.7939622113445, 5904.881902361929, 5908.734106965197, 5908.911366329508, 5911.970440147772, 5429.077056900336, 5465.836024919259, 5505.559555235572, 5529.557635389159, 5608.439156084359, 6036.9698151508965, 6059.121427393004, 6089.756409743649, 6103.542234332354, 6108.633481991094, 5858.677772722456, 5862.677552734555, 5864.882702345929, 5868.9706551467825, 5870.823875283749, 5688.488036076773, 5702.714864256771, 5715.942840571541, 5800.8259752207505, 5810.244668193108, 5708.71456427177, 5743.885122297531, 5773.566982476331, 5795.0, 5811.593188476851, 5840.766369345263, 5851.824445266649, 5871.882562348729, 5874.559408044413, 5925.555583331267, 4495.370648109268, 4507.0, 4509.706869053501, 4510.887227819265, 4547.363369128325, 3937.7440466369594, 3969.0, 4018.778967156776, 4025.295573274665, 4028.9597104028585, 5685.630434021776, 5693.0, 5702.914456283159, 5704.058830293038, 5719.971400143056, 5947.821565353046, 5994.280686317583, 6013.939860601338, 6015.488683461955, 6015.939840601538, 5362.892742145135, 5407.107827208467, 5416.160495123183, 5606.327240731139, 5662.5753068520025, 5010.2735103409805, 5095.031943930641, 5113.897722045613, 5116.641835071584, 5159.484051594885, 6164.7842325518395, 6176.197094377792, 6179.258488981351, 6179.320274769681, 6181.196444462281, 5914.290285165635, 5953.851153721192, 5955.702214889152, 5961.940380596138, 5971.104334349882, 5855.59010869235, 5902.1441890926435, 5904.261967254093, 5965.224520812267, 5986.580939334205, 5732.828015159552, 5870.236869206976, 5876.764929402776, 5878.0, 5936.1689363488285, 5630.352509461464, 5709.800156994485, 5710.943475457054, 5780.0, 5793.826185214451, 5683.460071293221, 5710.486056254957, 5749.13762935563, 5776.537876969916, 5832.679202643895, 5722.570807189394, 5754.683492407958, 5762.567807414544, 5781.392953739965, 5783.045797443543, 5522.5858060644805, 5540.695261760642, 5550.27846379968, 5628.324601047737, 5716.085426331767, 5731.971340143273, 5817.680027598522, 5822.563307752021, 5863.296404431496, 5867.794627188028, 5664.546836253007, 5669.6314739541795, 5673.347565030074, 5695.544356451557, 5704.3154821421695], "value": 5424.782993693881, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.5903431460719, 559.1138046196778, 572.3789688188318, 581.9796307129249, 592.1000079878582, 32097.19757006076, 33860.15349616261, 41638.791806040965, 42592.361114583306, 42608.360874586826, 42343.78828105855, 42884.356734649, 42947.0, 43014.78492607533, 43075.13849723004, 8610.182032706914, 8744.081871403507, 8780.868286975701, 8790.428622139572, 8798.0, 8513.276371508398, 10141.543630536644, 10401.37591744494, 10430.63492777753, 10641.467926603678, 10391.480425978709, 10447.320924139907, 10453.320534165294, 10485.213608979318, 10491.947540262288, 10212.2851400402, 10250.282480226424, 10251.48742562869, 10253.0, 10350.068493835515, 10225.233107516966, 10313.484325783757, 10333.276670633059, 10378.169746420268, 10394.688159355232, 39602.0, 39673.0, 39871.0, 39877.80061099676, 39957.0, 3424.434968230239, 3440.3807314683345, 3445.207602251471, 3488.982555087234, 3573.249617580311, 29633.851830740707, 30102.096937091923, 30537.541936870966, 30625.846870765727, 31506.80137777264, 3994.900127496807, 4117.75293482392, 4169.541350451448, 4212.0, 4254.489461264637, 333560.0, 338320.0, 341455.0, 341554.0, 342965.0, 58118.41881581215, 58230.4176958225, 58316.12525812116, 58348.0, 58684.41315586789, 60534.0919886202, 60649.69675151596, 60753.0, 60785.0, 61145.0, 15379.384824607114, 15848.68302633941, 15859.0, 15870.20648967547, 15928.76106858398, 12100.57647982334, 12103.697407564881, 12183.939080304543, 12208.633740987785, 12307.20003199789, 18322.541936451697, 18549.81450185508, 18657.346992855455, 18844.15201315944, 18858.52853678669, 6730.629815360105, 6844.691988860513, 7000.299970002959, 7053.612051337226, 7082.362587367059, 862.2584577263548, 934.1825902335456, 971.2327261463506, 1084.5011294804478, 1138.6242539961793, 30280.0, 31122.84438577838, 31163.376732465225, 31480.0, 31637.84181079126, 1074.9677509674723, 1090.4057288777635, 1104.8511741536718, 1155.5493357590547, 1162.9823904083926, 15889.52331430059, 16246.75629865553, 16526.83473165277, 16592.2533485991, 16789.41237056697, 483584.0, 493998.0, 494912.0, 495030.0, 495509.0, 54906.72546637321, 55798.0, 55840.720796395755, 55893.0, 55945.0, 1290.851552071505, 1306.8366454193226, 1351.216294549159, 1355.728854229158, 1362.1010133311966, 29479.26301842471, 30280.84859575776, 30715.539266910568, 31208.531872021485, 31488.685113148575, 43984.0, 44254.11491770211, 44583.77708111569, 44723.0, 44741.77629111834, 414654.2672866405, 414774.0, 416063.0, 416105.0, 417384.82615174673, 24273.878630606734, 25104.37239069038, 26100.869495653158, 27243.455130897666, 27258.318542036606, 42672.0, 43027.63819095512, 43468.56531434645, 43921.34117988169, 44278.77860610676, 36266.81866590756, 36672.449913251854, 37080.44379334258, 37124.44313335356, 37304.44043339298, 36986.0, 37085.25829483341, 37099.62900370962, 37562.624373757004, 38284.0, 36775.448368275036, 37170.07074823151, 37423.0, 37525.6247437533, 37906.620933790306, 31743.0, 33723.32553348968, 34308.14229644279, 34427.65572344245, 34461.79383721558, 25980.22059338223, 26457.735422645528, 26536.601950970366, 26738.0, 26776.7322326782], "value": 19539.231326751935, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.735639018102, 370.5830940192282, 375.70507151885766, 379.70003697079306, 396.34602905206407, 18025.549361265974, 18072.18675159618, 18430.539236519093, 18681.906590467046, 18830.43508694738, 11664.183507154503, 12029.278243305407, 12030.398480076004, 12072.2756634602, 12072.879271207285, 4906.803727850882, 5264.236685680574, 5306.6550674206055, 5308.460546441546, 5310.176922576988, 5179.067767801795, 5388.164834450647, 5705.942940570603, 5735.2544169257935, 5774.971125144369, 5726.112452569859, 5738.8278351649515, 5746.454086861741, 5765.509931655814, 5786.479216870481, 5560.388357280696, 5687.6303040302455, 5736.397678243766, 5747.683877386742, 5763.279590051244, 4988.575971042465, 5561.165825126223, 5566.165075238706, 5569.805056822992, 5571.944280557183, 12764.170328928683, 13299.601011969657, 13418.932905335509, 13439.529616463376, 13442.596722098255, 2330.6620540021772, 2348.2602980061224, 2382.1900553811615, 2440.060576677974, 2565.4227798745133, 9357.953210233973, 9680.806383872354, 9681.70954871355, 10174.236932230038, 10408.739781505446, 1853.898035608041, 1860.6278744251204, 1928.9294441584914, 1932.3236867096543, 1958.9510262243416, 77958.61020694918, 82801.17198827995, 83761.0, 85333.57333213295, 86459.56770216172, 10193.184545236512, 10220.795584088277, 10629.4153821539, 10663.680089597325, 10740.409277489656, 14911.478098266509, 14930.40278388874, 14955.775663365059, 15013.249337533298, 15088.924555377153, 7438.256174382626, 7590.962045189739, 7741.148473667892, 7990.960045199853, 8024.0, 7645.923540764632, 7693.346065584488, 7717.151113377524, 7863.803404914923, 7963.721269755531, 4270.935935960963, 4295.978520107379, 4308.719933204332, 4336.284513055373, 4351.564843515623, 1653.6775328811007, 1805.5395874052294, 1821.0526840105222, 1823.392548655409, 1842.134196927442, 945.7588314979773, 956.8229877472689, 998.8152191844532, 1027.2141811514198, 1031.2265800649513, 17578.736318955227, 18857.339993100177, 19111.235550578098, 19210.0, 19550.120244589027, 981.788915383196, 985.9507024648882, 993.9304248702522, 1003.4180175498193, 1016.8423894296396, 10341.017603327671, 10652.573897044187, 10909.236353455182, 10947.726306842393, 10949.4525273736, 341459.0, 346322.0, 347052.0, 420747.0, 440978.0, 81790.59104704438, 98065.50967245118, 98406.0, 101126.0, 102112.48943755383, 993.6273897288517, 1021.99489002556, 1054.2409465185208, 1057.1648397765832, 1064.499685147979, 17299.827001730326, 17408.564785880455, 17972.910135449238, 18074.0, 18296.908515457337, 33763.493547597296, 41586.376204356355, 41985.79007104945, 42003.57996419997, 43251.13497729965, 56227.71886140543, 56261.718691406284, 57194.7140264296, 59061.70469147627, 59712.402875970685, 8257.256846883809, 8352.87470687928, 8455.619497122521, 8479.745607631781, 8855.73432797017, 12722.300273484678, 12835.0, 12851.22892626408, 13446.260455675032, 13754.793678095037, 11397.202195846212, 11442.37066961325, 11671.941640292083, 11767.0, 12010.219335743148, 11314.321140731583, 11350.659480215607, 11412.201145919706, 11776.76446471083, 12069.155159138776, 11675.766484670428, 11712.765744685228, 11835.881641183478, 11948.283103013848, 12069.879301206876, 8286.875696864672, 8319.792005199919, 8576.0, 8596.484210947363, 8716.694915677921, 11325.830112548154, 11333.376664283214, 11642.068634509389, 11729.765404692029, 11759.353235572125], "value": 8769.061240756419, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.9431622735087, 1471.6394483351578, 1565.9620336547098, 1723.3192888808912, 1725.982740172598, 7871.448998570102, 8174.305184059363, 8382.119877412868, 8425.410221284512, 8566.57167141642, 8501.702440414587, 8645.61094750736, 8650.56747162641, 8673.95663021684, 8674.045854955966, 2270.2962081754667, 2298.689676893615, 2307.411610039446, 2317.721873375189, 2318.281332786833, 2304.9078036878504, 2345.695059642244, 2356.611159158737, 2370.8577485350934, 2372.1697405907967, 2259.175400978639, 2272.681824544565, 2274.215395688485, 2285.897134628946, 2286.565552545011, 2215.0586000949693, 2267.353804165813, 2284.954300913989, 2286.5998450271304, 2294.8393612447053, 2256.3231030690727, 2263.9207627733117, 2268.6823844661762, 2282.4978504728933, 2292.86242825431, 8484.872726909101, 8549.358798090107, 8570.057293697688, 8570.871436928452, 8593.441426307332, 5079.111155547801, 5121.436641969381, 5138.229265610188, 5154.433012368637, 5199.350081239845, 3126.4685003549453, 3166.509191075364, 3364.4616861302075, 3409.1647546351055, 3417.3165366926714, 1050.8318669012997, 1069.2675517270695, 1086.7228856641584, 1091.1052936591998, 1106.8339749037627, 11438.999999999916, 11462.484188211467, 11475.483603237873, 11571.132165087567, 11594.826077608843, 4311.331743579687, 4466.754328511963, 4551.8634440966825, 4564.612007979293, 4590.0, 9084.0, 9144.908550914539, 9165.725028249164, 9166.0, 9167.174954254016, 5201.921971170435, 5211.5830733541225, 5212.765425555859, 5213.68717876921, 5214.608904332114, 4664.020555683277, 4703.129920964632, 4844.515548445127, 4913.410390753133, 4945.901081978341, 3731.1231860512758, 3822.7132965027736, 3836.3094642963974, 3871.903202419962, 3913.6477717005605, 1182.5388098641536, 1209.7096696792707, 1214.1197631717112, 1219.1039585904352, 1221.773971815217, 810.9635066422026, 872.3195907192273, 947.7204224753576, 948.4688574398222, 964.1322809471532, 5908.734106965197, 5918.556108291896, 5999.340072592011, 6001.939980600226, 6061.393860613992, 444.89544956935094, 445.03649598619273, 445.2830942183083, 456.0468620582997, 459.53357342297596, 3940.389239667856, 3960.2277555876904, 4000.879973600797, 4012.7792971386853, 4045.838166473367, 10112.0, 10408.115310198567, 10411.583536658449, 10421.218408619385, 10438.478076096164, 10345.793084138275, 10355.275130740927, 10377.117944974761, 10390.064894159563, 10393.584256629802, 7564.335846113846, 7648.541087534654, 7710.884336734954, 7727.497712648772, 7758.0, 5692.886142277214, 5744.167095771173, 5751.166080918159, 5763.567732420169, 5926.703664816656, 9439.575219115019, 9446.197073248852, 9544.85682714746, 9569.760755981157, 9639.855402169112, 9552.90447095548, 9578.201678407017, 9598.088181622734, 9668.9033109668, 9782.706518804447, 6231.5637905348, 6431.839204019937, 6841.315868413119, 7107.786766397016, 7198.856022879618, 7860.4104692147175, 8070.919290807017, 8114.959425202836, 8176.83646327082, 8188.754337369888, 7269.127704675473, 7355.77932662021, 7401.0, 7457.813554661177, 7638.770836874903, 7052.8589428210125, 7184.9640751795905, 7190.388816950618, 7372.63136843145, 7414.073240844895, 6772.11962444879, 6867.141607299088, 6886.758963436256, 6917.481188910952, 6920.238773734985, 4985.501449854985, 5002.949970500394, 5139.383274007143, 5296.285001524745, 5354.3842458117815, 5112.872178195575, 5177.792888284426, 5200.921986170135, 5255.13290307095, 5261.89476210466], "value": 4398.28813734559, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.63295880149815, 309.3673437819659, 310.59002117205296, 312.6389020681114, 319.431412086486, 5465.972670136649, 5502.642328248661, 5592.245046918665, 5595.664260144395, 5602.747876345564, 5423.566114710824, 5450.91823622646, 5464.644798088131, 5465.672059676413, 5492.368377636573, 4089.7750623715683, 4125.731827431222, 4182.121754431573, 4243.384709217177, 4268.87193384199, 4247.069522029805, 4259.16946195492, 4260.7656578888145, 4275.828966841338, 4293.248681480744, 4221.113566151112, 4229.471316085489, 4234.9153016939645, 4240.3851441540955, 4260.1266740318315, 4137.296659567895, 4197.580241975808, 4213.178430206111, 4227.302495088306, 4227.323628219486, 3703.203811180609, 3708.479523395422, 3714.517112775349, 3714.9442758358646, 3717.4609681596016, 5328.147496400596, 5368.463153684639, 5379.623426360156, 5397.352317721859, 5400.541853699479, 4699.921551383849, 4776.785044672998, 4825.276208568707, 4826.517348265181, 4861.0, 5683.630564013326, 5697.344805347397, 5708.343540492813, 5736.168255602956, 5738.942610573882, 4043.1711499142607, 4049.1496785675045, 4051.4327994080854, 4056.4320995060716, 4058.6144316289906, 5728.541716662657, 5858.707064646751, 5935.258092738408, 5980.282366116094, 5982.341942386334, 4095.2219078375015, 4096.795160242035, 4102.815373308149, 4110.7328023678365, 4125.071858831739, 4170.436086467575, 4173.64524015456, 4205.939089845953, 4258.510271318838, 4260.701750877471, 4554.0, 4765.714057156512, 4845.854624361275, 4878.390201224847, 4881.9511804881495, 5701.258836351248, 5719.19931209631, 5733.4519679686255, 5744.822311426147, 5824.504917082011, 1368.3773882883265, 1378.3459848182222, 1378.3521744779937, 1382.025671901307, 1382.7165431086603, 877.3507604372846, 925.3522534225934, 946.7065209784988, 946.9337146399823, 954.2604481526733, 5202.271681964528, 5241.191788832846, 5301.761420736076, 5321.308229930161, 5353.705546194997, 5620.690862002629, 5655.0, 5683.403242659544, 5688.374278829326, 5707.8858422832145, 5164.32863727713, 5325.794132449103, 5334.333208348957, 5400.702961337164, 5417.729113544386, 3024.7126522980284, 3029.560713696502, 3032.969670303313, 3037.9392412151633, 3047.3143542703156, 5875.559333050039, 5881.3530511643685, 5896.823095307148, 5897.115432685132, 5918.852028699231, 5526.104096611879, 5733.598648094593, 5750.6837123958585, 5758.0, 5780.277465316835, 5777.88444231113, 5828.213191219216, 5837.307180917572, 5859.5936975126515, 5869.295684517885, 5584.664920104807, 5601.439856014366, 5668.234788303526, 5678.545716342765, 5871.266091738533, 5802.854928626818, 5878.470937615635, 5892.026171232685, 5906.468417842415, 5914.585978981602, 6138.416850399205, 6179.28938172116, 6182.0, 6188.8762224754355, 6196.318404975359, 3903.1998440320235, 4051.655609273127, 4105.281575724296, 4110.445089912943, 4149.232392007489, 5870.354261031198, 5902.940970590411, 5908.586398952032, 5916.319623243382, 5984.401559843981, 5540.889182216414, 5720.113515431023, 5777.306723193244, 5803.419658034331, 5816.82549523515, 5664.773409063756, 5687.289088863892, 5692.097030514385, 5705.971470142788, 5725.421611492817, 5669.829905102853, 5687.459691329483, 5695.658260504383, 5722.771089156554, 5731.8567035824435, 5577.219189313419, 5804.912926306024, 5814.331351894417, 5820.563457740602, 5847.26909136358, 5694.686792226467, 5703.372629010722, 5724.79963201286, 5733.559864081684, 5738.282714660668], "value": 4309.283269167808, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.9187697476303, 683.9863202735945, 694.3369082526189, 734.9930595084735, 800.7157459102019, 15001.0, 15009.399624015026, 15494.302756375962, 15938.920305398486, 15949.920250398747, 14713.337899794507, 14766.261686915665, 14868.107913525197, 14888.478903238389, 14897.03169293995, 785.2736218997433, 797.330242596219, 797.3461761355691, 798.1340245833278, 799.3804801278997, 787.8227398835273, 819.1317203764029, 819.4550623835142, 825.6532256452274, 825.7192554531458, 858.3733874271785, 860.3031544449017, 861.8190180062163, 862.7282406042077, 865.1910463716446, 856.9742907712747, 857.9099194584542, 859.7807559072459, 859.866720658299, 860.7460799064291, 624.7782037376711, 625.4183609243402, 626.2735227136545, 626.9811905642838, 628.7107930352043, 15408.844336674794, 15668.921655391765, 15750.606234844221, 15839.12884791336, 15897.841021589751, 13432.0, 14117.235345581803, 14646.780298295535, 14671.55985320442, 14915.850841491663, 12516.249025058434, 12955.0, 13036.217826930415, 13280.800787988188, 13524.32378381077, 4287.356896465524, 4315.093830295642, 4337.674674399433, 4571.9085618287445, 4585.426821647294, 82549.9999999994, 82776.58611706963, 83031.5848420754, 83226.58386708089, 83577.58211208905, 10768.318154401355, 11107.0, 11197.0, 11255.268407553483, 11322.26405283654, 20335.694964575545, 20665.58668826615, 20912.058957346955, 21020.0, 21070.15719371208, 7468.887966680504, 7681.961590192125, 7783.727569535039, 7976.840463190703, 8019.719309824245, 4451.666125040635, 4543.227651299287, 4578.45058592971, 4603.286490593963, 4615.561521655437, 3450.654934506529, 3562.4656301554974, 3573.6605022522817, 3592.6227746086283, 3609.675129238381, 615.3446579392933, 621.9626822390671, 626.0609086370445, 626.6021076616381, 630.8107567729663, 580.2833500626723, 641.3169973977699, 642.6529673976, 645.8579112595221, 660.3561527510735, 9196.632134714537, 9242.76893077665, 9398.718038458721, 9404.38871473352, 9678.322517423712, 585.379497732405, 595.7110801261384, 605.12257227021, 637.200313606421, 688.5490004047357, 4450.977745111254, 4554.476235232991, 4596.448426188878, 4802.711837289774, 5006.799728010911, 83899.5805020971, 85236.57381713176, 85247.57376213079, 85912.57043714741, 87129.0, 74990.0, 75304.0, 75521.0, 75814.62092689502, 76657.23342766613, 55784.442155577926, 66142.66928665325, 68233.0, 69477.65261173763, 71185.28814711787, 9781.168600668738, 9801.362911410735, 9861.887684611344, 10017.599296028076, 10147.644832431124, 44889.77555112204, 44912.0, 45783.0, 46134.30798537957, 46965.47758918163, 64711.67644161749, 65753.34246657472, 66421.66789166024, 67348.0, 68010.15867937136, 12631.621051368473, 12743.49026038948, 13039.869601304244, 13094.0, 13099.158068303666, 13561.0, 13862.0, 14256.215908124737, 15419.812399908238, 15568.532944011698, 12500.812487812509, 12750.553730619384, 12821.423035963591, 12851.293178875252, 13269.459888800482, 13004.349782510648, 14466.349014294172, 14512.1292722437, 14531.491397801026, 14894.925525372304, 13023.674408139872, 13447.193168409536, 13449.125806822525, 13911.165330080228, 13941.163530188222, 10941.28881622692, 11119.388433636228, 11394.886051139383, 11413.162888245082, 11619.498815609026, 9979.643562775522, 10493.344554386395, 11448.771024579295, 11628.127890408085, 11737.823932641188], "value": 7314.37429553716, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 113.0, 112.0, 113.0, 112.0, 113.0, 112.0, 111.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 130.0, 130.0, 173.0, 128.0, 131.0, 130.0, 127.0, 152.0, 133.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 169.0, 167.0, 162.0, 166.0, 163.0, 165.0, 162.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 109.0, 77.0, 75.0, 76.0, 76.0, 95.0, 76.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 103.0, 83.0, 83.0, 83.0, 102.0, 82.0, 83.0, 99.0], "value": 88.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 121.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 149.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 97.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 53.0, 53.0, 54.0, 53.0, 56.0, 54.0, 54.0, 57.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 63.0, 63.0, 63.0, 63.0, 62.0, 64.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 81.0, 81.0, 82.0, 82.0, 82.0, 82.0, 81.0, 82.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 144.0, 137.0, 142.0, 134.0, 146.0, 139.0, 134.0, 182.0, 136.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 176.0, 170.0, 169.0, 177.0, 171.0, 174.0, 172.0, 175.0, 176.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 69.0, 70.0, 67.0, 67.0, 67.0, 70.0, 67.0, 65.0], "value": 68.2, "unit": "score"}]}]} 09:42:36 INFO - Return code: 0 09:42:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:42:36 ERROR - # TBPL SUCCESS # 09:42:36 INFO - Running post-action listener: _resource_record_post_action 09:42:36 INFO - [mozharness: 2016-11-30 17:42:36.971239Z] Finished run-tests step (success) 09:42:36 INFO - Running post-run listener: _resource_record_post_run 09:42:37 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 404709376; Read time: 0; Write time: 309952 09:42:37 INFO - TinderboxPrint: CPU usage
13.4% 09:42:37 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:42:37 INFO - TinderboxPrint: I/O write bytes / time
404,709,376 / 309,952 09:42:37 INFO - TinderboxPrint: CPU idle
8,261.9 (86.6%) 09:42:37 INFO - TinderboxPrint: CPU user
1,220.6 (12.8%) 09:42:37 INFO - TinderboxPrint: Swap in / out
0 / 0 09:42:37 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115748864; Read time: 0; Write time: 97920 09:42:37 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288960512; Read time: 0; Write time: 212032 09:42:37 INFO - Running post-run listener: _upload_blobber_files 09:42:37 INFO - Blob upload gear active. 09:42:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:42:37 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:42:37 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:42:37 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:42:38 INFO - (blobuploader) - INFO - Open directory for files ... 09:42:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:42:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:42:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:42:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:42:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:42:38 INFO - (blobuploader) - INFO - Done attempting. 09:42:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:42:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:42:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:42:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:42:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:42:41 INFO - (blobuploader) - INFO - Done attempting. 09:42:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:42:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:42:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:42:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:42:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:42:42 INFO - (blobuploader) - INFO - Done attempting. 09:42:42 INFO - (blobuploader) - INFO - Iteration through files over. 09:42:42 INFO - Return code: 0 09:42:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:42:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:42:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f804d9140fcca0e49fbd07bd37ddf8fbdbdf70a2195de7931d5621062ceb6d1e9c022ef037285455cb18752b49cbb072c99fd99e897c9d199b6073eb4b0e9c86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0995b3e12d924da77e415573af2fbc075008b87ef1d6600e89f59a1e656577d67dfce6ce162542ebb5ff24798d5e8998e2a1f56ef74a2ced3d82b3998c7dc230", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/95d2aada42249e2e894c8534bafba5e8a3fa8598b31195e8cd55c2050f83bf10308891b35f10dc6225786d32da4334d324ae308a745eec8d112bfc2f0b23d134"} 09:42:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:42:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:42:42 INFO - Contents: 09:42:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f804d9140fcca0e49fbd07bd37ddf8fbdbdf70a2195de7931d5621062ceb6d1e9c022ef037285455cb18752b49cbb072c99fd99e897c9d199b6073eb4b0e9c86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0995b3e12d924da77e415573af2fbc075008b87ef1d6600e89f59a1e656577d67dfce6ce162542ebb5ff24798d5e8998e2a1f56ef74a2ced3d82b3998c7dc230", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/95d2aada42249e2e894c8534bafba5e8a3fa8598b31195e8cd55c2050f83bf10308891b35f10dc6225786d32da4334d324ae308a745eec8d112bfc2f0b23d134"} 09:42:42 INFO - Running post-run listener: copy_logs_to_upload_dir 09:42:42 INFO - Copying logs to upload dir... 09:42:42 INFO - mkdir: /builds/slave/test/build/upload/logs 09:42:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.496974 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-30 09:42:42.561101) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 09:42:42.569159) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f804d9140fcca0e49fbd07bd37ddf8fbdbdf70a2195de7931d5621062ceb6d1e9c022ef037285455cb18752b49cbb072c99fd99e897c9d199b6073eb4b0e9c86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0995b3e12d924da77e415573af2fbc075008b87ef1d6600e89f59a1e656577d67dfce6ce162542ebb5ff24798d5e8998e2a1f56ef74a2ced3d82b3998c7dc230", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/95d2aada42249e2e894c8534bafba5e8a3fa8598b31195e8cd55c2050f83bf10308891b35f10dc6225786d32da4334d324ae308a745eec8d112bfc2f0b23d134"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011256 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480505403/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f804d9140fcca0e49fbd07bd37ddf8fbdbdf70a2195de7931d5621062ceb6d1e9c022ef037285455cb18752b49cbb072c99fd99e897c9d199b6073eb4b0e9c86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0995b3e12d924da77e415573af2fbc075008b87ef1d6600e89f59a1e656577d67dfce6ce162542ebb5ff24798d5e8998e2a1f56ef74a2ced3d82b3998c7dc230", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/95d2aada42249e2e894c8534bafba5e8a3fa8598b31195e8cd55c2050f83bf10308891b35f10dc6225786d32da4334d324ae308a745eec8d112bfc2f0b23d134"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 09:42:42.601743) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 09:42:42.602078) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1480524124.877891-2102102070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 09:42:42.682852) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 09:42:42.683218) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 09:42:42.683532) ========= ========= Total master_lag: 0.20 =========