builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1480521969.73 results: success (0) buildid: 20161130080515 builduid: 28ea6cf5789a4239bc800a7651b219f3 revision: fcc2e4e18962ccd980f62e5d88f9426c363c1c9f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 08:06:09.737941) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 08:06:09.738400) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 08:06:09.738687) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 08:06:09.756546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 08:06:09.756817) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-30 08:06:10-- 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% 220M=0s 2016-11-30 08:06:10 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.102280 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 08:06:09.872831) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 08:06:09.873198) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017451 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 08:06:09.923175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 08:06:09.923579) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-30 08:06:10,485 truncating revision to first 12 chars 2016-11-30 08:06:10,485 Setting DEBUG logging. 2016-11-30 08:06:10,485 attempt 1/10 2016-11-30 08:06:10,485 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 08:06:11,028 unpacking tar archive at: mozilla-inbound-fcc2e4e18962/testing/mozharness/ program finished with exit code 0 elapsedTime=0.840660 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 08:06:10.777938) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 08:06:10.778444) ========= script_repo_revision: fcc2e4e18962ccd980f62e5d88f9426c363c1c9f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 08:06:10.779099) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 08:06:10.779591) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 08:06:10.790373) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-30 08:06:10.790747) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:06:11 INFO - MultiFileLogger online at 20161130 08:06:11 in /builds/slave/test 08:06:11 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 08:06:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:06:11 INFO - {'append_to_log': False, 08:06:11 INFO - 'base_work_dir': '/builds/slave/test', 08:06:11 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 08:06:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:06:11 INFO - 'branch': 'Mozilla-Inbound', 08:06:11 INFO - 'buildbot_json_path': 'buildprops.json', 08:06:11 INFO - 'config_files': ('talos/linux_config.py',), 08:06:11 INFO - 'default_actions': ('clobber', 08:06:11 INFO - 'read-buildbot-config', 08:06:11 INFO - 'download-and-extract', 08:06:11 INFO - 'populate-webroot', 08:06:11 INFO - 'create-virtualenv', 08:06:11 INFO - 'install', 08:06:11 INFO - 'run-tests'), 08:06:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:06:11 INFO - 'download_minidump_stackwalk': True, 08:06:11 INFO - 'download_symbols': 'ondemand', 08:06:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:06:11 INFO - 'tooltool.py': '/tools/tooltool.py', 08:06:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:06:11 INFO - '/tools/misc-python/virtualenv.py')}, 08:06:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:06:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:06:11 INFO - 'installer_path': 'installer.exe', 08:06:11 INFO - 'log_level': 'info', 08:06:11 INFO - 'log_name': 'talos', 08:06:11 INFO - 'log_to_console': True, 08:06:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:06:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:06:11 INFO - 'opt_config_files': (), 08:06:11 INFO - 'pip_index': False, 08:06:11 INFO - 'sps_profile': False, 08:06:11 INFO - 'sps_profile_interval': 0, 08:06:11 INFO - 'suite': 'dromaeojs-e10s', 08:06:11 INFO - 'system_bits': '32', 08:06:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:06:11 INFO - 'title': 'talos-linux64-ix-062', 08:06:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:06:11 INFO - 'use_talos_json': True, 08:06:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:06:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:06:11 INFO - 'work_dir': 'build'} 08:06:11 INFO - [mozharness: 2016-11-30 16:06:11.459185Z] Running clobber step. 08:06:11 INFO - Running pre-action listener: _resource_record_pre_action 08:06:11 INFO - Running main action method: clobber 08:06:11 INFO - rmtree: /builds/slave/test/build 08:06:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:06:12 INFO - Running post-action listener: _resource_record_post_action 08:06:12 INFO - [mozharness: 2016-11-30 16:06:12.435429Z] Finished clobber step (success) 08:06:12 INFO - [mozharness: 2016-11-30 16:06:12.435527Z] Running read-buildbot-config step. 08:06:12 INFO - Running pre-action listener: _resource_record_pre_action 08:06:12 INFO - Running main action method: read_buildbot_config 08:06:12 INFO - Using buildbot properties: 08:06:12 INFO - { 08:06:12 INFO - "project": "", 08:06:12 INFO - "product": "firefox", 08:06:12 INFO - "script_repo_revision": "production", 08:06:12 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 08:06:12 INFO - "repository": "", 08:06:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 08:06:12 INFO - "buildid": "20161130080515", 08:06:12 INFO - "stage_platform": "linux64-pgo", 08:06:12 INFO - "basedir": "/builds/slave/test", 08:06:12 INFO - "buildnumber": 2181, 08:06:12 INFO - "platform": "ubuntu64_hw", 08:06:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:06:12 INFO - "slavebuilddir": "test", 08:06:12 INFO - "branch": "mozilla-inbound", 08:06:12 INFO - "revision": "fcc2e4e18962ccd980f62e5d88f9426c363c1c9f", 08:06:12 INFO - "slavename": "talos-linux64-ix-062", 08:06:12 INFO - "builduid": "28ea6cf5789a4239bc800a7651b219f3", 08:06:12 INFO - "repo_path": "integration/mozilla-inbound" 08:06:12 INFO - } 08:06:12 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. 08:06:12 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. 08:06:12 INFO - Running post-action listener: _resource_record_post_action 08:06:12 INFO - [mozharness: 2016-11-30 16:06:12.437896Z] Finished read-buildbot-config step (success) 08:06:12 INFO - [mozharness: 2016-11-30 16:06:12.437984Z] Running download-and-extract step. 08:06:12 INFO - Running pre-action listener: _resource_record_pre_action 08:06:12 INFO - Running main action method: download_and_extract 08:06:12 INFO - mkdir: /builds/slave/test/build/tests 08:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:12 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 08:06:12 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 08:06:12 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 08:06:12 INFO - Downloaded 1361 bytes. 08:06:12 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:06:12 INFO - Using the following test package requirements: 08:06:12 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:06:12 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:06:12 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:06:12 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:12 INFO - u'jsshell-linux-x86_64.zip'], 08:06:12 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:06:12 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:06:12 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:06:12 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:06:12 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:06:12 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:06:12 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:06:12 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 08:06:12 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 08:06:12 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 08:06:12 INFO - Http code: 200 08:06:12 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 08:06:12 INFO - x-amz-cf-id: BnZD48K6Oi59i5iQpgy5yNbiFi3dHBA9k90fPxkBS3IeUK1GgaJVfg== 08:06:12 INFO - x-amz-replication-status: COMPLETED 08:06:12 INFO - x-amz-version-id: PGy.voT7TUROTj2wwZlpk8ix3DjjOmqW 08:06:12 INFO - Expected file size: 21783183 08:06:12 INFO - Obtained file size: 21783183 08:06:16 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 08:06:16 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 08:06:16 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 08:06:16 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 08:06:16 INFO - Http code: 200 08:06:16 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 08:06:16 INFO - x-amz-cf-id: wOa2RVCwJEVZcKz7h4iiUssWHeW6rT1phOB6PccPlCOdnkRh7bxegQ== 08:06:16 INFO - x-amz-replication-status: COMPLETED 08:06:16 INFO - x-amz-version-id: PGy.voT7TUROTj2wwZlpk8ix3DjjOmqW 08:06:17 INFO - Expected file size: 21783183 08:06:17 INFO - Obtained file size: 21783183 08:06:21 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 08:06:21 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 08:06:21 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 08:06:21 INFO - Http code: 200 08:06:21 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 08:06:21 INFO - x-amz-cf-id: 8nNKNSRu7_2LiIZxUG-JGoSZc-8dQjHBhcpDdUtpXQVIyCUPqIwApg== 08:06:21 INFO - x-amz-replication-status: COMPLETED 08:06:21 INFO - x-amz-version-id: M41MZHZMwUOdx3tilZHyTSL_OGlfpoUn 08:06:21 INFO - Expected file size: 14409702 08:06:21 INFO - Obtained file size: 14409702 08:06: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')]} 08:06:22 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 08:06:22 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 08:06:22 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 08:06:22 INFO - Downloaded 59776050 bytes. 08:06:22 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 08:06:22 INFO - mkdir: /builds/slave/test/properties 08:06:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:06:22 INFO - Writing to file /builds/slave/test/properties/build_url 08:06:22 INFO - Contents: 08:06:22 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 08:06:22 INFO - Running post-action listener: _resource_record_post_action 08:06:22 INFO - Running post-action listener: set_extra_try_arguments 08:06:22 INFO - [mozharness: 2016-11-30 16:06:22.941934Z] Finished download-and-extract step (success) 08:06:22 INFO - [mozharness: 2016-11-30 16:06:22.942160Z] Running populate-webroot step. 08:06:22 INFO - Running pre-action listener: _resource_record_pre_action 08:06:22 INFO - Running main action method: populate_webroot 08:06:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:06:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:06:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:06:22 INFO - '--tppagecycles', 08:06:22 INFO - '7'], 08:06:22 INFO - 'tests': ['tsvgm']}}, 08:06:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:06:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:06:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:06:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:06:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:06:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:06:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:06:22 INFO - 'talos_options': ['--disable-e10s'], 08:06:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:06:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:06:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:06:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:06:22 INFO - 'talos_options': ['--disable-e10s'], 08:06:22 INFO - 'tests': ['damp', 'tps']}, 08:06:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:06:22 INFO - 'tests': ['damp', 'tps']}, 08:06:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:06:22 INFO - 'tests': ['dromaeo_dom']}, 08:06:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:06:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:06:22 INFO - 'tests': ['basic_compositor_video']}, 08:06:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:06:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:06:22 INFO - 'tests': ['a11yr', 08:06:22 INFO - 'ts_paint', 08:06:22 INFO - 'tpaint', 08:06:22 INFO - 'sessionrestore', 08:06:22 INFO - 'sessionrestore_no_auto_restore', 08:06:22 INFO - 'tabpaint']}, 08:06:22 INFO - 'other-e10s': {'tests': ['a11yr', 08:06:22 INFO - 'ts_paint', 08:06:22 INFO - 'tpaint', 08:06:22 INFO - 'sessionrestore', 08:06:22 INFO - 'sessionrestore_no_auto_restore', 08:06:22 INFO - 'tabpaint']}, 08:06:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:06:22 INFO - 'ts_paint', 08:06:22 INFO - 'tpaint', 08:06:22 INFO - 'sessionrestore', 08:06:22 INFO - 'sessionrestore_no_auto_restore', 08:06:22 INFO - 'tabpaint']}, 08:06:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:06:22 INFO - 'ts_paint', 08:06:22 INFO - 'tpaint', 08:06:22 INFO - 'sessionrestore', 08:06:22 INFO - 'sessionrestore_no_auto_restore', 08:06:22 INFO - 'tabpaint']}, 08:06:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:06:22 INFO - 'tests': ['a11yr', 08:06:22 INFO - 'ts_paint', 08:06:22 INFO - 'tpaint', 08:06:22 INFO - 'sessionrestore', 08:06:22 INFO - 'sessionrestore_no_auto_restore', 08:06:22 INFO - 'tabpaint']}, 08:06:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:06:22 INFO - 'tests': ['a11yr', 08:06:22 INFO - 'ts_paint', 08:06:22 INFO - 'tpaint', 08:06:22 INFO - 'sessionrestore', 08:06:22 INFO - 'sessionrestore_no_auto_restore', 08:06:22 INFO - 'tabpaint']}, 08:06:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:06:22 INFO - 'tests': ['tsvgx', 08:06:22 INFO - 'tsvgr_opacity', 08:06:22 INFO - 'tart', 08:06:22 INFO - 'tscrollx', 08:06:22 INFO - 'cart', 08:06:22 INFO - 'tsvg_static']}, 08:06:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:06:22 INFO - 'tsvgr_opacity', 08:06:22 INFO - 'tart', 08:06:22 INFO - 'tscrollx', 08:06:22 INFO - 'cart', 08:06:22 INFO - 'tsvg_static']}, 08:06:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:06:22 INFO - 'talos_options': ['--disable-e10s'], 08:06:22 INFO - 'tests': ['tp5o']}, 08:06:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:06:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:06:22 INFO - 'talos_options': ['--disable-e10s', 08:06:22 INFO - '--xperf_path', 08:06:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:06:22 INFO - 'tests': ['tp5n']}, 08:06:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:06:22 INFO - 'talos_options': ['--xperf_path', 08:06:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:06:22 INFO - 'tests': ['tp5n']}}, 08:06:22 INFO - 'talos.zip': {'path': '', 08:06:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:06:22 INFO - Running post-action listener: _resource_record_post_action 08:06:22 INFO - [mozharness: 2016-11-30 16:06:22.963074Z] Finished populate-webroot step (success) 08:06:22 INFO - [mozharness: 2016-11-30 16:06:22.963163Z] Running create-virtualenv step. 08:06:22 INFO - Running pre-action listener: _resource_record_pre_action 08:06:22 INFO - Running main action method: create_virtualenv 08:06:22 INFO - Creating virtualenv /builds/slave/test/build/venv 08:06:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:06:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:06:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:06:23 INFO - Using real prefix '/usr' 08:06:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:06:23 INFO - Installing distribute.............................................................................................................................................................................................done. 08:06:25 INFO - Installing pip.................done. 08:06:25 INFO - Return code: 0 08:06:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:06:25 INFO - Reading from file tmpfile_stdout 08:06:25 INFO - Output received: 08:06:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:06:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:06: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')]} 08:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06: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')]} 08:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb109c01e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162efc0>, '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 0x162fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1630350>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06: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', 'pip>=1.5'] in /builds/slave/test/build 08:06: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 pip>=1.5 08:06:25 INFO - Using env: {'DISPLAY': ':0', 08:06:25 INFO - 'HOME': '/home/cltbld', 08:06:25 INFO - 'LANG': 'en_US.UTF-8', 08:06:25 INFO - 'LANGUAGE': 'en_US:en', 08:06:25 INFO - 'LOGNAME': 'cltbld', 08:06:25 INFO - 'MAIL': '/var/mail/cltbld', 08:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:25 INFO - 'MOZ_NO_REMOTE': '1', 08:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:25 INFO - 'NO_EM_RESTART': '1', 08:06:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:25 INFO - 'PWD': '/builds/slave/test', 08:06:25 INFO - 'SHELL': '/bin/bash', 08:06:25 INFO - 'SHLVL': '1', 08:06:25 INFO - 'TERM': 'linux', 08:06:25 INFO - 'TMOUT': '86400', 08:06:25 INFO - 'USER': 'cltbld', 08:06:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 08:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:25 INFO - '_': '/tools/buildbot/bin/python'} 08:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:06:25 INFO - Cleaning up... 08:06:25 INFO - Return code: 0 08:06:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:06: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')]} 08:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06: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')]} 08:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06: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', '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 0x7fb109c01e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162efc0>, '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 0x162fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1630350>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:06: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 psutil>=3.1.1 08:06:25 INFO - Using env: {'DISPLAY': ':0', 08:06:25 INFO - 'HOME': '/home/cltbld', 08:06:25 INFO - 'LANG': 'en_US.UTF-8', 08:06:25 INFO - 'LANGUAGE': 'en_US:en', 08:06:25 INFO - 'LOGNAME': 'cltbld', 08:06:25 INFO - 'MAIL': '/var/mail/cltbld', 08:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:25 INFO - 'MOZ_NO_REMOTE': '1', 08:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:25 INFO - 'NO_EM_RESTART': '1', 08:06:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:25 INFO - 'PWD': '/builds/slave/test', 08:06:25 INFO - 'SHELL': '/bin/bash', 08:06:25 INFO - 'SHLVL': '1', 08:06:25 INFO - 'TERM': 'linux', 08:06:25 INFO - 'TMOUT': '86400', 08:06:25 INFO - 'USER': 'cltbld', 08:06:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 08:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:25 INFO - '_': '/tools/buildbot/bin/python'} 08:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:26 INFO - Downloading/unpacking psutil>=3.1.1 08:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:06:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:06:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:06:28 INFO - Installing collected packages: psutil 08:06:28 INFO - Running setup.py install for psutil 08:06:28 INFO - building 'psutil._psutil_linux' extension 08:06:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:06:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:06:28 INFO - building 'psutil._psutil_posix' extension 08:06:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:06:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:06:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:06:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:06:28 INFO - Successfully installed psutil 08:06:28 INFO - Cleaning up... 08:06:28 INFO - Return code: 0 08:06:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb109c01e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162efc0>, '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 0x162fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1630350>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:06: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 mozsystemmonitor==0.3 08:06:28 INFO - Using env: {'DISPLAY': ':0', 08:06:28 INFO - 'HOME': '/home/cltbld', 08:06:28 INFO - 'LANG': 'en_US.UTF-8', 08:06:28 INFO - 'LANGUAGE': 'en_US:en', 08:06:28 INFO - 'LOGNAME': 'cltbld', 08:06:28 INFO - 'MAIL': '/var/mail/cltbld', 08:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:28 INFO - 'MOZ_NO_REMOTE': '1', 08:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:28 INFO - 'NO_EM_RESTART': '1', 08:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:28 INFO - 'PWD': '/builds/slave/test', 08:06:28 INFO - 'SHELL': '/bin/bash', 08:06:28 INFO - 'SHLVL': '1', 08:06:28 INFO - 'TERM': 'linux', 08:06:28 INFO - 'TMOUT': '86400', 08:06:28 INFO - 'USER': 'cltbld', 08:06:28 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 08:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:28 INFO - '_': '/tools/buildbot/bin/python'} 08:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:06:31 INFO - Installing collected packages: mozsystemmonitor 08:06:31 INFO - Running setup.py install for mozsystemmonitor 08:06:31 INFO - Successfully installed mozsystemmonitor 08:06:31 INFO - Cleaning up... 08:06:31 INFO - Return code: 0 08:06:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:06: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')]} 08:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06: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')]} 08:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:31 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 0x7fb109c01e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162efc0>, '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 0x162fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1630350>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:06:31 INFO - Using env: {'DISPLAY': ':0', 08:06:31 INFO - 'HOME': '/home/cltbld', 08:06:31 INFO - 'LANG': 'en_US.UTF-8', 08:06:31 INFO - 'LANGUAGE': 'en_US:en', 08:06:31 INFO - 'LOGNAME': 'cltbld', 08:06:31 INFO - 'MAIL': '/var/mail/cltbld', 08:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:31 INFO - 'MOZ_NO_REMOTE': '1', 08:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:31 INFO - 'NO_EM_RESTART': '1', 08:06:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:31 INFO - 'PWD': '/builds/slave/test', 08:06:31 INFO - 'SHELL': '/bin/bash', 08:06:31 INFO - 'SHLVL': '1', 08:06:31 INFO - 'TERM': 'linux', 08:06:31 INFO - 'TMOUT': '86400', 08:06:31 INFO - 'USER': 'cltbld', 08:06:31 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 08:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:31 INFO - '_': '/tools/buildbot/bin/python'} 08:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:31 INFO - Downloading/unpacking jsonschema==2.5.1 08:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:06:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:33 INFO - Downloading functools32-3.2.3-2.tar.gz 08:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:06:33 INFO - warning: no files found matching '*.txt' 08:06:33 INFO - no previously-included directories found matching 'build' 08:06:33 INFO - no previously-included directories found matching 'dist' 08:06:33 INFO - no previously-included directories found matching '.git*' 08:06:33 INFO - Installing collected packages: jsonschema, functools32 08:06:33 INFO - Running setup.py install for functools32 08:06:33 INFO - warning: no files found matching '*.txt' 08:06:33 INFO - no previously-included directories found matching 'build' 08:06:33 INFO - no previously-included directories found matching 'dist' 08:06:33 INFO - no previously-included directories found matching '.git*' 08:06:33 INFO - Successfully installed jsonschema functools32 08:06:33 INFO - Cleaning up... 08:06:33 INFO - Return code: 0 08:06:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:33 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 0x7fb109c01e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162efc0>, '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 0x162fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1630350>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:06:33 INFO - Using env: {'DISPLAY': ':0', 08:06:33 INFO - 'HOME': '/home/cltbld', 08:06:33 INFO - 'LANG': 'en_US.UTF-8', 08:06:33 INFO - 'LANGUAGE': 'en_US:en', 08:06:33 INFO - 'LOGNAME': 'cltbld', 08:06:33 INFO - 'MAIL': '/var/mail/cltbld', 08:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:33 INFO - 'MOZ_NO_REMOTE': '1', 08:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:33 INFO - 'NO_EM_RESTART': '1', 08:06:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:33 INFO - 'PWD': '/builds/slave/test', 08:06:33 INFO - 'SHELL': '/bin/bash', 08:06:33 INFO - 'SHLVL': '1', 08:06:33 INFO - 'TERM': 'linux', 08:06:33 INFO - 'TMOUT': '86400', 08:06:33 INFO - 'USER': 'cltbld', 08:06:33 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 08:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:33 INFO - '_': '/tools/buildbot/bin/python'} 08:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:06:34 INFO - Cleaning up... 08:06:34 INFO - Return code: 0 08:06:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:34 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 0x7fb109c01e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162efc0>, '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 0x162fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1630350>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:06:34 INFO - Using env: {'DISPLAY': ':0', 08:06:34 INFO - 'HOME': '/home/cltbld', 08:06:34 INFO - 'LANG': 'en_US.UTF-8', 08:06:34 INFO - 'LANGUAGE': 'en_US:en', 08:06:34 INFO - 'LOGNAME': 'cltbld', 08:06:34 INFO - 'MAIL': '/var/mail/cltbld', 08:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:34 INFO - 'MOZ_NO_REMOTE': '1', 08:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:34 INFO - 'NO_EM_RESTART': '1', 08:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:34 INFO - 'PWD': '/builds/slave/test', 08:06:34 INFO - 'SHELL': '/bin/bash', 08:06:34 INFO - 'SHLVL': '1', 08:06:34 INFO - 'TERM': 'linux', 08:06:34 INFO - 'TMOUT': '86400', 08:06:34 INFO - 'USER': 'cltbld', 08:06:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 08:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:34 INFO - '_': '/tools/buildbot/bin/python'} 08:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:34 INFO - Downloading/unpacking blobuploader==1.2.4 08:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:36 INFO - Downloading blobuploader-1.2.4.tar.gz 08:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:06:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:06: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 08:06: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 08:06: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 08:06: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 08:06: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 08:06: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 08:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:06:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:06: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 08:06: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 08:06: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 08:06: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 08:06: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 08:06: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 08:06:37 INFO - Downloading docopt-0.6.1.tar.gz 08:06:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:06:37 INFO - Installing collected packages: blobuploader, requests, docopt 08:06:37 INFO - Running setup.py install for blobuploader 08:06:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:06:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:06:37 INFO - Running setup.py install for requests 08:06:37 INFO - Running setup.py install for docopt 08:06:37 INFO - Successfully installed blobuploader requests docopt 08:06:37 INFO - Cleaning up... 08:06:37 INFO - Return code: 0 08:06:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:37 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 0x7fb109c01e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162efc0>, '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 0x162fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1630350>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:06:37 INFO - Using env: {'DISPLAY': ':0', 08:06:37 INFO - 'HOME': '/home/cltbld', 08:06:37 INFO - 'LANG': 'en_US.UTF-8', 08:06:37 INFO - 'LANGUAGE': 'en_US:en', 08:06:37 INFO - 'LOGNAME': 'cltbld', 08:06:37 INFO - 'MAIL': '/var/mail/cltbld', 08:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:37 INFO - 'MOZ_NO_REMOTE': '1', 08:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:37 INFO - 'NO_EM_RESTART': '1', 08:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:37 INFO - 'PWD': '/builds/slave/test', 08:06:37 INFO - 'SHELL': '/bin/bash', 08:06:37 INFO - 'SHLVL': '1', 08:06:37 INFO - 'TERM': 'linux', 08:06:37 INFO - 'TMOUT': '86400', 08:06:37 INFO - 'USER': 'cltbld', 08:06:37 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 08:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:37 INFO - '_': '/tools/buildbot/bin/python'} 08:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:06:37 INFO - Running setup.py (path:/tmp/pip-mlhUP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:06:38 INFO - Running setup.py (path:/tmp/pip-0FjLHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:06:38 INFO - Running setup.py (path:/tmp/pip-3xBYUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:06:38 INFO - Running setup.py (path:/tmp/pip-7Qbn8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:06:38 INFO - Running setup.py (path:/tmp/pip-TXDtzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:06:38 INFO - Running setup.py (path:/tmp/pip-4bJvEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:06:38 INFO - Running setup.py (path:/tmp/pip-a6cQn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:06:38 INFO - Running setup.py (path:/tmp/pip-dsq0py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:06:38 INFO - Running setup.py (path:/tmp/pip-rz59HM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:06:38 INFO - Running setup.py (path:/tmp/pip-tqs57F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:06:38 INFO - Running setup.py (path:/tmp/pip-K3NWn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:06:38 INFO - Running setup.py (path:/tmp/pip-sByIvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:06:38 INFO - Running setup.py (path:/tmp/pip-noFObK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:06:38 INFO - Running setup.py (path:/tmp/pip-CMaQkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:38 INFO - Running setup.py (path:/tmp/pip-RNBK_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:06:39 INFO - Running setup.py (path:/tmp/pip-eDtkbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:06:39 INFO - Running setup.py (path:/tmp/pip-IcK4ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:06:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:06:39 INFO - Running setup.py install for manifestparser 08:06:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:06:39 INFO - Running setup.py install for mozcrash 08:06:39 INFO - Running setup.py install for mozdebug 08:06:39 INFO - Running setup.py install for mozdevice 08:06:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:06:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:06:39 INFO - Running setup.py install for mozfile 08:06:39 INFO - Running setup.py install for mozhttpd 08:06:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:06:39 INFO - Running setup.py install for mozinfo 08:06:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:06:39 INFO - Running setup.py install for mozInstall 08:06:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:06:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:06:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:06:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:06:40 INFO - Running setup.py install for mozleak 08:06:40 INFO - Running setup.py install for mozlog 08:06:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:06:40 INFO - Running setup.py install for moznetwork 08:06:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:06:40 INFO - Running setup.py install for mozprocess 08:06:40 INFO - Running setup.py install for mozprofile 08:06:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:06:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:06:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:06:40 INFO - Running setup.py install for mozrunner 08:06:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:06:40 INFO - Running setup.py install for mozscreenshot 08:06:40 INFO - Running setup.py install for moztest 08:06:40 INFO - Running setup.py install for mozversion 08:06:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:06:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:06:40 INFO - Cleaning up... 08:06:41 INFO - Return code: 0 08:06:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:41 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 0x7fb109c01e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162efc0>, '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 0x162fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1630350>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:06:41 INFO - Using env: {'DISPLAY': ':0', 08:06:41 INFO - 'HOME': '/home/cltbld', 08:06:41 INFO - 'LANG': 'en_US.UTF-8', 08:06:41 INFO - 'LANGUAGE': 'en_US:en', 08:06:41 INFO - 'LOGNAME': 'cltbld', 08:06:41 INFO - 'MAIL': '/var/mail/cltbld', 08:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:41 INFO - 'MOZ_NO_REMOTE': '1', 08:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:41 INFO - 'NO_EM_RESTART': '1', 08:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:41 INFO - 'PWD': '/builds/slave/test', 08:06:41 INFO - 'SHELL': '/bin/bash', 08:06:41 INFO - 'SHLVL': '1', 08:06:41 INFO - 'TERM': 'linux', 08:06:41 INFO - 'TMOUT': '86400', 08:06:41 INFO - 'USER': 'cltbld', 08:06:41 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 08:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:41 INFO - '_': '/tools/buildbot/bin/python'} 08:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:06:41 INFO - Running setup.py (path:/tmp/pip-Eeppyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:06:41 INFO - Running setup.py (path:/tmp/pip-v38vO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:06:41 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)) 08:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:06:41 INFO - Running setup.py (path:/tmp/pip-Fo6bqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:06:41 INFO - Running setup.py (path:/tmp/pip-JX5Qsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:06:41 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)) 08:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:06:41 INFO - Running setup.py (path:/tmp/pip-Rm6fyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:06:41 INFO - Running setup.py (path:/tmp/pip-r5GELu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:06:41 INFO - Running setup.py (path:/tmp/pip-6OLsUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:06:41 INFO - Running setup.py (path:/tmp/pip-ng4xlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:06:41 INFO - Running setup.py (path:/tmp/pip-4RgagV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:06:41 INFO - Running setup.py (path:/tmp/pip-XMP1hA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:06:41 INFO - Running setup.py (path:/tmp/pip-w5PhWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:06:42 INFO - Running setup.py (path:/tmp/pip-WaAkmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:06:42 INFO - Running setup.py (path:/tmp/pip-JyPQIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:06:42 INFO - Running setup.py (path:/tmp/pip-3K46Ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:06:42 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)) 08:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:42 INFO - Running setup.py (path:/tmp/pip-Vu_FVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:06:42 INFO - Running setup.py (path:/tmp/pip-XnLgAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:06:42 INFO - Running setup.py (path:/tmp/pip-zGKopC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:06:42 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)) 08:06:42 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)) 08:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:06:42 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)) 08:06:42 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)) 08:06:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:44 INFO - Downloading blessings-1.6.tar.gz 08:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:06:44 INFO - Installing collected packages: blessings 08:06:44 INFO - Running setup.py install for blessings 08:06:44 INFO - Successfully installed blessings 08:06:44 INFO - Cleaning up... 08:06:44 INFO - Return code: 0 08:06:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:06:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:06:44 INFO - Reading from file tmpfile_stdout 08:06:44 INFO - Current package versions: 08:06:44 INFO - argparse == 1.2.1 08:06:44 INFO - blessings == 1.6 08:06:44 INFO - blobuploader == 1.2.4 08:06:44 INFO - docopt == 0.6.1 08:06:44 INFO - functools32 == 3.2.3-2 08:06:44 INFO - jsonschema == 2.5.1 08:06:44 INFO - manifestparser == 1.1 08:06:44 INFO - mozInstall == 1.12 08:06:44 INFO - mozcrash == 1.0 08:06:44 INFO - mozdebug == 0.1 08:06:44 INFO - mozdevice == 0.49 08:06:44 INFO - mozfile == 1.2 08:06:44 INFO - mozhttpd == 0.7 08:06:44 INFO - mozinfo == 0.9 08:06:44 INFO - mozleak == 0.1 08:06:44 INFO - mozlog == 3.4 08:06:44 INFO - moznetwork == 0.27 08:06:44 INFO - mozprocess == 0.23 08:06:44 INFO - mozprofile == 0.28 08:06:44 INFO - mozrunner == 6.13 08:06:44 INFO - mozscreenshot == 0.1 08:06:44 INFO - mozsystemmonitor == 0.3 08:06:44 INFO - moztest == 0.7 08:06:44 INFO - mozversion == 1.4 08:06:44 INFO - psutil == 3.1.1 08:06:44 INFO - requests == 1.2.3 08:06:44 INFO - wsgiref == 0.1.2 08:06:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:44 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 0x7fb109c01e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162efc0>, '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 0x162fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1630350>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:06:44 INFO - Using env: {'DISPLAY': ':0', 08:06:44 INFO - 'HOME': '/home/cltbld', 08:06:44 INFO - 'LANG': 'en_US.UTF-8', 08:06:44 INFO - 'LANGUAGE': 'en_US:en', 08:06:44 INFO - 'LOGNAME': 'cltbld', 08:06:44 INFO - 'MAIL': '/var/mail/cltbld', 08:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:44 INFO - 'MOZ_NO_REMOTE': '1', 08:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:44 INFO - 'NO_EM_RESTART': '1', 08:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:44 INFO - 'PWD': '/builds/slave/test', 08:06:44 INFO - 'SHELL': '/bin/bash', 08:06:44 INFO - 'SHLVL': '1', 08:06:44 INFO - 'TERM': 'linux', 08:06:44 INFO - 'TMOUT': '86400', 08:06:44 INFO - 'USER': 'cltbld', 08:06:44 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 08:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:44 INFO - '_': '/tools/buildbot/bin/python'} 08:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:06:45 INFO - Cleaning up... 08:06:45 INFO - Return code: 0 08:06:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:45 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 0x7fb109c01e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162efc0>, '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 0x162fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1630350>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:06:45 INFO - Using env: {'DISPLAY': ':0', 08:06:45 INFO - 'HOME': '/home/cltbld', 08:06:45 INFO - 'LANG': 'en_US.UTF-8', 08:06:45 INFO - 'LANGUAGE': 'en_US:en', 08:06:45 INFO - 'LOGNAME': 'cltbld', 08:06:45 INFO - 'MAIL': '/var/mail/cltbld', 08:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:45 INFO - 'MOZ_NO_REMOTE': '1', 08:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:45 INFO - 'NO_EM_RESTART': '1', 08:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:45 INFO - 'PWD': '/builds/slave/test', 08:06:45 INFO - 'SHELL': '/bin/bash', 08:06:45 INFO - 'SHLVL': '1', 08:06:45 INFO - 'TERM': 'linux', 08:06:45 INFO - 'TMOUT': '86400', 08:06:45 INFO - 'USER': 'cltbld', 08:06:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 08:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:45 INFO - '_': '/tools/buildbot/bin/python'} 08:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:06:45 INFO - Cleaning up... 08:06:45 INFO - Return code: 0 08:06:45 INFO - Running post-action listener: _resource_record_post_action 08:06:45 INFO - Running post-action listener: _start_resource_monitoring 08:06:45 INFO - Starting resource monitoring. 08:06:45 INFO - [mozharness: 2016-11-30 16:06:45.456970Z] Finished create-virtualenv step (success) 08:06:45 INFO - [mozharness: 2016-11-30 16:06:45.457443Z] Running install step. 08:06:45 INFO - Running pre-action listener: _resource_record_pre_action 08:06:45 INFO - Running main action method: install 08:06:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:06:45 INFO - Reading from file tmpfile_stdout 08:06:45 INFO - Detecting whether we're running mozinstall >=1.0... 08:06:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:06:45 INFO - Reading from file tmpfile_stdout 08:06:45 INFO - Output received: 08:06:45 INFO - Usage: mozinstall [options] installer 08:06:45 INFO - Options: 08:06:45 INFO - -h, --help show this help message and exit 08:06:45 INFO - -d DEST, --destination=DEST 08:06:45 INFO - Directory to install application into. [default: 08:06:45 INFO - "/builds/slave/test"] 08:06:45 INFO - --app=APP Application being installed. [default: firefox] 08:06:45 INFO - mkdir: /builds/slave/test/build/application 08:06:45 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'] 08:06:45 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 08:07:02 INFO - Reading from file tmpfile_stdout 08:07:02 INFO - Output received: 08:07:02 INFO - /builds/slave/test/build/application/firefox/firefox 08:07:02 INFO - Running post-action listener: _resource_record_post_action 08:07:02 INFO - [mozharness: 2016-11-30 16:07:02.749572Z] Finished install step (success) 08:07:02 INFO - [mozharness: 2016-11-30 16:07:02.749844Z] Running run-tests step. 08:07:02 INFO - Running pre-action listener: _resource_record_pre_action 08:07:02 INFO - Running main action method: run_tests 08:07:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:07:02 INFO - Python 2.7.3 08:07:02 INFO - Return code: 0 08:07:02 INFO - grabbing minidump binary from tooltool 08:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:02 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 0x162efc0>, '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 0x162fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1630350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:07:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:07:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:07:02 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:07:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:07:02 INFO - Return code: 0 08:07:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:07:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:07:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:07:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:07:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:07:02 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-062', '--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 08:07:02 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-062 --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 08:07:02 INFO - Using env: {'DISPLAY': ':0', 08:07:02 INFO - 'HOME': '/home/cltbld', 08:07:02 INFO - 'LANG': 'en_US.UTF-8', 08:07:02 INFO - 'LANGUAGE': 'en_US:en', 08:07:02 INFO - 'LOGNAME': 'cltbld', 08:07:02 INFO - 'MAIL': '/var/mail/cltbld', 08:07:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:07:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:02 INFO - 'MOZ_NO_REMOTE': '1', 08:07:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:02 INFO - 'NO_EM_RESTART': '1', 08:07:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:02 INFO - 'PWD': '/builds/slave/test', 08:07:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:07:02 INFO - 'SHELL': '/bin/bash', 08:07:02 INFO - 'SHLVL': '1', 08:07:02 INFO - 'TERM': 'linux', 08:07:02 INFO - 'TMOUT': '86400', 08:07:02 INFO - 'USER': 'cltbld', 08:07:02 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190', 08:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:02 INFO - '_': '/tools/buildbot/bin/python'} 08:07:02 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-062', '--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 08:07:03 INFO - mozversion application_buildid: 20161130033003 08:07:03 INFO - mozversion application_changeset: fcc2e4e18962ccd980f62e5d88f9426c363c1c9f 08:07:03 INFO - mozversion application_display_name: Nightly 08:07:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:07:03 INFO - mozversion application_name: Firefox 08:07:03 INFO - mozversion application_remotingname: firefox 08:07:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:07:03 INFO - mozversion application_vendor: Mozilla 08:07:03 INFO - mozversion application_version: 53.0a1 08:07:03 INFO - mozversion platform_buildid: 20161130033003 08:07:03 INFO - mozversion platform_changeset: fcc2e4e18962ccd980f62e5d88f9426c363c1c9f 08:07:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:07:03 INFO - mozversion platform_version: 53.0a1 08:07:03 INFO - using testdate: 1480522023 08:07:03 INFO - actual date: 1480522023 08:07:03 INFO - starting webserver on 'localhost:33310' 08:07:03 INFO - SUITE-START | Running 2 tests 08:07:03 INFO - TEST-START | dromaeo_css 08:07:03 INFO - operating with platform_type : linux_ 08:07:03 INFO - Initialising browser for dromaeo_css test... 08:07:03 INFO - TEST-INFO | started process 1811 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQFNWZ1/profile http://localhost:33310/getInfo.html) 08:07:07 INFO - PROCESS | 1811 | __metrics Screen width/height:1600/1200 08:07:07 INFO - PROCESS | 1811 | colorDepth:24 08:07:07 INFO - PROCESS | 1811 | Browser inner width/height: 1024/697 08:07:07 INFO - PROCESS | 1811 | __metrics 08:07:07 ERROR - PROCESS | 1811 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 08:07:08 INFO - TEST-INFO | 1811: exit 0 08:07:08 INFO - Browser initialized. 08:07:08 INFO - Running cycle 1/1 for dromaeo_css test... 08:07:08 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQFNWZ1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:07:20 INFO - PROCESS | 1939 | RSS: Main: 187023360 08:07:20 INFO - PROCESS | 1939 | 08:08:10 INFO - PROCESS | 1939 | 1480522090428 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:10:21 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:33310/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33310/tests/dromaeo/cssquery-ext.html) 08:10:23 INFO - PROCESS | 1939 | RSS: Main: 198631424 08:10:23 INFO - PROCESS | 1939 | 08:13:25 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:33310/tests/dromaeo/cssquery-ext.html (next: http://localhost:33310/tests/dromaeo/cssquery-jquery.html) 08:13:26 INFO - PROCESS | 1939 | RSS: Main: 198209536 08:13:26 INFO - PROCESS | 1939 | 08:16:28 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:33310/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33310/tests/dromaeo/cssquery-mootools.html) 08:16:29 INFO - PROCESS | 1939 | RSS: Main: 200491008 08:16:29 INFO - PROCESS | 1939 | 08:19:31 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:33310/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33310/tests/dromaeo/cssquery-prototype.html) 08:19:31 INFO - PROCESS | 1939 | RSS: Main: 196874240 08:19:31 INFO - PROCESS | 1939 | 08:22:34 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:33310/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33310/tests/dromaeo/cssquery-yui.html) 08:22:34 INFO - PROCESS | 1939 | RSS: Main: 200724480 08:22:34 INFO - PROCESS | 1939 | 08:25:37 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:33310/tests/dromaeo/cssquery-yui.html (next: http://localhost:33310/tests/dromaeo/cssquery-dojo.html) 08:25:37 INFO - PROCESS | 1939 | RSS: Main: 201089024 08:25:37 INFO - PROCESS | 1939 | 08:25:37 INFO - PROCESS | 1939 | __start_tp_report 08:25:37 INFO - PROCESS | 1939 | _x_x_mozilla_page_load 08:25:37 INFO - PROCESS | 1939 | _x_x_mozilla_page_load_details 08:25:37 INFO - PROCESS | 1939 | |i|pagename|runs| 08:25:37 INFO - PROCESS | 1939 | |0;dojo.html;3143.0570828751374;3144.103930379842;3181;3191.5531825544444;3202.295494991102;5268;5405.945940540599;5454.972725136374;5497.39528651849;5518.255035570197;5340.893182136355;5348.46515348465;5469.72651367432;5541.168824676301;5569.805056823002;4915.778789954443;4921.753912304388;4991.700497970133;4995.325631039817;5044.545990860822;4891.437484689271;4980.078685443204;4988.226824842155;5112.233165025239;5130.358705161855;4828.227483602606;4849.030193961222;4960.578350840183;5025.597952163855;5035.219540971156;4905.754712264373;4910.779014944336;4913.820683036046;4920.089783390084;4935.6545041847085;4840.564349208553;4844.2733589961435;4855.32025516428;4865.19724245499;4905.4358748744;5257.13257312543;5308.840734777963;5330.413654498002;5332.413434522199;5364.865878353034;5779.682117483537;5794.797182098607;5806.187133801272;5819.7672093116225;5877.706114694248;5848.4151584841175;5851.210086638292;5862.179294898718;5869.706514674292;5870.618409803349;5288.894222115536;5363.892722145613;5370.489803468664;5424.647397919122;5453.945460545384;5842.737076831553;5919.763209471659;5945.227120474311;5954.642721436728;6095.207623008981;5741.741621627037;5750.424957504216;5754.625949313281;5756.481916627524;5767.394423585547;5654.830355089354;5812.3025236971835;5846.064629659234;5849.327327357323;5852.7658893643775;5674.858128546737;5731;5762.222100016528;5806.44838740319;5879.706014699248;5789.507891829157;5830.300363956352;5833.416658334218;5855.004649209644;5890;4486.506484286726;4495.664080328615;4510.300903359985;4512.661550383668;4548.204064288736;3873.9031524211555;3885.1258466844733;3979.243943650697;4008.8196031178086;4055.249778790874;5500.972495137578;5580.693061881636;5609.439056094439;5627.915581266284;5645.576581756384;5890.087036509348;5897.115432685046;5898.498627616701;5898.557608179403;5911.290645122613;5403.162509810985;5601.5238704710555;5606.579506537026;5640;5645.858853528694;4909.649846292226;5017.949820501822;5059.114654935372;5106.799902023022;5111.821086261963;6101.938980610137;6107.6640784757265;6109.84725381869;6111.663858487826;6124.969375153096;5823.679697616672;5828.242328497268;5875.353711091691;5889.411058894248;5889.411058894248;5889.352171261244;5918.260217472816;5920.200772895604;6010.42900924429;6019.54853385989;5677.74450149736;5681.318241810844;5713.085906254979;5719.256496655408;5724.771009159754;5821.650700957956;5859;5881.705914704162;5905.675187864708;5945.435183657545;5679.659220446786;5703.0589952659;5739.368669446274;5747.252857128547;5763.596548241583;5492.560595152298;5536.031194541019;5728.627639203439;5734.684592347461;5745.425457454221;5504.972475137759;5520.696361700145;5526.253955715927;5528.695921724344;5562.777488900399;5749.91375129365;5750.453706897838;5792.507636850746;5851.414858514115;5857.1799948008165;5659.405762394889;5667.858303542444;5699.857503562444;5700.401457847032;5703.8859222816145 08:25:37 INFO - PROCESS | 1939 | |1;ext.html;548.2379492505418;576.6367188671137;582.0425400216645;602.7528713227578;603.0020316376396;37132.25735485289;40708.59291407089;40859.38710919331;40862.59137408625;40993;41270.174596508055;42177.15645687092;42181;42293.57706422935;42307.3653895191;8387.790305242357;8616.65533378664;10248.74378140545;10518.579256829718;10548.997845204693;10220.335678180894;10404.63583774568;10418.374897506135;10419.895801041968;10440.634577789779;10383.688489345332;10430.322029068086;10455.895441045606;10484.31851929626;10491.632792852251;10384.688459346195;10402.583896644124;10453.320534165256;10473.109785668152;10490.423026733526;10304.278700490893;10317.380957142595;10318.38089714612;10351.482425878752;10370;41591.7920410399;42262;42491.787541062404;42566;42642.78678606618;3300.0924745695124;3313.4201514734823;3425.1094715373933;3620.312140693286;3709.1654377764785;30295.697043029508;30717.692823071706;30740.385192296028;30781.846090769628;31038.534421983688;4018.397240413932;4041.4341992121126;4099.61053699898;4183.288840897055;4322.092360604277;367981.9605411842;368942;369308;369694;369880;57738.7113064432;57753.6470988191;57906.710466447395;58179.127313090336;58863.70568147217;61522;61640;62045.68977155085;62204;62290.377096229364;15742.29159687794;16138.273777680033;16167.757483637755;16224.188790560425;16383.508494745176;12017.879821201675;12172;12466.065045121652;12532.498700052078;12598.307093109966;19380.452022204823;19453.90458223712;19505.906129133487;19539.609207815764;19557.307913058725;7285.271472852673;7484.363829074481;7589.468737188344;7752.961235193788;7766.922330776733;912.9634814607341;994.5474808961905;997.7156510394648;1034.0900007992918;1051.0698032241369;31813.8409307952;32227.838860805547;32228.83885580557;32314.515282270786;32744.836275818467;1039.4698703661036;1059.8622179116664;1138.8918052784973;1149.816029435303;1196.3599474281218;16601.66796664084;16625.418110366078;16667.666646667;16684.6663066738;17018.319267229173;498572;514281;516099;868117;870266;57251.71374143103;57871.71064144652;57955.42044579585;57955.42044579585;58170.709146454;1319.300770591588;1329.973400531984;1341.5706973768495;1351.5404762380838;1366.5626999360309;29944.339528873697;32503.512447312838;32509;32517.83741081374;33163.50254746229;49824;50179.74910125572;50374.2443863335;50380.99999999853;50385.74807125941;429086;435596;437986;438837;439762;27959.440811184068;28173.43653126967;28436.303280573393;28446.146615601567;28493.572596410657;45304.32043519416;45460.545394546956;46216.37836216486;46694.76652616715;47414.52585474101;38240;38627.2274554513;39244.80377598094;39614;40122.19755604813;38552.944809107794;38951.6104838948;39109.8044509787;39753;40260.1947961045;39498.40752388774;39895.40156897591;40110.39834402428;40599.59400405958;40624;33247.50128748119;35745;35791.82104089463;35803.82098089597;36411.81794091013;26844.194674159808;27693.169204923885;27726.44547109087;27781.583276251276;27789.58315625227 08:25:37 INFO - PROCESS | 1939 | |2;jquery.html;366.60223657331795;379.87843889955207;389.7271909663236;395.9980200098999;404.69243375034966;17327.826721732796;18884.15021324042;18895.62208755824;19161.23355065796;19406.02969851509;18473.44579662609;18699.813001869978;18887.24451021961;18927.52681182971;18964.5258868528;5338.412774594792;5390.353157621091;5577.2191893135;5583.441655834425;5589.832305030855;5439.864003399927;5450.345958484968;5484.232207490954;5504.146857237135;5564.944350556483;5430.511253987141;5454.154606036071;5468.91796623051;5502.752376143083;5527.226188333637;5665.065264231397;5836.153757705151;5839.8540036499;5841.56188285876;5842.678652674102;5414.620976531644;5515.420880807537;5547.3343198816;5611.7474713637985;5632.549396048306;13648.590542283748;13761.449542018307;17393.956362618283;21757;22303.21938732153;2149.623815832223;2216.2353987874317;2385.153270588933;2825.3784167483327;2928.1069273871462;10265.384076955406;10270.691879243635;11593;12071.336076515789;14523.20122393268;1860.627874425107;1902.771667399921;1905.6474552207885;1957.9314723984735;1987.3342430285873;75204.62397687977;78321.99999999943;78504.60747696282;80326;83027.5848620759;10823.350598964087;10829.783404331869;10873.619423320146;11230.606928757454;11317.547298108148;15286;15384.384624615113;15433.614159646098;15488.303026363841;15541.378344866305;7780.14418413974;7930.881036784453;8118.228768267005;8134.837303253902;8199.95900020496;7519;7583.355414789694;7691.423143264277;7729.420293478011;7843.803904902309;4523.909521809545;4696.38946936896;4712;4739.644526660514;4780.4741478437345;1800.8559315254747;1893.9053047347577;1932.1884808380514;1940.2142132436104;1964.5972575621963;862.2451268198047;951.3293128344501;966.1111777165025;1037.8028174646793;1057.1067448006422;18876.36651073066;19317.8068219316;19337.709934350994;19423.125959331865;19636.214551417783;989.1641562879355;998.7003898830321;1002.7242508310127;1030.7526193713604;1036.5853658536646;10146.289759716896;10577.903626624964;10750.462476876124;10771.353718776898;10784.40685762275;348448;437081;449089;450905;451692;92488.53755731178;95062.52468737612;95488.52255738676;97123.51438242763;99750;1006.4967516241879;1026.5380578739448;1067.3382502848283;1071.4535586850761;1082.767205050918;16814.495565133064;16869.831301687318;17454.389096381565;17747.911260443616;18061.548461288574;41179;41225.38161927513;41297.79351103225;41535;41907.2948328266;57544.71227643835;57845.421545784004;57947.710261448425;58743;59279;7948.960255198687;8095.55474448911;8295.211954864279;8376.246137847624;8555.700550480704;11343.319400835977;12596.307203103917;12683.175593586388;12764.872351276368;12776.872231277568;11323.32060076398;11594.753469028685;11616.88383116158;11897.524099035942;11959.76080478403;11129.443527823414;11277.830832537682;11441.883251598481;11552.306861588331;11740.354280514312;11237.38194399316;11332;11531.1351648625;11579.305241685526;11900.76198476043;8129.67481300765;8155.184481552034;8426.115257897833;8529.402941794015;8562.78593035179;10510;11094.611688590861;11095.833562496407;11128.44357782124;11627.18609697347 08:25:37 INFO - PROCESS | 1939 | |3;mootools.html;1429.8284205895295;1454.483658301303;1566.3499647646227;1665;1680.2942764039103;7383.889241661379;7572.848543029136;7967.92032079679;8460.407771455993;8460.746177614674;8036.678532858693;8276.172382761735;8278.668853245863;8509.659613615464;8524.360672949539;2300.194931773878;2345.2846881701075;2345.319857241398;2363.515479326734;2364.775346342095;2307.3193407944614;2329.126577533425;2348.7886090251873;2363.8936247868887;2368.609179485383;2262.4343914021497;2275.601769690306;2288.1305104060434;2316.1198744477074;2316.779905908936;2212.070930209316;2263.9434014149697;2276.64711969645;2284.0521183708825;2288.8855557222237;2271.3980795089315;2280.9429764256024;2281.885905704708;2286.211257116292;2305.054927479742;8250.958745206235;8423.073461919184;8427.41008129425;8430.241278284922;8489.151084891462;5036.521530454601;5192.662476938987;5196.32447781786;5196.8960620787375;5213.582913366921;3090.3819236152635;3163.14595059335;3338.61605915318;3378.9662103378896;3427.091820667525;1025.1132770153838;1040.5213601743208;1069.887661795516;1094.6934858239706;1113.4432783608195;11214.327140371604;11264.380459074748;11347.319160850375;11367.772644547063;11387;4457.799399027052;4539.6368290536675;4625.444946606362;4635.443746750411;4783.856484305476;9788.608455661693;9854.556544955494;9882.209423246122;9893.15908147801;9907.554160062815;5266.420693723688;5280.81517146898;5289.206619007103;5293.311869456946;5301.310829592206;4616.76916154191;4786.305985632133;4800.3759511263315;4841.15279826029;4890.021995600894;3705.7591256568235;3795.35478968576;3809.7523660961947;3856.1130939883983;3908.413737939332;1230.3479156047308;1246.7319526301708;1253.5863165155477;1256.2776403567984;1263.1158189267549;946.7112530678072;966.3085718834955;967.7387105481481;969.9078587534173;983.095552092077;5863.794767183128;5997.430244126801;6020.247469066367;6061.121137435047;6134.447899689049;458.21187557401214;461.73450266097126;461.91223667503067;466.71530366476424;467.45774901115226;4149.2738770715005;4153.875383738493;4155;4162.500499940026;4171.20747058058;10268.127209187154;10364.948175259226;10386.221033422524;10391.948040259751;10413.375197488174;9765.658201962897;10339.327943683636;10348;10350.844737328945;10420.426876521864;7680.4623676343235;7905.486143400661;7951.880721789062;7968.322692571081;8022.679092836222;5729.3984131665575;5879.735411906389;5896.764129434775;6015.72929218195;6136.846578835565;9453.574589143367;9453.716388508356;9494.477803720862;9508.809823803347;9526.761830954281;9460.621575136918;9460.810783784149;9621.51892405363;9653.565589548347;9757.073078057572;6773.424258938046;6950.826229344105;7083.7520686775715;7297.525660832029;7575.128860180929;7635.885461717968;7818.609069546386;7874.173211812677;7878.72424465141;7897.210278972057;7017.228104908558;7247.891281630885;7254.746083887038;7300.96349518249;7323.523970941872;7037.366637002694;7157.355837974607;7236.4210863131875;7352.852942941218;7475.514091584029;6771.762988295386;6773.288804675438;6807.829804254735;6835.1114355135505;6845.726170953106;4991.126552853164;5111.39392198718;5152.119476391165;5212.244224587338;5288.233206185005;5097.92353114711;5171.974140129275;5188.610854185876;5253.686578355411;5302.973485132549 08:25:37 INFO - PROCESS | 1939 | |4;prototype.html;296.23571186339234;304.6694336644742;305.28563162200453;310.4768465136244;314.90710240479046;5352.892942141155;5407.215953686713;5445.809396671118;5482.945170548293;5521.2270282160525;5379.865503362418;5447.509724124828;5448.2134916233235;5451.809186678457;5469;4215.473065866767;4239.321708526636;4250.851220207293;4252.2345977724;4271.807768650418;3957.901052473697;4180.184863951516;4213.726107802983;4214.461721471672;4227.915441691164;4160;4167.4790651168605;4170.145120250341;4170.145120250357;4198.412222288882;4181.184668989548;4182.22628813669;4193.029276240162;4211.284081706087;4226.535081141072;3600.71194304455;3665.9450108248398;3694.649008344203;3702.407614781649;3706.8331925063435;5263.921041184385;5273.841784746463;5295.232191332235;5303.60222983274;5325.7869685212545;4745.359376484165;4745.406824146981;4746.457401344577;4759.524047595248;4781.737004464753;5492.725363731797;5621;5621.662700237999;5633.8309850704545;5674.957015474426;3923.509561304837;3947.842086316544;3949.782761948092;3962.1283317670354;3978.3634618460906;5869.295684517885;5888.646681199141;5897.439743224387;5926.792562260343;5928.4960778334325;3935.173613541131;3944.8027598619956;4005;4016.2369149861433;4018.33697439925;4028.9798551007057;4057.1479989202007;4084.8774536763945;4093.2399068400873;4093.9590604094174;4714.693544919569;4743.57307842289;4743.905121897543;4749.145153872267;4758.690685105457;5432.891342173134;5673.404292549306;5695.870493891895;5702.344230413555;5749.913751293734;1375.0649558300252;1377.6418131285939;1379.4551152294787;1380.9240491773048;1382.3295701584723;903.6791938861741;925.7639301977953;933.5425641435647;934.1592566689898;950.3205208275978;5350.224217488442;5376.650517716336;5383.273258110184;5391.514763671288;5392.379876314196;5628.746706398222;5640.153976903497;5648.491635752802;5674.489295963301;5700.40145784695;5231.555317797954;5318.414974352818;5321.32378300834;5323.2015197719875;5338.304156400993;2972.7027297270533;2998.85005749716;3002.2944608017096;3015;3015.9547606785914;5749.252597162342;5768.134779783066;5785.218995435563;5811.476967072984;5851.303122094545;5422.972885135549;5669.291338582677;5707.258056452718;5713.143428285857;5758.337791153987;5766.625169363978;5808.3901190375245;5810.808784199229;5812.854678632983;5824.708764561755;5476.972615136899;5510;5528.004959107399;5621.409751976147;5667.716614169358;5526.281583394294;5541.251930989265;5541.5843811715085;5546.616563896101;5556.416576259596;5809.564282678732;5820.912686309794;5823.505002074871;5829.883402332014;5869.647821130746;3780.678642315434;3930.744501607386;3938.8424463021156;3983.482147320946;3996.160806230724;5641.66150030983;5771.480566749013;5800.390958949419;5814.813334399226;5861.736221870111;5657.869755078733;5699.518125287373;5725.885482290414;5741.741621626953;5747.655140691572;5634.295713035871;5652.180433837153;5664.892952609325;5695.8860822784145;5722.198892155185;5476.753546090516;5522.66863988162;5539.944600553943;5546.61173717852;5607.383187849252;5646.463585959327;5672.801451949162;5677.517411019944;5712.314522257189;5719.169865643121;5478.986557393498;5555.944300608639;5575.414581469049;5647.757493351456;5649.322081350264 08:25:37 INFO - PROCESS | 1939 | |5;yui.html;713.4328209073785;736.5396627108057;762.1311704656689;768.0898135709182;834.4284165346738;15222.467213647524;15789.526314210563;16102.275397607107;16137.83862161378;16184;14679.192644404553;14794.40822367104;14832.332545035473;14864.256787160653;14950.17774022431;780.6682160081971;804.7143264141233;813.7762115418249;814.9551774652392;817.4114637461018;791.7268542352879;793.2067932067932;798.0184373220942;798.5927177139642;800.591698233899;850.6299759604592;850.9872351914695;853.7268074216254;854.8204876975842;855.1619412975288;852.045708806138;852.8209076093997;854.6538651846013;854.9658013679446;856.5845564901049;615.0896672924098;615.8244900203465;617.3425302053344;621.4531212532987;621.7979156774021;15677.764833527392;15834.28745706446;15864.444744434004;15881.444149454714;15965.92017039919;14049.367778449994;14556.199409032499;14624.570749864608;14695.63260918475;14890.329935152835;12012.63962081139;12074.939625301817;12087.758244835055;12224.288599596064;12395.442205100791;3669.6697297243377;3701.3522633539023;3702.796346200958;3725.217704282104;3858.305505009097;78697;80695.59652201818;80770.59614701889;82599;83090;11214.551417943354;11321.490532926038;11360.431978401211;11387.316760994367;11422.25755325901;20991.116643421017;21216.681749773765;21252.406069544846;21291.893540532197;21669.783302167092;7854.567998760009;7945.562994035268;8240.13478584752;8274.420790544604;8371.95814020926;4545.136424079415;4547.522510136388;4604.654650901196;4649.232876575327;4653.371794807726;3629.9473152785395;3744.1762812181278;3758.736888417839;3777.131259810259;3791.1848952474797;601.5458328961694;615.2340336281359;623.052959501555;623.9906401403982;624.0701354981136;653.2226650286144;673.1182151381705;674.1068084787578;680.7413182990432;709.7480394459996;9423.717288481357;9609.118097817092;9783.951080244553;9787.36382135159;9966.15287700539;689.5104475822122;693.6670398208888;716.2908720366903;728.144430294402;728.9963550182215;4487.842925497592;4494.505604383515;4759.619710284048;4767.356406885096;4774.140654682191;66169.6691516549;66853.66573167103;73172;87040.56479717561;87180;71176.28823711697;71934.64032679803;71956.64021679858;72551.6372418145;72710;65312;66824;67761;68371.31628683649;69942;8941.239994600532;9275.489848058422;9389.906100938902;9397.483138427453;9404.38871473352;44947.830999435486;45740.771296143306;46285.768571158274;46500.30249546192;47448;57683.42316576948;58075.419245807;61568.38431615626;62106;63461.36538634555;11498.310101393943;11614.303141811519;11863.525458981545;11902.345371004678;11924;12353.197042192229;12805.359732013176;13031.501377341727;13038.413271403;13165.934170329087;11955.222910510789;12002.75994480123;12978.610641680765;13130.474781008652;13754.724905502035;12365.876341236473;12444.937775311066;12834.55079072228;13016.21902685804;13376.13055151451;12156.574519891761;12239.87760122423;12350;12479.251244925334;13289.66775830612;10535.147120512962;10715.41065241388;10787;11252.83120753173;11795.823062654239;10941.398223097805;11327.207095503236;11340.489677964346;11418.429078545872;11483.440133558624 08:25:37 INFO - PROCESS | 1939 | __end_tp_report 08:25:37 INFO - PROCESS | 1939 | __start_cc_report 08:25:37 INFO - PROCESS | 1939 | _x_x_mozilla_cycle_collect,343 08:25:37 INFO - PROCESS | 1939 | __end_cc_report 08:25:37 INFO - PROCESS | 1939 | __startTimestamp1480523137611__endTimestamp 08:25:37 INFO - PROCESS | 1939 | 08:25:37 INFO - PROCESS | 1939 | ------- Summary: start ------- 08:25:37 INFO - PROCESS | 1939 | Number of tests: 6 08:25:37 INFO - PROCESS | 1939 | 08:25:37 INFO - PROCESS | 1939 | [#0] dojo.html Cycles:165 Average:5416.54 Median:5654.83 stddev:617.82 (10.9%) stddev-sans-first:593.41 08:25:37 INFO - PROCESS | 1939 | Values: 3143.1 3144.1 3181.0 3191.6 3202.3 5268.0 5405.9 5455.0 5497.4 5518.3 5340.9 5348.5 5469.7 5541.2 5569.8 4915.8 4921.8 4991.7 4995.3 5044.5 4891.4 4980.1 4988.2 5112.2 5130.4 4828.2 4849.0 4960.6 5025.6 5035.2 4905.8 4910.8 4913.8 4920.1 4935.7 4840.6 4844.3 4855.3 4865.2 4905.4 5257.1 5308.8 5330.4 5332.4 5364.9 5779.7 5794.8 5806.2 5819.8 5877.7 5848.4 5851.2 5862.2 5869.7 5870.6 5288.9 5363.9 5370.5 5424.6 5453.9 5842.7 5919.8 5945.2 5954.6 6095.2 5741.7 5750.4 5754.6 5756.5 5767.4 5654.8 5812.3 5846.1 5849.3 5852.8 5674.9 5731.0 5762.2 5806.4 5879.7 5789.5 5830.3 5833.4 5855.0 5890.0 4486.5 4495.7 4510.3 4512.7 4548.2 3873.9 3885.1 3979.2 4008.8 4055.2 5501.0 5580.7 5609.4 5627.9 5645.6 5890.1 5897.1 5898.5 5898.6 5911.3 5403.2 5601.5 5606.6 5640.0 5645.9 4909.6 5017.9 5059.1 5106.8 5111.8 6101.9 6107.7 6109.8 6111.7 6125.0 5823.7 5828.2 5875.4 5889.4 5889.4 5889.4 5918.3 5920.2 6010.4 6019.5 5677.7 5681.3 5713.1 5719.3 5724.8 5821.7 5859.0 5881.7 5905.7 5945.4 5679.7 5703.1 5739.4 5747.3 5763.6 5492.6 5536.0 5728.6 5734.7 5745.4 5505.0 5520.7 5526.3 5528.7 5562.8 5749.9 5750.5 5792.5 5851.4 5857.2 5659.4 5667.9 5699.9 5700.4 5703.9 08:25:37 INFO - PROCESS | 1939 | 08:25:37 INFO - PROCESS | 1939 | [#1] ext.html Cycles:180 Average:63829.69 Median:369125.00 stddev:136866.86 (37.1%) stddev-sans-first:137168.34 08:25:37 INFO - PROCESS | 1939 | Values: 548.2 576.6 582.0 602.8 603.0 37132.3 40708.6 40859.4 40862.6 40993.0 41270.2 42177.2 42181.0 42293.6 42307.4 8387.8 8616.7 10248.7 10518.6 10549.0 10220.3 10404.6 10418.4 10419.9 10440.6 10383.7 10430.3 10455.9 10484.3 10491.6 10384.7 10402.6 10453.3 10473.1 10490.4 10304.3 10317.4 10318.4 10351.5 10370.0 41591.8 42262.0 42491.8 42566.0 42642.8 3300.1 3313.4 3425.1 3620.3 3709.2 30295.7 30717.7 30740.4 30781.8 31038.5 4018.4 4041.4 4099.6 4183.3 4322.1 367982.0 368942.0 369308.0 369694.0 369880.0 57738.7 57753.6 57906.7 58179.1 58863.7 61522.0 61640.0 62045.7 62204.0 62290.4 15742.3 16138.3 16167.8 16224.2 16383.5 12017.9 12172.0 12466.1 12532.5 12598.3 19380.5 19453.9 19505.9 19539.6 19557.3 7285.3 7484.4 7589.5 7753.0 7766.9 913.0 994.5 997.7 1034.1 1051.1 31813.8 32227.8 32228.8 32314.5 32744.8 1039.5 1059.9 1138.9 1149.8 1196.4 16601.7 16625.4 16667.7 16684.7 17018.3 498572.0 514281.0 516099.0 868117.0 870266.0 57251.7 57871.7 57955.4 57955.4 58170.7 1319.3 1330.0 1341.6 1351.5 1366.6 29944.3 32503.5 32509.0 32517.8 33163.5 49824.0 50179.7 50374.2 50381.0 50385.7 429086.0 435596.0 437986.0 438837.0 439762.0 27959.4 28173.4 28436.3 28446.1 28493.6 45304.3 45460.5 46216.4 46694.8 47414.5 38240.0 38627.2 39244.8 39614.0 40122.2 38552.9 38951.6 39109.8 39753.0 40260.2 39498.4 39895.4 40110.4 40599.6 40624.0 33247.5 35745.0 35791.8 35803.8 36411.8 26844.2 27693.2 27726.4 27781.6 27789.6 08:25:37 INFO - PROCESS | 1939 | 08:25:37 INFO - PROCESS | 1939 | [#2] jquery.html Cycles:180 Average:27103.51 Median:12259.73 stddev:71280.45 (581.4%) stddev-sans-first:71452.14 08:25:37 INFO - PROCESS | 1939 | Values: 366.6 379.9 389.7 396.0 404.7 17327.8 18884.2 18895.6 19161.2 19406.0 18473.4 18699.8 18887.2 18927.5 18964.5 5338.4 5390.4 5577.2 5583.4 5589.8 5439.9 5450.3 5484.2 5504.1 5564.9 5430.5 5454.2 5468.9 5502.8 5527.2 5665.1 5836.2 5839.9 5841.6 5842.7 5414.6 5515.4 5547.3 5611.7 5632.5 13648.6 13761.4 17394.0 21757.0 22303.2 2149.6 2216.2 2385.2 2825.4 2928.1 10265.4 10270.7 11593.0 12071.3 14523.2 1860.6 1902.8 1905.6 1957.9 1987.3 75204.6 78322.0 78504.6 80326.0 83027.6 10823.4 10829.8 10873.6 11230.6 11317.5 15286.0 15384.4 15433.6 15488.3 15541.4 7780.1 7930.9 8118.2 8134.8 8200.0 7519.0 7583.4 7691.4 7729.4 7843.8 4523.9 4696.4 4712.0 4739.6 4780.5 1800.9 1893.9 1932.2 1940.2 1964.6 862.2 951.3 966.1 1037.8 1057.1 18876.4 19317.8 19337.7 19423.1 19636.2 989.2 998.7 1002.7 1030.8 1036.6 10146.3 10577.9 10750.5 10771.4 10784.4 348448.0 437081.0 449089.0 450905.0 451692.0 92488.5 95062.5 95488.5 97123.5 99750.0 1006.5 1026.5 1067.3 1071.5 1082.8 16814.5 16869.8 17454.4 17747.9 18061.5 41179.0 41225.4 41297.8 41535.0 41907.3 57544.7 57845.4 57947.7 58743.0 59279.0 7949.0 8095.6 8295.2 8376.2 8555.7 11343.3 12596.3 12683.2 12764.9 12776.9 11323.3 11594.8 11616.9 11897.5 11959.8 11129.4 11277.8 11441.9 11552.3 11740.4 11237.4 11332.0 11531.1 11579.3 11900.8 8129.7 8155.2 8426.1 8529.4 8562.8 10510.0 11094.6 11095.8 11128.4 11627.2 08:25:37 INFO - PROCESS | 1939 | 08:25:37 INFO - PROCESS | 1939 | [#3] mootools.html Cycles:180 Average:5554.40 Median:5190.64 stddev:3073.28 (59.2%) stddev-sans-first:3066.27 08:25:37 INFO - PROCESS | 1939 | Values: 1429.8 1454.5 1566.3 1665.0 1680.3 7383.9 7572.8 7967.9 8460.4 8460.7 8036.7 8276.2 8278.7 8509.7 8524.4 2300.2 2345.3 2345.3 2363.5 2364.8 2307.3 2329.1 2348.8 2363.9 2368.6 2262.4 2275.6 2288.1 2316.1 2316.8 2212.1 2263.9 2276.6 2284.1 2288.9 2271.4 2280.9 2281.9 2286.2 2305.1 8251.0 8423.1 8427.4 8430.2 8489.2 5036.5 5192.7 5196.3 5196.9 5213.6 3090.4 3163.1 3338.6 3379.0 3427.1 1025.1 1040.5 1069.9 1094.7 1113.4 11214.3 11264.4 11347.3 11367.8 11387.0 4457.8 4539.6 4625.4 4635.4 4783.9 9788.6 9854.6 9882.2 9893.2 9907.6 5266.4 5280.8 5289.2 5293.3 5301.3 4616.8 4786.3 4800.4 4841.2 4890.0 3705.8 3795.4 3809.8 3856.1 3908.4 1230.3 1246.7 1253.6 1256.3 1263.1 946.7 966.3 967.7 969.9 983.1 5863.8 5997.4 6020.2 6061.1 6134.4 458.2 461.7 461.9 466.7 467.5 4149.3 4153.9 4155.0 4162.5 4171.2 10268.1 10364.9 10386.2 10391.9 10413.4 9765.7 10339.3 10348.0 10350.8 10420.4 7680.5 7905.5 7951.9 7968.3 8022.7 5729.4 5879.7 5896.8 6015.7 6136.8 9453.6 9453.7 9494.5 9508.8 9526.8 9460.6 9460.8 9621.5 9653.6 9757.1 6773.4 6950.8 7083.8 7297.5 7575.1 7635.9 7818.6 7874.2 7878.7 7897.2 7017.2 7247.9 7254.7 7301.0 7323.5 7037.4 7157.4 7236.4 7352.9 7475.5 6771.8 6773.3 6807.8 6835.1 6845.7 4991.1 5111.4 5152.1 5212.2 5288.2 5097.9 5172.0 5188.6 5253.7 5303.0 08:25:37 INFO - PROCESS | 1939 | 08:25:37 INFO - PROCESS | 1939 | [#4] prototype.html Cycles:180 Average:4703.78 Median:5446.66 stddev:1395.18 (25.6%) stddev-sans-first:1359.30 08:25:37 INFO - PROCESS | 1939 | Values: 296.2 304.7 305.3 310.5 314.9 5352.9 5407.2 5445.8 5482.9 5521.2 5379.9 5447.5 5448.2 5451.8 5469.0 4215.5 4239.3 4250.9 4252.2 4271.8 3957.9 4180.2 4213.7 4214.5 4227.9 4160.0 4167.5 4170.1 4170.1 4198.4 4181.2 4182.2 4193.0 4211.3 4226.5 3600.7 3665.9 3694.6 3702.4 3706.8 5263.9 5273.8 5295.2 5303.6 5325.8 4745.4 4745.4 4746.5 4759.5 4781.7 5492.7 5621.0 5621.7 5633.8 5675.0 3923.5 3947.8 3949.8 3962.1 3978.4 5869.3 5888.6 5897.4 5926.8 5928.5 3935.2 3944.8 4005.0 4016.2 4018.3 4029.0 4057.1 4084.9 4093.2 4094.0 4714.7 4743.6 4743.9 4749.1 4758.7 5432.9 5673.4 5695.9 5702.3 5749.9 1375.1 1377.6 1379.5 1380.9 1382.3 903.7 925.8 933.5 934.2 950.3 5350.2 5376.7 5383.3 5391.5 5392.4 5628.7 5640.2 5648.5 5674.5 5700.4 5231.6 5318.4 5321.3 5323.2 5338.3 2972.7 2998.9 3002.3 3015.0 3016.0 5749.3 5768.1 5785.2 5811.5 5851.3 5423.0 5669.3 5707.3 5713.1 5758.3 5766.6 5808.4 5810.8 5812.9 5824.7 5477.0 5510.0 5528.0 5621.4 5667.7 5526.3 5541.3 5541.6 5546.6 5556.4 5809.6 5820.9 5823.5 5829.9 5869.6 3780.7 3930.7 3938.8 3983.5 3996.2 5641.7 5771.5 5800.4 5814.8 5861.7 5657.9 5699.5 5725.9 5741.7 5747.7 5634.3 5652.2 5664.9 5695.9 5722.2 5476.8 5522.7 5539.9 5546.6 5607.4 5646.5 5672.8 5677.5 5712.3 5719.2 5479.0 5555.9 5575.4 5647.8 5649.3 08:25:37 INFO - PROCESS | 1939 | 08:25:37 INFO - PROCESS | 1939 | [#5] yui.html Cycles:180 Average:17922.85 Median:26050.69 stddev:23343.68 (89.6%) stddev-sans-first:23373.40 08:25:37 INFO - PROCESS | 1939 | Values: 713.4 736.5 762.1 768.1 834.4 15222.5 15789.5 16102.3 16137.8 16184.0 14679.2 14794.4 14832.3 14864.3 14950.2 780.7 804.7 813.8 815.0 817.4 791.7 793.2 798.0 798.6 800.6 850.6 851.0 853.7 854.8 855.2 852.0 852.8 854.7 855.0 856.6 615.1 615.8 617.3 621.5 621.8 15677.8 15834.3 15864.4 15881.4 15965.9 14049.4 14556.2 14624.6 14695.6 14890.3 12012.6 12074.9 12087.8 12224.3 12395.4 3669.7 3701.4 3702.8 3725.2 3858.3 78697.0 80695.6 80770.6 82599.0 83090.0 11214.6 11321.5 11360.4 11387.3 11422.3 20991.1 21216.7 21252.4 21291.9 21669.8 7854.6 7945.6 8240.1 8274.4 8372.0 4545.1 4547.5 4604.7 4649.2 4653.4 3629.9 3744.2 3758.7 3777.1 3791.2 601.5 615.2 623.1 624.0 624.1 653.2 673.1 674.1 680.7 709.7 9423.7 9609.1 9784.0 9787.4 9966.2 689.5 693.7 716.3 728.1 729.0 4487.8 4494.5 4759.6 4767.4 4774.1 66169.7 66853.7 73172.0 87040.6 87180.0 71176.3 71934.6 71956.6 72551.6 72710.0 65312.0 66824.0 67761.0 68371.3 69942.0 8941.2 9275.5 9389.9 9397.5 9404.4 44947.8 45740.8 46285.8 46500.3 47448.0 57683.4 58075.4 61568.4 62106.0 63461.4 11498.3 11614.3 11863.5 11902.3 11924.0 12353.2 12805.4 13031.5 13038.4 13165.9 11955.2 12002.8 12978.6 13130.5 13754.7 12365.9 12444.9 12834.6 13016.2 13376.1 12156.6 12239.9 12350.0 12479.3 13289.7 10535.1 10715.4 10787.0 11252.8 11795.8 10941.4 11327.2 11340.5 11418.4 11483.4 08:25:37 INFO - PROCESS | 1939 | -------- Summary: end -------- 08:25:37 INFO - PROCESS | 1939 | 08:25:38 INFO - TEST-INFO | 1939: exit 0 08:25:38 INFO - TEST-OK | dromaeo_css | took 1115563ms 08:25:38 INFO - TEST-START | kraken 08:25:38 INFO - operating with platform_type : linux_ 08:25:38 INFO - Initialising browser for kraken test... 08:25:38 INFO - TEST-INFO | started process 2295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp011RyN/profile http://localhost:33310/getInfo.html) 08:25:42 INFO - PROCESS | 2295 | __metrics Screen width/height:1600/1200 08:25:42 INFO - PROCESS | 2295 | colorDepth:24 08:25:42 INFO - PROCESS | 2295 | Browser inner width/height: 1024/697 08:25:42 INFO - PROCESS | 2295 | __metrics 08:25:43 ERROR - PROCESS | 2295 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 08:25:44 INFO - TEST-INFO | 2295: exit 0 08:25:44 INFO - Browser initialized. 08:25:44 INFO - Running cycle 1/1 for kraken test... 08:25:44 INFO - TEST-INFO | started process 2497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp011RyN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:25:56 INFO - PROCESS | 2497 | RSS: Main: 186560512 08:25:56 INFO - PROCESS | 2497 | 08:25:58 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:33310/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33310/tests/kraken/driver.html?testName=audio-beat-detection) 08:25:59 INFO - PROCESS | 2497 | RSS: Main: 199725056 08:25:59 INFO - PROCESS | 2497 | 08:26:02 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:33310/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33310/tests/kraken/driver.html?testName=audio-dft) 08:26:03 INFO - PROCESS | 2497 | RSS: Main: 197632000 08:26:03 INFO - PROCESS | 2497 | 08:26:06 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:33310/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33310/tests/kraken/driver.html?testName=audio-fft) 08:26:06 INFO - PROCESS | 2497 | RSS: Main: 194007040 08:26:06 INFO - PROCESS | 2497 | 08:26:08 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:33310/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33310/tests/kraken/driver.html?testName=audio-oscillator) 08:26:09 INFO - PROCESS | 2497 | RSS: Main: 194592768 08:26:09 INFO - PROCESS | 2497 | 08:26:11 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:33310/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33310/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:26:12 INFO - PROCESS | 2497 | RSS: Main: 194605056 08:26:12 INFO - PROCESS | 2497 | 08:26:15 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:33310/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33310/tests/kraken/driver.html?testName=imaging-darkroom) 08:26:15 INFO - PROCESS | 2497 | RSS: Main: 200060928 08:26:15 INFO - PROCESS | 2497 | 08:26:19 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:33310/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33310/tests/kraken/driver.html?testName=imaging-desaturate) 08:26:20 INFO - PROCESS | 2497 | RSS: Main: 200216576 08:26:20 INFO - PROCESS | 2497 | 08:26:22 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:33310/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33310/tests/kraken/driver.html?testName=json-parse-financial) 08:26:23 INFO - PROCESS | 2497 | RSS: Main: 200413184 08:26:23 INFO - PROCESS | 2497 | 08:26:25 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:33310/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33310/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:26:25 INFO - PROCESS | 2497 | RSS: Main: 199720960 08:26:25 INFO - PROCESS | 2497 | 08:26:27 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:33310/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33310/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:26:28 INFO - PROCESS | 2497 | RSS: Main: 199806976 08:26:28 INFO - PROCESS | 2497 | 08:26:30 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:33310/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33310/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:26:30 INFO - PROCESS | 2497 | RSS: Main: 199909376 08:26:30 INFO - PROCESS | 2497 | 08:26:33 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:33310/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33310/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:26:34 INFO - PROCESS | 2497 | RSS: Main: 199909376 08:26:34 INFO - PROCESS | 2497 | 08:26:37 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:33310/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33310/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:26:38 INFO - PROCESS | 2497 | RSS: Main: 200122368 08:26:38 INFO - PROCESS | 2497 | 08:26:39 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:33310/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33310/tests/kraken/driver.html?testName=ai-astar) 08:26:40 INFO - PROCESS | 2497 | RSS: Main: 201326592 08:26:40 INFO - PROCESS | 2497 | 08:26:40 INFO - PROCESS | 2497 | __start_tp_report 08:26:40 INFO - PROCESS | 2497 | _x_x_mozilla_page_load 08:26:40 INFO - PROCESS | 2497 | _x_x_mozilla_page_load_details 08:26:40 INFO - PROCESS | 2497 | |i|pagename|runs| 08:26:40 INFO - PROCESS | 2497 | |0;ai-astar;108;113;113;114;112;112;114;113;113;114 08:26:40 INFO - PROCESS | 2497 | |1;audio-beat-detection;152;128;126;172;130;126;131;127;153;128 08:26:40 INFO - PROCESS | 2497 | |2;audio-dft;164;167;165;170;170;168;167;167;168;166 08:26:40 INFO - PROCESS | 2497 | |3;audio-fft;78;76;77;113;77;76;77;77;96;77 08:26:40 INFO - PROCESS | 2497 | |4;audio-oscillator;83;85;112;83;84;85;102;83;82;111 08:26:40 INFO - PROCESS | 2497 | |5;imaging-gaussian-blur;118;119;118;118;119;118;118;119;119;120 08:26:40 INFO - PROCESS | 2497 | |6;imaging-darkroom;149;147;147;148;147;149;148;148;149;148 08:26:40 INFO - PROCESS | 2497 | |7;imaging-desaturate;98;98;97;97;96;98;97;97;96;96 08:26:40 INFO - PROCESS | 2497 | |8;json-parse-financial;57;54;52;52;56;55;54;57;54;54 08:26:40 INFO - PROCESS | 2497 | |9;json-stringify-tinderbox;63;64;63;63;64;64;65;64;64;65 08:26:40 INFO - PROCESS | 2497 | |10;stanford-crypto-aes;83;88;84;86;84;82;82;84;82;81 08:26:40 INFO - PROCESS | 2497 | |11;stanford-crypto-ccm;134;142;135;137;145;147;141;136;178;134 08:26:40 INFO - PROCESS | 2497 | |12;stanford-crypto-pbkdf2;173;173;177;173;172;173;178;171;176;178 08:26:40 INFO - PROCESS | 2497 | |13;stanford-crypto-sha256-iterative;77;71;71;69;74;73;78;69;79;68 08:26:40 INFO - PROCESS | 2497 | __end_tp_report 08:26:40 INFO - PROCESS | 2497 | __start_cc_report 08:26:40 INFO - PROCESS | 2497 | _x_x_mozilla_cycle_collect,826 08:26:40 INFO - PROCESS | 2497 | __end_cc_report 08:26:40 INFO - PROCESS | 2497 | __startTimestamp1480523200008__endTimestamp 08:26:40 INFO - PROCESS | 2497 | 08:26:40 INFO - PROCESS | 2497 | ------- Summary: start ------- 08:26:40 INFO - PROCESS | 2497 | Number of tests: 14 08:26:40 INFO - PROCESS | 2497 | 08:26:40 INFO - PROCESS | 2497 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:1.78 (1.6%) stddev-sans-first:0.78 08:26:40 INFO - PROCESS | 2497 | Values: 108.0 113.0 113.0 114.0 112.0 112.0 114.0 113.0 113.0 114.0 08:26:40 INFO - PROCESS | 2497 | 08:26:40 INFO - PROCESS | 2497 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:130.50 stddev:15.97 (12.2%) stddev-sans-first:16.02 08:26:40 INFO - PROCESS | 2497 | Values: 152.0 128.0 126.0 172.0 130.0 126.0 131.0 127.0 153.0 128.0 08:26:40 INFO - PROCESS | 2497 | 08:26:40 INFO - PROCESS | 2497 | [#2] audio-dft Cycles:10 Average:167.20 Median:167.50 stddev:1.93 (1.2%) stddev-sans-first:1.67 08:26:40 INFO - PROCESS | 2497 | Values: 164.0 167.0 165.0 170.0 170.0 168.0 167.0 167.0 168.0 166.0 08:26:40 INFO - PROCESS | 2497 | 08:26:40 INFO - PROCESS | 2497 | [#3] audio-fft Cycles:10 Average:82.40 Median:77.00 stddev:12.33 (16.0%) stddev-sans-first:12.98 08:26:40 INFO - PROCESS | 2497 | Values: 78.0 76.0 77.0 113.0 77.0 76.0 77.0 77.0 96.0 77.0 08:26:40 INFO - PROCESS | 2497 | 08:26:40 INFO - PROCESS | 2497 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:83.00 stddev:12.27 (14.8%) stddev-sans-first:12.67 08:26:40 INFO - PROCESS | 2497 | Values: 83.0 85.0 112.0 83.0 84.0 85.0 102.0 83.0 82.0 111.0 08:26:40 INFO - PROCESS | 2497 | 08:26:40 INFO - PROCESS | 2497 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:119.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 08:26:40 INFO - PROCESS | 2497 | Values: 118.0 119.0 118.0 118.0 119.0 118.0 118.0 119.0 119.0 120.0 08:26:40 INFO - PROCESS | 2497 | 08:26:40 INFO - PROCESS | 2497 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 08:26:40 INFO - PROCESS | 2497 | Values: 149.0 147.0 147.0 148.0 147.0 149.0 148.0 148.0 149.0 148.0 08:26:40 INFO - PROCESS | 2497 | 08:26:40 INFO - PROCESS | 2497 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.78 08:26:40 INFO - PROCESS | 2497 | Values: 98.0 98.0 97.0 97.0 96.0 98.0 97.0 97.0 96.0 96.0 08:26:40 INFO - PROCESS | 2497 | 08:26:40 INFO - PROCESS | 2497 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.50 stddev:1.78 (3.3%) stddev-sans-first:1.64 08:26:40 INFO - PROCESS | 2497 | Values: 57.0 54.0 52.0 52.0 56.0 55.0 54.0 57.0 54.0 54.0 08:26:40 INFO - PROCESS | 2497 | 08:26:40 INFO - PROCESS | 2497 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 08:26:40 INFO - PROCESS | 2497 | Values: 63.0 64.0 63.0 63.0 64.0 64.0 65.0 64.0 64.0 65.0 08:26:40 INFO - PROCESS | 2497 | 08:26:40 INFO - PROCESS | 2497 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:2.12 (2.5%) stddev-sans-first:2.24 08:26:40 INFO - PROCESS | 2497 | Values: 83.0 88.0 84.0 86.0 84.0 82.0 82.0 84.0 82.0 81.0 08:26:40 INFO - PROCESS | 2497 | 08:26:40 INFO - PROCESS | 2497 | [#11] stanford-crypto-ccm Cycles:10 Average:142.90 Median:141.50 stddev:13.17 (9.3%) stddev-sans-first:13.57 08:26:40 INFO - PROCESS | 2497 | Values: 134.0 142.0 135.0 137.0 145.0 147.0 141.0 136.0 178.0 134.0 08:26:40 INFO - PROCESS | 2497 | 08:26:40 INFO - PROCESS | 2497 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:174.50 stddev:2.59 (1.5%) stddev-sans-first:2.70 08:26:40 INFO - PROCESS | 2497 | Values: 173.0 173.0 177.0 173.0 172.0 173.0 178.0 171.0 176.0 178.0 08:26:40 INFO - PROCESS | 2497 | 08:26:40 INFO - PROCESS | 2497 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:73.50 stddev:3.98 (5.4%) stddev-sans-first:3.94 08:26:40 INFO - PROCESS | 2497 | Values: 77.0 71.0 71.0 69.0 74.0 73.0 78.0 69.0 79.0 68.0 08:26:40 INFO - PROCESS | 2497 | -------- Summary: end -------- 08:26:40 INFO - PROCESS | 2497 | 08:26:41 INFO - TEST-INFO | 2497: exit 0 08:26:41 INFO - TEST-OK | kraken | took 62673ms 08:26:41 INFO - SUITE-END | took 1178s 08:26:41 INFO - Completed test suite (00:19:38) 08:26:41 INFO - javascript benchmark 08:26:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7157.008568984174, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3143.0570828751374, 3144.103930379842, 3181.0, 3191.5531825544444, 3202.295494991102, 5268.0, 5405.945940540599, 5454.972725136374, 5497.39528651849, 5518.255035570197, 5340.893182136355, 5348.46515348465, 5469.72651367432, 5541.168824676301, 5569.805056823002, 4915.778789954443, 4921.753912304388, 4991.700497970133, 4995.325631039817, 5044.545990860822, 4891.437484689271, 4980.078685443204, 4988.226824842155, 5112.233165025239, 5130.358705161855, 4828.227483602606, 4849.030193961222, 4960.578350840183, 5025.597952163855, 5035.219540971156, 4905.754712264373, 4910.779014944336, 4913.820683036046, 4920.089783390084, 4935.6545041847085, 4840.564349208553, 4844.2733589961435, 4855.32025516428, 4865.19724245499, 4905.4358748744, 5257.13257312543, 5308.840734777963, 5330.413654498002, 5332.413434522199, 5364.865878353034, 5779.682117483537, 5794.797182098607, 5806.187133801272, 5819.7672093116225, 5877.706114694248, 5848.4151584841175, 5851.210086638292, 5862.179294898718, 5869.706514674292, 5870.618409803349, 5288.894222115536, 5363.892722145613, 5370.489803468664, 5424.647397919122, 5453.945460545384, 5842.737076831553, 5919.763209471659, 5945.227120474311, 5954.642721436728, 6095.207623008981, 5741.741621627037, 5750.424957504216, 5754.625949313281, 5756.481916627524, 5767.394423585547, 5654.830355089354, 5812.3025236971835, 5846.064629659234, 5849.327327357323, 5852.7658893643775, 5674.858128546737, 5731.0, 5762.222100016528, 5806.44838740319, 5879.706014699248, 5789.507891829157, 5830.300363956352, 5833.416658334218, 5855.004649209644, 5890.0, 4486.506484286726, 4495.664080328615, 4510.300903359985, 4512.661550383668, 4548.204064288736, 3873.9031524211555, 3885.1258466844733, 3979.243943650697, 4008.8196031178086, 4055.249778790874, 5500.972495137578, 5580.693061881636, 5609.439056094439, 5627.915581266284, 5645.576581756384, 5890.087036509348, 5897.115432685046, 5898.498627616701, 5898.557608179403, 5911.290645122613, 5403.162509810985, 5601.5238704710555, 5606.579506537026, 5640.0, 5645.858853528694, 4909.649846292226, 5017.949820501822, 5059.114654935372, 5106.799902023022, 5111.821086261963, 6101.938980610137, 6107.6640784757265, 6109.84725381869, 6111.663858487826, 6124.969375153096, 5823.679697616672, 5828.242328497268, 5875.353711091691, 5889.411058894248, 5889.411058894248, 5889.352171261244, 5918.260217472816, 5920.200772895604, 6010.42900924429, 6019.54853385989, 5677.74450149736, 5681.318241810844, 5713.085906254979, 5719.256496655408, 5724.771009159754, 5821.650700957956, 5859.0, 5881.705914704162, 5905.675187864708, 5945.435183657545, 5679.659220446786, 5703.0589952659, 5739.368669446274, 5747.252857128547, 5763.596548241583, 5492.560595152298, 5536.031194541019, 5728.627639203439, 5734.684592347461, 5745.425457454221, 5504.972475137759, 5520.696361700145, 5526.253955715927, 5528.695921724344, 5562.777488900399, 5749.91375129365, 5750.453706897838, 5792.507636850746, 5851.414858514115, 5857.1799948008165, 5659.405762394889, 5667.858303542444, 5699.857503562444, 5700.401457847032, 5703.8859222816145], "value": 5374.88517202896, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.2379492505418, 576.6367188671137, 582.0425400216645, 602.7528713227578, 603.0020316376396, 37132.25735485289, 40708.59291407089, 40859.38710919331, 40862.59137408625, 40993.0, 41270.174596508055, 42177.15645687092, 42181.0, 42293.57706422935, 42307.3653895191, 8387.790305242357, 8616.65533378664, 10248.74378140545, 10518.579256829718, 10548.997845204693, 10220.335678180894, 10404.63583774568, 10418.374897506135, 10419.895801041968, 10440.634577789779, 10383.688489345332, 10430.322029068086, 10455.895441045606, 10484.31851929626, 10491.632792852251, 10384.688459346195, 10402.583896644124, 10453.320534165256, 10473.109785668152, 10490.423026733526, 10304.278700490893, 10317.380957142595, 10318.38089714612, 10351.482425878752, 10370.0, 41591.7920410399, 42262.0, 42491.787541062404, 42566.0, 42642.78678606618, 3300.0924745695124, 3313.4201514734823, 3425.1094715373933, 3620.312140693286, 3709.1654377764785, 30295.697043029508, 30717.692823071706, 30740.385192296028, 30781.846090769628, 31038.534421983688, 4018.397240413932, 4041.4341992121126, 4099.61053699898, 4183.288840897055, 4322.092360604277, 367981.9605411842, 368942.0, 369308.0, 369694.0, 369880.0, 57738.7113064432, 57753.6470988191, 57906.710466447395, 58179.127313090336, 58863.70568147217, 61522.0, 61640.0, 62045.68977155085, 62204.0, 62290.377096229364, 15742.29159687794, 16138.273777680033, 16167.757483637755, 16224.188790560425, 16383.508494745176, 12017.879821201675, 12172.0, 12466.065045121652, 12532.498700052078, 12598.307093109966, 19380.452022204823, 19453.90458223712, 19505.906129133487, 19539.609207815764, 19557.307913058725, 7285.271472852673, 7484.363829074481, 7589.468737188344, 7752.961235193788, 7766.922330776733, 912.9634814607341, 994.5474808961905, 997.7156510394648, 1034.0900007992918, 1051.0698032241369, 31813.8409307952, 32227.838860805547, 32228.83885580557, 32314.515282270786, 32744.836275818467, 1039.4698703661036, 1059.8622179116664, 1138.8918052784973, 1149.816029435303, 1196.3599474281218, 16601.66796664084, 16625.418110366078, 16667.666646667, 16684.6663066738, 17018.319267229173, 498572.0, 514281.0, 516099.0, 868117.0, 870266.0, 57251.71374143103, 57871.71064144652, 57955.42044579585, 57955.42044579585, 58170.709146454, 1319.300770591588, 1329.973400531984, 1341.5706973768495, 1351.5404762380838, 1366.5626999360309, 29944.339528873697, 32503.512447312838, 32509.0, 32517.83741081374, 33163.50254746229, 49824.0, 50179.74910125572, 50374.2443863335, 50380.99999999853, 50385.74807125941, 429086.0, 435596.0, 437986.0, 438837.0, 439762.0, 27959.440811184068, 28173.43653126967, 28436.303280573393, 28446.146615601567, 28493.572596410657, 45304.32043519416, 45460.545394546956, 46216.37836216486, 46694.76652616715, 47414.52585474101, 38240.0, 38627.2274554513, 39244.80377598094, 39614.0, 40122.19755604813, 38552.944809107794, 38951.6104838948, 39109.8044509787, 39753.0, 40260.1947961045, 39498.40752388774, 39895.40156897591, 40110.39834402428, 40599.59400405958, 40624.0, 33247.50128748119, 35745.0, 35791.82104089463, 35803.82098089597, 36411.81794091013, 26844.194674159808, 27693.169204923885, 27726.44547109087, 27781.583276251276, 27789.58315625227], "value": 20390.85868094095, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.60223657331795, 379.87843889955207, 389.7271909663236, 395.9980200098999, 404.69243375034966, 17327.826721732796, 18884.15021324042, 18895.62208755824, 19161.23355065796, 19406.02969851509, 18473.44579662609, 18699.813001869978, 18887.24451021961, 18927.52681182971, 18964.5258868528, 5338.412774594792, 5390.353157621091, 5577.2191893135, 5583.441655834425, 5589.832305030855, 5439.864003399927, 5450.345958484968, 5484.232207490954, 5504.146857237135, 5564.944350556483, 5430.511253987141, 5454.154606036071, 5468.91796623051, 5502.752376143083, 5527.226188333637, 5665.065264231397, 5836.153757705151, 5839.8540036499, 5841.56188285876, 5842.678652674102, 5414.620976531644, 5515.420880807537, 5547.3343198816, 5611.7474713637985, 5632.549396048306, 13648.590542283748, 13761.449542018307, 17393.956362618283, 21757.0, 22303.21938732153, 2149.623815832223, 2216.2353987874317, 2385.153270588933, 2825.3784167483327, 2928.1069273871462, 10265.384076955406, 10270.691879243635, 11593.0, 12071.336076515789, 14523.20122393268, 1860.627874425107, 1902.771667399921, 1905.6474552207885, 1957.9314723984735, 1987.3342430285873, 75204.62397687977, 78321.99999999943, 78504.60747696282, 80326.0, 83027.5848620759, 10823.350598964087, 10829.783404331869, 10873.619423320146, 11230.606928757454, 11317.547298108148, 15286.0, 15384.384624615113, 15433.614159646098, 15488.303026363841, 15541.378344866305, 7780.14418413974, 7930.881036784453, 8118.228768267005, 8134.837303253902, 8199.95900020496, 7519.0, 7583.355414789694, 7691.423143264277, 7729.420293478011, 7843.803904902309, 4523.909521809545, 4696.38946936896, 4712.0, 4739.644526660514, 4780.4741478437345, 1800.8559315254747, 1893.9053047347577, 1932.1884808380514, 1940.2142132436104, 1964.5972575621963, 862.2451268198047, 951.3293128344501, 966.1111777165025, 1037.8028174646793, 1057.1067448006422, 18876.36651073066, 19317.8068219316, 19337.709934350994, 19423.125959331865, 19636.214551417783, 989.1641562879355, 998.7003898830321, 1002.7242508310127, 1030.7526193713604, 1036.5853658536646, 10146.289759716896, 10577.903626624964, 10750.462476876124, 10771.353718776898, 10784.40685762275, 348448.0, 437081.0, 449089.0, 450905.0, 451692.0, 92488.53755731178, 95062.52468737612, 95488.52255738676, 97123.51438242763, 99750.0, 1006.4967516241879, 1026.5380578739448, 1067.3382502848283, 1071.4535586850761, 1082.767205050918, 16814.495565133064, 16869.831301687318, 17454.389096381565, 17747.911260443616, 18061.548461288574, 41179.0, 41225.38161927513, 41297.79351103225, 41535.0, 41907.2948328266, 57544.71227643835, 57845.421545784004, 57947.710261448425, 58743.0, 59279.0, 7948.960255198687, 8095.55474448911, 8295.211954864279, 8376.246137847624, 8555.700550480704, 11343.319400835977, 12596.307203103917, 12683.175593586388, 12764.872351276368, 12776.872231277568, 11323.32060076398, 11594.753469028685, 11616.88383116158, 11897.524099035942, 11959.76080478403, 11129.443527823414, 11277.830832537682, 11441.883251598481, 11552.306861588331, 11740.354280514312, 11237.38194399316, 11332.0, 11531.1351648625, 11579.305241685526, 11900.76198476043, 8129.67481300765, 8155.184481552034, 8426.115257897833, 8529.402941794015, 8562.78593035179, 10510.0, 11094.611688590861, 11095.833562496407, 11128.44357782124, 11627.18609697347], "value": 9063.388113395546, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1429.8284205895295, 1454.483658301303, 1566.3499647646227, 1665.0, 1680.2942764039103, 7383.889241661379, 7572.848543029136, 7967.92032079679, 8460.407771455993, 8460.746177614674, 8036.678532858693, 8276.172382761735, 8278.668853245863, 8509.659613615464, 8524.360672949539, 2300.194931773878, 2345.2846881701075, 2345.319857241398, 2363.515479326734, 2364.775346342095, 2307.3193407944614, 2329.126577533425, 2348.7886090251873, 2363.8936247868887, 2368.609179485383, 2262.4343914021497, 2275.601769690306, 2288.1305104060434, 2316.1198744477074, 2316.779905908936, 2212.070930209316, 2263.9434014149697, 2276.64711969645, 2284.0521183708825, 2288.8855557222237, 2271.3980795089315, 2280.9429764256024, 2281.885905704708, 2286.211257116292, 2305.054927479742, 8250.958745206235, 8423.073461919184, 8427.41008129425, 8430.241278284922, 8489.151084891462, 5036.521530454601, 5192.662476938987, 5196.32447781786, 5196.8960620787375, 5213.582913366921, 3090.3819236152635, 3163.14595059335, 3338.61605915318, 3378.9662103378896, 3427.091820667525, 1025.1132770153838, 1040.5213601743208, 1069.887661795516, 1094.6934858239706, 1113.4432783608195, 11214.327140371604, 11264.380459074748, 11347.319160850375, 11367.772644547063, 11387.0, 4457.799399027052, 4539.6368290536675, 4625.444946606362, 4635.443746750411, 4783.856484305476, 9788.608455661693, 9854.556544955494, 9882.209423246122, 9893.15908147801, 9907.554160062815, 5266.420693723688, 5280.81517146898, 5289.206619007103, 5293.311869456946, 5301.310829592206, 4616.76916154191, 4786.305985632133, 4800.3759511263315, 4841.15279826029, 4890.021995600894, 3705.7591256568235, 3795.35478968576, 3809.7523660961947, 3856.1130939883983, 3908.413737939332, 1230.3479156047308, 1246.7319526301708, 1253.5863165155477, 1256.2776403567984, 1263.1158189267549, 946.7112530678072, 966.3085718834955, 967.7387105481481, 969.9078587534173, 983.095552092077, 5863.794767183128, 5997.430244126801, 6020.247469066367, 6061.121137435047, 6134.447899689049, 458.21187557401214, 461.73450266097126, 461.91223667503067, 466.71530366476424, 467.45774901115226, 4149.2738770715005, 4153.875383738493, 4155.0, 4162.500499940026, 4171.20747058058, 10268.127209187154, 10364.948175259226, 10386.221033422524, 10391.948040259751, 10413.375197488174, 9765.658201962897, 10339.327943683636, 10348.0, 10350.844737328945, 10420.426876521864, 7680.4623676343235, 7905.486143400661, 7951.880721789062, 7968.322692571081, 8022.679092836222, 5729.3984131665575, 5879.735411906389, 5896.764129434775, 6015.72929218195, 6136.846578835565, 9453.574589143367, 9453.716388508356, 9494.477803720862, 9508.809823803347, 9526.761830954281, 9460.621575136918, 9460.810783784149, 9621.51892405363, 9653.565589548347, 9757.073078057572, 6773.424258938046, 6950.826229344105, 7083.7520686775715, 7297.525660832029, 7575.128860180929, 7635.885461717968, 7818.609069546386, 7874.173211812677, 7878.72424465141, 7897.210278972057, 7017.228104908558, 7247.891281630885, 7254.746083887038, 7300.96349518249, 7323.523970941872, 7037.366637002694, 7157.355837974607, 7236.4210863131875, 7352.852942941218, 7475.514091584029, 6771.762988295386, 6773.288804675438, 6807.829804254735, 6835.1114355135505, 6845.726170953106, 4991.126552853164, 5111.39392198718, 5152.119476391165, 5212.244224587338, 5288.233206185005, 5097.92353114711, 5171.974140129275, 5188.610854185876, 5253.686578355411, 5302.973485132549], "value": 4420.936481681095, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.23571186339234, 304.6694336644742, 305.28563162200453, 310.4768465136244, 314.90710240479046, 5352.892942141155, 5407.215953686713, 5445.809396671118, 5482.945170548293, 5521.2270282160525, 5379.865503362418, 5447.509724124828, 5448.2134916233235, 5451.809186678457, 5469.0, 4215.473065866767, 4239.321708526636, 4250.851220207293, 4252.2345977724, 4271.807768650418, 3957.901052473697, 4180.184863951516, 4213.726107802983, 4214.461721471672, 4227.915441691164, 4160.0, 4167.4790651168605, 4170.145120250341, 4170.145120250357, 4198.412222288882, 4181.184668989548, 4182.22628813669, 4193.029276240162, 4211.284081706087, 4226.535081141072, 3600.71194304455, 3665.9450108248398, 3694.649008344203, 3702.407614781649, 3706.8331925063435, 5263.921041184385, 5273.841784746463, 5295.232191332235, 5303.60222983274, 5325.7869685212545, 4745.359376484165, 4745.406824146981, 4746.457401344577, 4759.524047595248, 4781.737004464753, 5492.725363731797, 5621.0, 5621.662700237999, 5633.8309850704545, 5674.957015474426, 3923.509561304837, 3947.842086316544, 3949.782761948092, 3962.1283317670354, 3978.3634618460906, 5869.295684517885, 5888.646681199141, 5897.439743224387, 5926.792562260343, 5928.4960778334325, 3935.173613541131, 3944.8027598619956, 4005.0, 4016.2369149861433, 4018.33697439925, 4028.9798551007057, 4057.1479989202007, 4084.8774536763945, 4093.2399068400873, 4093.9590604094174, 4714.693544919569, 4743.57307842289, 4743.905121897543, 4749.145153872267, 4758.690685105457, 5432.891342173134, 5673.404292549306, 5695.870493891895, 5702.344230413555, 5749.913751293734, 1375.0649558300252, 1377.6418131285939, 1379.4551152294787, 1380.9240491773048, 1382.3295701584723, 903.6791938861741, 925.7639301977953, 933.5425641435647, 934.1592566689898, 950.3205208275978, 5350.224217488442, 5376.650517716336, 5383.273258110184, 5391.514763671288, 5392.379876314196, 5628.746706398222, 5640.153976903497, 5648.491635752802, 5674.489295963301, 5700.40145784695, 5231.555317797954, 5318.414974352818, 5321.32378300834, 5323.2015197719875, 5338.304156400993, 2972.7027297270533, 2998.85005749716, 3002.2944608017096, 3015.0, 3015.9547606785914, 5749.252597162342, 5768.134779783066, 5785.218995435563, 5811.476967072984, 5851.303122094545, 5422.972885135549, 5669.291338582677, 5707.258056452718, 5713.143428285857, 5758.337791153987, 5766.625169363978, 5808.3901190375245, 5810.808784199229, 5812.854678632983, 5824.708764561755, 5476.972615136899, 5510.0, 5528.004959107399, 5621.409751976147, 5667.716614169358, 5526.281583394294, 5541.251930989265, 5541.5843811715085, 5546.616563896101, 5556.416576259596, 5809.564282678732, 5820.912686309794, 5823.505002074871, 5829.883402332014, 5869.647821130746, 3780.678642315434, 3930.744501607386, 3938.8424463021156, 3983.482147320946, 3996.160806230724, 5641.66150030983, 5771.480566749013, 5800.390958949419, 5814.813334399226, 5861.736221870111, 5657.869755078733, 5699.518125287373, 5725.885482290414, 5741.741621626953, 5747.655140691572, 5634.295713035871, 5652.180433837153, 5664.892952609325, 5695.8860822784145, 5722.198892155185, 5476.753546090516, 5522.66863988162, 5539.944600553943, 5546.61173717852, 5607.383187849252, 5646.463585959327, 5672.801451949162, 5677.517411019944, 5712.314522257189, 5719.169865643121, 5478.986557393498, 5555.944300608639, 5575.414581469049, 5647.757493351456, 5649.322081350264], "value": 4246.416000294614, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.4328209073785, 736.5396627108057, 762.1311704656689, 768.0898135709182, 834.4284165346738, 15222.467213647524, 15789.526314210563, 16102.275397607107, 16137.83862161378, 16184.0, 14679.192644404553, 14794.40822367104, 14832.332545035473, 14864.256787160653, 14950.17774022431, 780.6682160081971, 804.7143264141233, 813.7762115418249, 814.9551774652392, 817.4114637461018, 791.7268542352879, 793.2067932067932, 798.0184373220942, 798.5927177139642, 800.591698233899, 850.6299759604592, 850.9872351914695, 853.7268074216254, 854.8204876975842, 855.1619412975288, 852.045708806138, 852.8209076093997, 854.6538651846013, 854.9658013679446, 856.5845564901049, 615.0896672924098, 615.8244900203465, 617.3425302053344, 621.4531212532987, 621.7979156774021, 15677.764833527392, 15834.28745706446, 15864.444744434004, 15881.444149454714, 15965.92017039919, 14049.367778449994, 14556.199409032499, 14624.570749864608, 14695.63260918475, 14890.329935152835, 12012.63962081139, 12074.939625301817, 12087.758244835055, 12224.288599596064, 12395.442205100791, 3669.6697297243377, 3701.3522633539023, 3702.796346200958, 3725.217704282104, 3858.305505009097, 78697.0, 80695.59652201818, 80770.59614701889, 82599.0, 83090.0, 11214.551417943354, 11321.490532926038, 11360.431978401211, 11387.316760994367, 11422.25755325901, 20991.116643421017, 21216.681749773765, 21252.406069544846, 21291.893540532197, 21669.783302167092, 7854.567998760009, 7945.562994035268, 8240.13478584752, 8274.420790544604, 8371.95814020926, 4545.136424079415, 4547.522510136388, 4604.654650901196, 4649.232876575327, 4653.371794807726, 3629.9473152785395, 3744.1762812181278, 3758.736888417839, 3777.131259810259, 3791.1848952474797, 601.5458328961694, 615.2340336281359, 623.052959501555, 623.9906401403982, 624.0701354981136, 653.2226650286144, 673.1182151381705, 674.1068084787578, 680.7413182990432, 709.7480394459996, 9423.717288481357, 9609.118097817092, 9783.951080244553, 9787.36382135159, 9966.15287700539, 689.5104475822122, 693.6670398208888, 716.2908720366903, 728.144430294402, 728.9963550182215, 4487.842925497592, 4494.505604383515, 4759.619710284048, 4767.356406885096, 4774.140654682191, 66169.6691516549, 66853.66573167103, 73172.0, 87040.56479717561, 87180.0, 71176.28823711697, 71934.64032679803, 71956.64021679858, 72551.6372418145, 72710.0, 65312.0, 66824.0, 67761.0, 68371.31628683649, 69942.0, 8941.239994600532, 9275.489848058422, 9389.906100938902, 9397.483138427453, 9404.38871473352, 44947.830999435486, 45740.771296143306, 46285.768571158274, 46500.30249546192, 47448.0, 57683.42316576948, 58075.419245807, 61568.38431615626, 62106.0, 63461.36538634555, 11498.310101393943, 11614.303141811519, 11863.525458981545, 11902.345371004678, 11924.0, 12353.197042192229, 12805.359732013176, 13031.501377341727, 13038.413271403, 13165.934170329087, 11955.222910510789, 12002.75994480123, 12978.610641680765, 13130.474781008652, 13754.724905502035, 12365.876341236473, 12444.937775311066, 12834.55079072228, 13016.21902685804, 13376.13055151451, 12156.574519891761, 12239.87760122423, 12350.0, 12479.251244925334, 13289.66775830612, 10535.147120512962, 10715.41065241388, 10787.0, 11252.83120753173, 11795.823062654239, 10941.398223097805, 11327.207095503236, 11340.489677964346, 11418.429078545872, 11483.440133558624], "value": 7206.268408004958, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 113.0, 113.0, 114.0, 112.0, 112.0, 114.0, 113.0, 113.0, 114.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 128.0, 126.0, 172.0, 130.0, 126.0, 131.0, 127.0, 153.0, 128.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 165.0, 170.0, 170.0, 168.0, 167.0, 167.0, 168.0, 166.0], "value": 167.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 77.0, 113.0, 77.0, 76.0, 77.0, 77.0, 96.0, 77.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 112.0, 83.0, 84.0, 85.0, 102.0, 83.0, 82.0, 111.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 118.0, 119.0, 118.0, 118.0, 119.0, 119.0, 120.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 148.0, 147.0, 149.0, 148.0, 148.0, 149.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 97.0, 97.0, 96.0, 98.0, 97.0, 97.0, 96.0, 96.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 52.0, 52.0, 56.0, 55.0, 54.0, 57.0, 54.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 88.0, 84.0, 86.0, 84.0, 82.0, 82.0, 84.0, 82.0, 81.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 142.0, 135.0, 137.0, 145.0, 147.0, 141.0, 136.0, 178.0, 134.0], "value": 142.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 177.0, 173.0, 172.0, 173.0, 178.0, 171.0, 176.0, 178.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 71.0, 71.0, 69.0, 74.0, 73.0, 78.0, 69.0, 79.0, 68.0], "value": 72.9, "unit": "score"}]}]} 08:26:41 INFO - Return code: 0 08:26:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:26:41 ERROR - # TBPL SUCCESS # 08:26:41 INFO - Running post-action listener: _resource_record_post_action 08:26:41 INFO - [mozharness: 2016-11-30 16:26:41.802130Z] Finished run-tests step (success) 08:26:41 INFO - Running post-run listener: _resource_record_post_run 08:26:41 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 410140672; Read time: 16; Write time: 348192 08:26:41 INFO - TinderboxPrint: CPU usage
13.5% 08:26:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:26:41 INFO - TinderboxPrint: I/O write bytes / time
410,140,672 / 348,192 08:26:41 INFO - TinderboxPrint: CPU idle
8,248.0 (86.5%) 08:26:41 INFO - TinderboxPrint: CPU user
1,223.7 (12.8%) 08:26:41 INFO - TinderboxPrint: Swap in / out
0 / 0 08:26:41 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120541184; Read time: 0; Write time: 118416 08:26:41 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 289054720; Read time: 0; Write time: 229744 08:26:42 INFO - Running post-run listener: _upload_blobber_files 08:26:42 INFO - Blob upload gear active. 08:26:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:26:42 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 08:26:42 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'] 08:26:42 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 08:26:42 INFO - (blobuploader) - INFO - Open directory for files ... 08:26:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:26:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:26:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:43 INFO - (blobuploader) - INFO - Done attempting. 08:26:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:26:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:26:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:47 INFO - (blobuploader) - INFO - Done attempting. 08:26:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:26:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:26:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:48 INFO - (blobuploader) - INFO - Done attempting. 08:26:48 INFO - (blobuploader) - INFO - Iteration through files over. 08:26:48 INFO - Return code: 0 08:26:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:26:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:26:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7b56b0e6a5cda54ff7ab15564c6bfc337301251616dcb314a479abe4d7946bc5edceffeee60daa980a44db47e91d0b04994e33cf67306a4967392112939059c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa157bcbec9b92a3651ce8e57f5aa6ec27bfda1a07a956f9e10cd19160bcf144f2ec737bea7919b2c52683d6dbeafe9000b282003374d17a8aeb73e502d4f6c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5b5477efe5b3aba0611e1a88e40beec8396dddbca7fcbc7cc4169fee26c2d03c7e369e08a691a4b5c01fc00e8b69e7375faa91ad06e1d2c6059a04aca94b3612"} 08:26:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:26:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:26:48 INFO - Contents: 08:26:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7b56b0e6a5cda54ff7ab15564c6bfc337301251616dcb314a479abe4d7946bc5edceffeee60daa980a44db47e91d0b04994e33cf67306a4967392112939059c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa157bcbec9b92a3651ce8e57f5aa6ec27bfda1a07a956f9e10cd19160bcf144f2ec737bea7919b2c52683d6dbeafe9000b282003374d17a8aeb73e502d4f6c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5b5477efe5b3aba0611e1a88e40beec8396dddbca7fcbc7cc4169fee26c2d03c7e369e08a691a4b5c01fc00e8b69e7375faa91ad06e1d2c6059a04aca94b3612"} 08:26:48 INFO - Running post-run listener: copy_logs_to_upload_dir 08:26:48 INFO - Copying logs to upload dir... 08:26:48 INFO - mkdir: /builds/slave/test/build/upload/logs 08:26:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.949972 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-30 08:26:47.756290) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 08:26:47.760133) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190 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/7b56b0e6a5cda54ff7ab15564c6bfc337301251616dcb314a479abe4d7946bc5edceffeee60daa980a44db47e91d0b04994e33cf67306a4967392112939059c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa157bcbec9b92a3651ce8e57f5aa6ec27bfda1a07a956f9e10cd19160bcf144f2ec737bea7919b2c52683d6dbeafe9000b282003374d17a8aeb73e502d4f6c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5b5477efe5b3aba0611e1a88e40beec8396dddbca7fcbc7cc4169fee26c2d03c7e369e08a691a4b5c01fc00e8b69e7375faa91ad06e1d2c6059a04aca94b3612"} 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.011550 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/7b56b0e6a5cda54ff7ab15564c6bfc337301251616dcb314a479abe4d7946bc5edceffeee60daa980a44db47e91d0b04994e33cf67306a4967392112939059c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa157bcbec9b92a3651ce8e57f5aa6ec27bfda1a07a956f9e10cd19160bcf144f2ec737bea7919b2c52683d6dbeafe9000b282003374d17a8aeb73e502d4f6c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5b5477efe5b3aba0611e1a88e40beec8396dddbca7fcbc7cc4169fee26c2d03c7e369e08a691a4b5c01fc00e8b69e7375faa91ad06e1d2c6059a04aca94b3612"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 08:26:47.787286) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 08:26:47.787656) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1480516710.705839-1016831190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 08:26:47.872840) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 08:26:47.873171) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 08:26:47.873459) ========= ========= Total master_lag: 0.17 =========