builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1477028961.22 results: success (0) buildid: 20161020224155 builduid: 2c30bbc7b8cb49b0bd5244afb8639c51 revision: 1171f3ae792b91d7ca49ef0907b251e381f1df56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 22:49:21.221798) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 22:49:21.222734) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 22:49:21.223419) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 22:49:21.242754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 22:49:21.243397) ========= 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=836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 22:49:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.5M=0s 2016-10-20 22:49:21 (70.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119686 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 22:49:21.379930) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 22:49:21.380285) ========= 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=836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018464 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 22:49:21.429576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 22:49:21.429951) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1171f3ae792b91d7ca49ef0907b251e381f1df56 --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 1171f3ae792b91d7ca49ef0907b251e381f1df56 --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=836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 22:49:21,889 truncating revision to first 12 chars 2016-10-20 22:49:21,889 Setting DEBUG logging. 2016-10-20 22:49:21,889 attempt 1/10 2016-10-20 22:49:21,889 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1171f3ae792b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 22:49:22,947 unpacking tar archive at: mozilla-inbound-1171f3ae792b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.385598 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 22:49:22.830779) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 22:49:22.831147) ========= script_repo_revision: 1171f3ae792b91d7ca49ef0907b251e381f1df56 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 22:49:22.831586) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 22:49:22.831902) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 22:49:22.841558) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-20 22:49:22.841875) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:49:23 INFO - MultiFileLogger online at 20161020 22:49:23 in /builds/slave/test 22:49:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:49:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:49:23 INFO - {'append_to_log': False, 22:49:23 INFO - 'base_work_dir': '/builds/slave/test', 22:49:23 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:49:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:49:23 INFO - 'branch': 'Mozilla-Inbound', 22:49:23 INFO - 'buildbot_json_path': 'buildprops.json', 22:49:23 INFO - 'config_files': ('talos/linux_config.py',), 22:49:23 INFO - 'default_actions': ('clobber', 22:49:23 INFO - 'read-buildbot-config', 22:49:23 INFO - 'download-and-extract', 22:49:23 INFO - 'populate-webroot', 22:49:23 INFO - 'create-virtualenv', 22:49:23 INFO - 'install', 22:49:23 INFO - 'run-tests'), 22:49:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:49:23 INFO - 'download_minidump_stackwalk': True, 22:49:23 INFO - 'download_symbols': 'ondemand', 22:49:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:49:23 INFO - 'tooltool.py': '/tools/tooltool.py', 22:49:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:49:23 INFO - '/tools/misc-python/virtualenv.py')}, 22:49:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:49:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:49:23 INFO - 'installer_path': 'installer.exe', 22:49:23 INFO - 'log_level': 'info', 22:49:23 INFO - 'log_name': 'talos', 22:49:23 INFO - 'log_to_console': True, 22:49:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:49:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:49:23 INFO - 'opt_config_files': (), 22:49:23 INFO - 'pip_index': False, 22:49:23 INFO - 'sps_profile': False, 22:49:23 INFO - 'sps_profile_interval': 0, 22:49:23 INFO - 'suite': 'dromaeojs', 22:49:23 INFO - 'system_bits': '32', 22:49:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:49:23 INFO - 'title': 'talos-linux64-ix-028', 22:49:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:49:23 INFO - 'use_talos_json': True, 22:49:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:49:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:49:23 INFO - 'work_dir': 'build'} 22:49:23 INFO - [mozharness: 2016-10-21 05:49:23.400193Z] Running clobber step. 22:49:23 INFO - Running pre-action listener: _resource_record_pre_action 22:49:23 INFO - Running main action method: clobber 22:49:23 INFO - rmtree: /builds/slave/test/build 22:49:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:49:24 INFO - Running post-action listener: _resource_record_post_action 22:49:24 INFO - [mozharness: 2016-10-21 05:49:24.374356Z] Finished clobber step (success) 22:49:24 INFO - [mozharness: 2016-10-21 05:49:24.374455Z] Running read-buildbot-config step. 22:49:24 INFO - Running pre-action listener: _resource_record_pre_action 22:49:24 INFO - Running main action method: read_buildbot_config 22:49:24 INFO - Using buildbot properties: 22:49:24 INFO - { 22:49:24 INFO - "project": "", 22:49:24 INFO - "product": "firefox", 22:49:24 INFO - "script_repo_revision": "production", 22:49:24 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 22:49:24 INFO - "repository": "", 22:49:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 22:49:24 INFO - "buildid": "20161020224155", 22:49:24 INFO - "stage_platform": "linux64-pgo", 22:49:24 INFO - "basedir": "/builds/slave/test", 22:49:24 INFO - "buildnumber": 1878, 22:49:24 INFO - "platform": "ubuntu64_hw", 22:49:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:49:24 INFO - "slavebuilddir": "test", 22:49:24 INFO - "branch": "mozilla-inbound", 22:49:24 INFO - "revision": "1171f3ae792b91d7ca49ef0907b251e381f1df56", 22:49:24 INFO - "slavename": "talos-linux64-ix-028", 22:49:24 INFO - "builduid": "2c30bbc7b8cb49b0bd5244afb8639c51", 22:49:24 INFO - "repo_path": "integration/mozilla-inbound" 22:49:24 INFO - } 22:49:24 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 22:49:24 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 22:49:24 INFO - Running post-action listener: _resource_record_post_action 22:49:24 INFO - [mozharness: 2016-10-21 05:49:24.376793Z] Finished read-buildbot-config step (success) 22:49:24 INFO - [mozharness: 2016-10-21 05:49:24.376879Z] Running download-and-extract step. 22:49:24 INFO - Running pre-action listener: _resource_record_pre_action 22:49:24 INFO - Running main action method: download_and_extract 22:49:24 INFO - mkdir: /builds/slave/test/build/tests 22:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:49:24 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:49:24 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:49:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:49:24 INFO - Downloaded 1361 bytes. 22:49:24 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:49:24 INFO - Using the following test package requirements: 22:49:24 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:49:24 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:49:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:49:24 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:49:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:49:24 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:49:24 INFO - u'jsshell-linux-x86_64.zip'], 22:49:24 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:49:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:49:24 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:49:24 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:49:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:49:24 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:49:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:49:24 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:49:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:49:24 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:49:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:49:24 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:49:24 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/1477017007/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:49:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:49:24 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:49:24 INFO - Http code: 200 22:49:24 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 22:49:24 INFO - x-amz-cf-id: clR4ETiAgVQpM3wuHhjRKdbw0BOYKZRhicFOSOQR-NQAqneg4q4uug== 22:49:24 INFO - x-amz-replication-status: COMPLETED 22:49:24 INFO - x-amz-version-id: qgar26m6taTPFsnE1hbyBpunsmMZykDF 22:49:24 INFO - Expected file size: 22120017 22:49:24 INFO - Obtained file size: 22120017 22:49:28 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:49:28 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/1477017007/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:49:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:49:28 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:49:28 INFO - Http code: 200 22:49:28 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 22:49:28 INFO - x-amz-cf-id: gZiDqQdKQUNf2RgasY5YTtdYtcMJGeODzTxtmJgY-Pg3ONLqpTQVpA== 22:49:28 INFO - x-amz-replication-status: COMPLETED 22:49:28 INFO - x-amz-version-id: qgar26m6taTPFsnE1hbyBpunsmMZykDF 22:49:29 INFO - Expected file size: 22120017 22:49:29 INFO - Obtained file size: 22120017 22:49:33 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/1477017007/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 22:49:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:49:33 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:49:33 INFO - Http code: 200 22:49:33 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 22:49:33 INFO - x-amz-cf-id: Rq9R0Hu_TS46SyXsRFs34I6M6rkKiuOK4wlKa6vFO38jfZeImd3yfg== 22:49:33 INFO - x-amz-replication-status: COMPLETED 22:49:33 INFO - x-amz-version-id: fqM41GWwnDxTQo8GN7s3EmLKcLJqa74. 22:49:33 INFO - Expected file size: 14409028 22:49:33 INFO - Obtained file size: 14409028 22:49: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')]} 22:49:34 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:49:34 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:49:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:49:34 INFO - Downloaded 59464235 bytes. 22:49:34 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:49:34 INFO - mkdir: /builds/slave/test/properties 22:49:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:49:34 INFO - Writing to file /builds/slave/test/properties/build_url 22:49:34 INFO - Contents: 22:49:34 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:49:35 INFO - Running post-action listener: _resource_record_post_action 22:49:35 INFO - Running post-action listener: set_extra_try_arguments 22:49:35 INFO - [mozharness: 2016-10-21 05:49:35.124168Z] Finished download-and-extract step (success) 22:49:35 INFO - [mozharness: 2016-10-21 05:49:35.124394Z] Running populate-webroot step. 22:49:35 INFO - Running pre-action listener: _resource_record_pre_action 22:49:35 INFO - Running main action method: populate_webroot 22:49:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:49:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:49:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:49:35 INFO - '--tppagecycles', 22:49:35 INFO - '7'], 22:49:35 INFO - 'tests': ['tsvgm']}}, 22:49:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:49:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:49:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:49:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:49:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:49:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:49:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:49:35 INFO - 'talos_options': ['--disable-e10s'], 22:49:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:49:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:49:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:49:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:49:35 INFO - 'talos_options': ['--disable-e10s'], 22:49:35 INFO - 'tests': ['damp', 'tps']}, 22:49:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:49:35 INFO - 'tests': ['damp', 'tps']}, 22:49:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:49:35 INFO - 'tests': ['dromaeo_dom']}, 22:49:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:49:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:49:35 INFO - 'tests': ['basic_compositor_video']}, 22:49:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:49:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:49:35 INFO - 'tests': ['a11yr', 22:49:35 INFO - 'ts_paint', 22:49:35 INFO - 'tpaint', 22:49:35 INFO - 'sessionrestore', 22:49:35 INFO - 'sessionrestore_no_auto_restore', 22:49:35 INFO - 'tabpaint']}, 22:49:35 INFO - 'other-e10s': {'tests': ['a11yr', 22:49:35 INFO - 'ts_paint', 22:49:35 INFO - 'tpaint', 22:49:35 INFO - 'sessionrestore', 22:49:35 INFO - 'sessionrestore_no_auto_restore', 22:49:35 INFO - 'tabpaint']}, 22:49:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:49:35 INFO - 'ts_paint', 22:49:35 INFO - 'tpaint', 22:49:35 INFO - 'sessionrestore', 22:49:35 INFO - 'sessionrestore_no_auto_restore', 22:49:35 INFO - 'tabpaint']}, 22:49:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:49:35 INFO - 'ts_paint', 22:49:35 INFO - 'tpaint', 22:49:35 INFO - 'sessionrestore', 22:49:35 INFO - 'sessionrestore_no_auto_restore', 22:49:35 INFO - 'tabpaint']}, 22:49:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:49:35 INFO - 'tests': ['a11yr', 22:49:35 INFO - 'ts_paint', 22:49:35 INFO - 'tpaint', 22:49:35 INFO - 'sessionrestore', 22:49:35 INFO - 'sessionrestore_no_auto_restore', 22:49:35 INFO - 'tabpaint']}, 22:49:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:49:35 INFO - 'tests': ['a11yr', 22:49:35 INFO - 'ts_paint', 22:49:35 INFO - 'tpaint', 22:49:35 INFO - 'sessionrestore', 22:49:35 INFO - 'sessionrestore_no_auto_restore', 22:49:35 INFO - 'tabpaint']}, 22:49:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:49:35 INFO - 'tests': ['tsvgx', 22:49:35 INFO - 'tsvgr_opacity', 22:49:35 INFO - 'tart', 22:49:35 INFO - 'tscrollx', 22:49:35 INFO - 'cart']}, 22:49:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:49:35 INFO - 'tsvgr_opacity', 22:49:35 INFO - 'tart', 22:49:35 INFO - 'tscrollx', 22:49:35 INFO - 'cart']}, 22:49:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:49:35 INFO - 'talos_options': ['--disable-e10s'], 22:49:35 INFO - 'tests': ['tp5o']}, 22:49:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:49:35 INFO - 'tests': ['tp5o']}, 22:49:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:49:35 INFO - 'talos_options': ['--disable-e10s', 22:49:35 INFO - '--xperf_path', 22:49:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:49:35 INFO - 'tests': ['tp5n']}, 22:49:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:49:35 INFO - 'talos_options': ['--xperf_path', 22:49:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:49:35 INFO - 'tests': ['tp5n']}}, 22:49:35 INFO - 'talos.zip': {'path': '', 22:49:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:49:35 INFO - Running post-action listener: _resource_record_post_action 22:49:35 INFO - [mozharness: 2016-10-21 05:49:35.143173Z] Finished populate-webroot step (success) 22:49:35 INFO - [mozharness: 2016-10-21 05:49:35.143260Z] Running create-virtualenv step. 22:49:35 INFO - Running pre-action listener: _resource_record_pre_action 22:49:35 INFO - Running main action method: create_virtualenv 22:49:35 INFO - Creating virtualenv /builds/slave/test/build/venv 22:49:35 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 22:49:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:49:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:49:35 INFO - Using real prefix '/usr' 22:49:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:49:35 INFO - Installing distribute.............................................................................................................................................................................................done. 22:49:37 INFO - Installing pip.................done. 22:49:37 INFO - Return code: 0 22:49:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:49:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:49:37 INFO - Reading from file tmpfile_stdout 22:49:37 INFO - Output received: 22:49:37 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) 22:49:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:49: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')]} 22:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49: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')]} 22:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:37 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 0x7f0a50c14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d38e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286c100>, '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 0x28639d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e60>, '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': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', '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 22:49:37 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 22:49:37 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 22:49:37 INFO - Using env: {'DISPLAY': ':0', 22:49:37 INFO - 'HOME': '/home/cltbld', 22:49:37 INFO - 'LANG': 'en_US.UTF-8', 22:49:37 INFO - 'LANGUAGE': 'en_US:en', 22:49:37 INFO - 'LOGNAME': 'cltbld', 22:49:37 INFO - 'MAIL': '/var/mail/cltbld', 22:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:49:37 INFO - 'MOZ_NO_REMOTE': '1', 22:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:49:37 INFO - 'NO_EM_RESTART': '1', 22:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:49:37 INFO - 'PWD': '/builds/slave/test', 22:49:37 INFO - 'SHELL': '/bin/bash', 22:49:37 INFO - 'SHLVL': '1', 22:49:37 INFO - 'TERM': 'linux', 22:49:37 INFO - 'TMOUT': '86400', 22:49:37 INFO - 'USER': 'cltbld', 22:49:37 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', 22:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:49:37 INFO - '_': '/tools/buildbot/bin/python'} 22:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:49:38 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 22:49:38 INFO - Cleaning up... 22:49:38 INFO - Return code: 0 22:49:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:38 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 0x7f0a50c14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d38e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286c100>, '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 0x28639d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e60>, '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': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', '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 22:49:38 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 22:49:38 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 22:49:38 INFO - Using env: {'DISPLAY': ':0', 22:49:38 INFO - 'HOME': '/home/cltbld', 22:49:38 INFO - 'LANG': 'en_US.UTF-8', 22:49:38 INFO - 'LANGUAGE': 'en_US:en', 22:49:38 INFO - 'LOGNAME': 'cltbld', 22:49:38 INFO - 'MAIL': '/var/mail/cltbld', 22:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:49:38 INFO - 'MOZ_NO_REMOTE': '1', 22:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:49:38 INFO - 'NO_EM_RESTART': '1', 22:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:49:38 INFO - 'PWD': '/builds/slave/test', 22:49:38 INFO - 'SHELL': '/bin/bash', 22:49:38 INFO - 'SHLVL': '1', 22:49:38 INFO - 'TERM': 'linux', 22:49:38 INFO - 'TMOUT': '86400', 22:49:38 INFO - 'USER': 'cltbld', 22:49:38 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', 22:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:49:38 INFO - '_': '/tools/buildbot/bin/python'} 22:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:49:38 INFO - Downloading/unpacking psutil>=3.1.1 22:49:38 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 22:49:38 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 22:49:38 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 22:49:38 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 22:49:38 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 22:49:38 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 22:49:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:49:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:49:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:49:40 INFO - Installing collected packages: psutil 22:49:40 INFO - Running setup.py install for psutil 22:49:40 INFO - building 'psutil._psutil_linux' extension 22:49:40 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 22:49:40 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 22:49:40 INFO - building 'psutil._psutil_posix' extension 22:49:40 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 22:49:40 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 22:49:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:49:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:49:40 INFO - Successfully installed psutil 22:49:40 INFO - Cleaning up... 22:49:40 INFO - Return code: 0 22:49:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:49:40 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')]} 22:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:40 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')]} 22:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:40 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 0x7f0a50c14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d38e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286c100>, '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 0x28639d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e60>, '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': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', '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 22:49:40 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 22:49:40 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 22:49:40 INFO - Using env: {'DISPLAY': ':0', 22:49:40 INFO - 'HOME': '/home/cltbld', 22:49:40 INFO - 'LANG': 'en_US.UTF-8', 22:49:40 INFO - 'LANGUAGE': 'en_US:en', 22:49:40 INFO - 'LOGNAME': 'cltbld', 22:49:40 INFO - 'MAIL': '/var/mail/cltbld', 22:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:49:40 INFO - 'MOZ_NO_REMOTE': '1', 22:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:49:40 INFO - 'NO_EM_RESTART': '1', 22:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:49:40 INFO - 'PWD': '/builds/slave/test', 22:49:40 INFO - 'SHELL': '/bin/bash', 22:49:40 INFO - 'SHLVL': '1', 22:49:40 INFO - 'TERM': 'linux', 22:49:40 INFO - 'TMOUT': '86400', 22:49:40 INFO - 'USER': 'cltbld', 22:49:40 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', 22:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:49:40 INFO - '_': '/tools/buildbot/bin/python'} 22:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:49:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:49:41 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 22:49:41 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 22:49:41 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 22:49:41 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 22:49:41 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 22:49:41 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 22:49:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:49:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:49:43 INFO - Installing collected packages: mozsystemmonitor 22:49:43 INFO - Running setup.py install for mozsystemmonitor 22:49:43 INFO - Successfully installed mozsystemmonitor 22:49:43 INFO - Cleaning up... 22:49:43 INFO - Return code: 0 22:49:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:49:43 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')]} 22:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:43 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')]} 22:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:43 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 0x7f0a50c14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d38e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286c100>, '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 0x28639d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e60>, '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': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', '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 22:49:43 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 22:49:43 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 22:49:43 INFO - Using env: {'DISPLAY': ':0', 22:49:43 INFO - 'HOME': '/home/cltbld', 22:49:43 INFO - 'LANG': 'en_US.UTF-8', 22:49:43 INFO - 'LANGUAGE': 'en_US:en', 22:49:43 INFO - 'LOGNAME': 'cltbld', 22:49:43 INFO - 'MAIL': '/var/mail/cltbld', 22:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:49:43 INFO - 'MOZ_NO_REMOTE': '1', 22:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:49:43 INFO - 'NO_EM_RESTART': '1', 22:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:49:43 INFO - 'PWD': '/builds/slave/test', 22:49:43 INFO - 'SHELL': '/bin/bash', 22:49:43 INFO - 'SHLVL': '1', 22:49:43 INFO - 'TERM': 'linux', 22:49:43 INFO - 'TMOUT': '86400', 22:49:43 INFO - 'USER': 'cltbld', 22:49:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', 22:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:49:43 INFO - '_': '/tools/buildbot/bin/python'} 22:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:49:43 INFO - Downloading/unpacking jsonschema==2.5.1 22:49:43 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 22:49:43 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 22:49:43 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 22:49:43 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 22:49:43 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 22:49:43 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 22:49:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:49:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:49:45 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 22:49:45 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 22:49:45 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 22:49:45 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 22:49:45 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 22:49:45 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 22:49:45 INFO - Downloading functools32-3.2.3-2.tar.gz 22:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:49:45 INFO - warning: no files found matching '*.txt' 22:49:45 INFO - no previously-included directories found matching 'build' 22:49:45 INFO - no previously-included directories found matching 'dist' 22:49:45 INFO - no previously-included directories found matching '.git*' 22:49:45 INFO - Installing collected packages: jsonschema, functools32 22:49:45 INFO - Running setup.py install for functools32 22:49:45 INFO - warning: no files found matching '*.txt' 22:49:45 INFO - no previously-included directories found matching 'build' 22:49:45 INFO - no previously-included directories found matching 'dist' 22:49:45 INFO - no previously-included directories found matching '.git*' 22:49:45 INFO - Successfully installed jsonschema functools32 22:49:45 INFO - Cleaning up... 22:49:45 INFO - Return code: 0 22:49:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:49: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')]} 22:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49: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')]} 22:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49: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', '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 0x7f0a50c14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d38e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286c100>, '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 0x28639d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e60>, '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': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', '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 22:49: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:49: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 functools32==3.2.3-2 22:49:45 INFO - Using env: {'DISPLAY': ':0', 22:49:45 INFO - 'HOME': '/home/cltbld', 22:49:45 INFO - 'LANG': 'en_US.UTF-8', 22:49:45 INFO - 'LANGUAGE': 'en_US:en', 22:49:45 INFO - 'LOGNAME': 'cltbld', 22:49:45 INFO - 'MAIL': '/var/mail/cltbld', 22:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:49:45 INFO - 'MOZ_NO_REMOTE': '1', 22:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:49:45 INFO - 'NO_EM_RESTART': '1', 22:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:49:45 INFO - 'PWD': '/builds/slave/test', 22:49:45 INFO - 'SHELL': '/bin/bash', 22:49:45 INFO - 'SHLVL': '1', 22:49:45 INFO - 'TERM': 'linux', 22:49:45 INFO - 'TMOUT': '86400', 22:49:45 INFO - 'USER': 'cltbld', 22:49:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', 22:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:49:45 INFO - '_': '/tools/buildbot/bin/python'} 22:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:49:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:49:46 INFO - Cleaning up... 22:49:46 INFO - Return code: 0 22:49:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:49:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:49:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:46 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 0x7f0a50c14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d38e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286c100>, '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 0x28639d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e60>, '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': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', '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 22:49:46 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 22:49:46 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 22:49:46 INFO - Using env: {'DISPLAY': ':0', 22:49:46 INFO - 'HOME': '/home/cltbld', 22:49:46 INFO - 'LANG': 'en_US.UTF-8', 22:49:46 INFO - 'LANGUAGE': 'en_US:en', 22:49:46 INFO - 'LOGNAME': 'cltbld', 22:49:46 INFO - 'MAIL': '/var/mail/cltbld', 22:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:49:46 INFO - 'MOZ_NO_REMOTE': '1', 22:49:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:49:46 INFO - 'NO_EM_RESTART': '1', 22:49:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:49:46 INFO - 'PWD': '/builds/slave/test', 22:49:46 INFO - 'SHELL': '/bin/bash', 22:49:46 INFO - 'SHLVL': '1', 22:49:46 INFO - 'TERM': 'linux', 22:49:46 INFO - 'TMOUT': '86400', 22:49:46 INFO - 'USER': 'cltbld', 22:49:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', 22:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:49:46 INFO - '_': '/tools/buildbot/bin/python'} 22:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:49:46 INFO - Downloading/unpacking blobuploader==1.2.4 22:49:46 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 22:49:46 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 22:49:46 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 22:49:46 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 22:49:46 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 22:49:46 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 22:49:48 INFO - Downloading blobuploader-1.2.4.tar.gz 22:49:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:49:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:49:48 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 22:49:48 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 22:49:48 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 22:49:48 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 22:49:48 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 22:49:48 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 22:49:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:49:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:49:48 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 22:49:48 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 22:49:48 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 22:49:48 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 22:49:48 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 22:49:48 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 22:49:48 INFO - Downloading docopt-0.6.1.tar.gz 22:49:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:49:49 INFO - Installing collected packages: blobuploader, requests, docopt 22:49:49 INFO - Running setup.py install for blobuploader 22:49:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:49:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:49:49 INFO - Running setup.py install for requests 22:49:49 INFO - Running setup.py install for docopt 22:49:49 INFO - Successfully installed blobuploader requests docopt 22:49:49 INFO - Cleaning up... 22:49:49 INFO - Return code: 0 22:49:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:49 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 0x7f0a50c14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d38e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286c100>, '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 0x28639d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e60>, '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': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', '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 22:49:49 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 22:49:49 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 22:49:49 INFO - Using env: {'DISPLAY': ':0', 22:49:49 INFO - 'HOME': '/home/cltbld', 22:49:49 INFO - 'LANG': 'en_US.UTF-8', 22:49:49 INFO - 'LANGUAGE': 'en_US:en', 22:49:49 INFO - 'LOGNAME': 'cltbld', 22:49:49 INFO - 'MAIL': '/var/mail/cltbld', 22:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:49:49 INFO - 'MOZ_NO_REMOTE': '1', 22:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:49:49 INFO - 'NO_EM_RESTART': '1', 22:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:49:49 INFO - 'PWD': '/builds/slave/test', 22:49:49 INFO - 'SHELL': '/bin/bash', 22:49:49 INFO - 'SHLVL': '1', 22:49:49 INFO - 'TERM': 'linux', 22:49:49 INFO - 'TMOUT': '86400', 22:49:49 INFO - 'USER': 'cltbld', 22:49:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', 22:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:49:49 INFO - '_': '/tools/buildbot/bin/python'} 22:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:49:49 INFO - Running setup.py (path:/tmp/pip-XrGSRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:49:49 INFO - Running setup.py (path:/tmp/pip-RBpBNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:49:50 INFO - Running setup.py (path:/tmp/pip-2ajVe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:49:50 INFO - Running setup.py (path:/tmp/pip-CYfUbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:49:50 INFO - Running setup.py (path:/tmp/pip-TNHKeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:49:50 INFO - Running setup.py (path:/tmp/pip-ZWJ0oP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:49:50 INFO - Running setup.py (path:/tmp/pip-ehIiQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:49:50 INFO - Running setup.py (path:/tmp/pip-ZJCkmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:49:50 INFO - Running setup.py (path:/tmp/pip-rV53Bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:49:50 INFO - Running setup.py (path:/tmp/pip-hHzAGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:49:50 INFO - Running setup.py (path:/tmp/pip-pxgOFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:49:50 INFO - Running setup.py (path:/tmp/pip-VXLr2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:49:50 INFO - Running setup.py (path:/tmp/pip-r80SOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:49:50 INFO - Running setup.py (path:/tmp/pip-agCdfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:49:50 INFO - Running setup.py (path:/tmp/pip-rzgEFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:49:50 INFO - Running setup.py (path:/tmp/pip-G_WVA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:49:51 INFO - Running setup.py (path:/tmp/pip-H0uKRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:49:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:49:51 INFO - Running setup.py install for manifestparser 22:49:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:49:51 INFO - Running setup.py install for mozcrash 22:49:51 INFO - Running setup.py install for mozdebug 22:49:51 INFO - Running setup.py install for mozdevice 22:49:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:49:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:49:51 INFO - Running setup.py install for mozfile 22:49:51 INFO - Running setup.py install for mozhttpd 22:49:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:49:51 INFO - Running setup.py install for mozinfo 22:49:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:49:51 INFO - Running setup.py install for mozInstall 22:49:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:49:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:49:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:49:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:49:51 INFO - Running setup.py install for mozleak 22:49:52 INFO - Running setup.py install for mozlog 22:49:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:49:52 INFO - Running setup.py install for moznetwork 22:49:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:49:52 INFO - Running setup.py install for mozprocess 22:49:52 INFO - Running setup.py install for mozprofile 22:49:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:49:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:49:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:49:52 INFO - Running setup.py install for mozrunner 22:49:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:49:52 INFO - Running setup.py install for mozscreenshot 22:49:52 INFO - Running setup.py install for moztest 22:49:52 INFO - Running setup.py install for mozversion 22:49:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:49:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:49:52 INFO - Cleaning up... 22:49:52 INFO - Return code: 0 22:49:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:52 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 0x7f0a50c14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d38e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286c100>, '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 0x28639d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e60>, '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': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', '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 22:49:52 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 22:49:52 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 22:49:52 INFO - Using env: {'DISPLAY': ':0', 22:49:52 INFO - 'HOME': '/home/cltbld', 22:49:52 INFO - 'LANG': 'en_US.UTF-8', 22:49:52 INFO - 'LANGUAGE': 'en_US:en', 22:49:52 INFO - 'LOGNAME': 'cltbld', 22:49:52 INFO - 'MAIL': '/var/mail/cltbld', 22:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:49:52 INFO - 'MOZ_NO_REMOTE': '1', 22:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:49:52 INFO - 'NO_EM_RESTART': '1', 22:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:49:52 INFO - 'PWD': '/builds/slave/test', 22:49:52 INFO - 'SHELL': '/bin/bash', 22:49:52 INFO - 'SHLVL': '1', 22:49:52 INFO - 'TERM': 'linux', 22:49:52 INFO - 'TMOUT': '86400', 22:49:52 INFO - 'USER': 'cltbld', 22:49:52 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', 22:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:49:52 INFO - '_': '/tools/buildbot/bin/python'} 22:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:49:53 INFO - Running setup.py (path:/tmp/pip-AuAWQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:49:53 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)) 22:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:49:53 INFO - Running setup.py (path:/tmp/pip-2zJjnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:49:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:49:53 INFO - Running setup.py (path:/tmp/pip-CwyxvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:49:53 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)) 22:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:49:53 INFO - Running setup.py (path:/tmp/pip-GdbeBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:49:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:49:53 INFO - Running setup.py (path:/tmp/pip-yLS1yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:49:53 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)) 22:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:49:53 INFO - Running setup.py (path:/tmp/pip-EZbcHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:49:53 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)) 22:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:49:53 INFO - Running setup.py (path:/tmp/pip-1KxUR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:49:53 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)) 22:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:49:53 INFO - Running setup.py (path:/tmp/pip-gJM5xY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:49:53 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)) 22:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:49:53 INFO - Running setup.py (path:/tmp/pip-KJcGhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:49:53 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)) 22:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:49:53 INFO - Running setup.py (path:/tmp/pip-StRqMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:49:53 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)) 22:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:49:53 INFO - Running setup.py (path:/tmp/pip-ugvRVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:49:53 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)) 22:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:49:53 INFO - Running setup.py (path:/tmp/pip-4ysQ6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:49:54 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)) 22:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:49:54 INFO - Running setup.py (path:/tmp/pip-XBOQEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:49:54 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)) 22:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:49:54 INFO - Running setup.py (path:/tmp/pip-fNqXyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:49:54 INFO - Running setup.py (path:/tmp/pip-VaCbiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:49:54 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)) 22:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:49:54 INFO - Running setup.py (path:/tmp/pip-vDuFaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:49:54 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)) 22:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:49:54 INFO - Running setup.py (path:/tmp/pip-ci105q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:49:54 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)) 22:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:49:54 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)) 22:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:49:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:49:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:49:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:49:56 INFO - Downloading blessings-1.6.tar.gz 22:49:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:49:56 INFO - Installing collected packages: blessings 22:49:56 INFO - Running setup.py install for blessings 22:49:56 INFO - Successfully installed blessings 22:49:56 INFO - Cleaning up... 22:49:56 INFO - Return code: 0 22:49:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:49:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:49:56 INFO - Reading from file tmpfile_stdout 22:49:56 INFO - Current package versions: 22:49:56 INFO - argparse == 1.2.1 22:49:56 INFO - blessings == 1.6 22:49:56 INFO - blobuploader == 1.2.4 22:49:56 INFO - docopt == 0.6.1 22:49:56 INFO - functools32 == 3.2.3-2 22:49:56 INFO - jsonschema == 2.5.1 22:49:56 INFO - manifestparser == 1.1 22:49:56 INFO - mozInstall == 1.12 22:49:56 INFO - mozcrash == 0.17 22:49:56 INFO - mozdebug == 0.1 22:49:56 INFO - mozdevice == 0.48 22:49:56 INFO - mozfile == 1.2 22:49:56 INFO - mozhttpd == 0.7 22:49:56 INFO - mozinfo == 0.9 22:49:56 INFO - mozleak == 0.1 22:49:56 INFO - mozlog == 3.4 22:49:56 INFO - moznetwork == 0.27 22:49:56 INFO - mozprocess == 0.23 22:49:56 INFO - mozprofile == 0.28 22:49:56 INFO - mozrunner == 6.12 22:49:56 INFO - mozscreenshot == 0.1 22:49:56 INFO - mozsystemmonitor == 0.3 22:49:56 INFO - moztest == 0.7 22:49:56 INFO - mozversion == 1.4 22:49:56 INFO - psutil == 3.1.1 22:49:56 INFO - requests == 1.2.3 22:49:56 INFO - wsgiref == 0.1.2 22:49:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:56 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 0x7f0a50c14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d38e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286c100>, '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 0x28639d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e60>, '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': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', '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 22:49:56 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 22:49:56 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 22:49:56 INFO - Using env: {'DISPLAY': ':0', 22:49:56 INFO - 'HOME': '/home/cltbld', 22:49:56 INFO - 'LANG': 'en_US.UTF-8', 22:49:56 INFO - 'LANGUAGE': 'en_US:en', 22:49:56 INFO - 'LOGNAME': 'cltbld', 22:49:56 INFO - 'MAIL': '/var/mail/cltbld', 22:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:49:56 INFO - 'MOZ_NO_REMOTE': '1', 22:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:49:56 INFO - 'NO_EM_RESTART': '1', 22:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:49:56 INFO - 'PWD': '/builds/slave/test', 22:49:56 INFO - 'SHELL': '/bin/bash', 22:49:56 INFO - 'SHLVL': '1', 22:49:56 INFO - 'TERM': 'linux', 22:49:56 INFO - 'TMOUT': '86400', 22:49:56 INFO - 'USER': 'cltbld', 22:49:56 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', 22:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:49:56 INFO - '_': '/tools/buildbot/bin/python'} 22:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:49:57 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)) 22:49:57 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)) 22:49:57 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)) 22:49:57 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)) 22:49:57 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)) 22:49:57 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)) 22:49:57 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)) 22:49:57 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)) 22:49:57 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)) 22:49:57 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)) 22:49:57 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)) 22:49:57 INFO - Cleaning up... 22:49:57 INFO - Return code: 0 22:49:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0a50c14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d38e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286c100>, '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 0x28639d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e60>, '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': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', '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 22:49:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:49:57 INFO - Using env: {'DISPLAY': ':0', 22:49:57 INFO - 'HOME': '/home/cltbld', 22:49:57 INFO - 'LANG': 'en_US.UTF-8', 22:49:57 INFO - 'LANGUAGE': 'en_US:en', 22:49:57 INFO - 'LOGNAME': 'cltbld', 22:49:57 INFO - 'MAIL': '/var/mail/cltbld', 22:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:49:57 INFO - 'MOZ_NO_REMOTE': '1', 22:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:49:57 INFO - 'NO_EM_RESTART': '1', 22:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:49:57 INFO - 'PWD': '/builds/slave/test', 22:49:57 INFO - 'SHELL': '/bin/bash', 22:49:57 INFO - 'SHLVL': '1', 22:49:57 INFO - 'TERM': 'linux', 22:49:57 INFO - 'TMOUT': '86400', 22:49:57 INFO - 'USER': 'cltbld', 22:49:57 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', 22:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:49:57 INFO - '_': '/tools/buildbot/bin/python'} 22:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:49:57 INFO - Cleaning up... 22:49:57 INFO - Return code: 0 22:49:57 INFO - Running post-action listener: _resource_record_post_action 22:49:57 INFO - Running post-action listener: _start_resource_monitoring 22:49:57 INFO - Starting resource monitoring. 22:49:57 INFO - [mozharness: 2016-10-21 05:49:57.285918Z] Finished create-virtualenv step (success) 22:49:57 INFO - [mozharness: 2016-10-21 05:49:57.286433Z] Running install step. 22:49:57 INFO - Running pre-action listener: _resource_record_pre_action 22:49:57 INFO - Running main action method: install 22:49:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:49:57 INFO - Reading from file tmpfile_stdout 22:49:57 INFO - Detecting whether we're running mozinstall >=1.0... 22:49:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:49:57 INFO - Reading from file tmpfile_stdout 22:49:57 INFO - Output received: 22:49:57 INFO - Usage: mozinstall [options] installer 22:49:57 INFO - Options: 22:49:57 INFO - -h, --help show this help message and exit 22:49:57 INFO - -d DEST, --destination=DEST 22:49:57 INFO - Directory to install application into. [default: 22:49:57 INFO - "/builds/slave/test"] 22:49:57 INFO - --app=APP Application being installed. [default: firefox] 22:49:57 INFO - mkdir: /builds/slave/test/build/application 22:49:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:50:14 INFO - Reading from file tmpfile_stdout 22:50:14 INFO - Output received: 22:50:14 INFO - /builds/slave/test/build/application/firefox/firefox 22:50:14 INFO - Running post-action listener: _resource_record_post_action 22:50:14 INFO - [mozharness: 2016-10-21 05:50:14.540778Z] Finished install step (success) 22:50:14 INFO - [mozharness: 2016-10-21 05:50:14.541054Z] Running run-tests step. 22:50:14 INFO - Running pre-action listener: _resource_record_pre_action 22:50:14 INFO - Running main action method: run_tests 22:50:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:50:14 INFO - Python 2.7.3 22:50:14 INFO - Return code: 0 22:50:14 INFO - grabbing minidump binary from tooltool 22:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:50:14 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 0x286c100>, '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 0x28639d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:50:14 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 22:50:14 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 22:50:14 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 22:50:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:50:14 INFO - Return code: 0 22:50:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:50:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:50:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:50:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:50:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:50:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:50:14 INFO - Using env: {'DISPLAY': ':0', 22:50:14 INFO - 'HOME': '/home/cltbld', 22:50:14 INFO - 'LANG': 'en_US.UTF-8', 22:50:14 INFO - 'LANGUAGE': 'en_US:en', 22:50:14 INFO - 'LOGNAME': 'cltbld', 22:50:14 INFO - 'MAIL': '/var/mail/cltbld', 22:50:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:50:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:14 INFO - 'MOZ_NO_REMOTE': '1', 22:50:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:50:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:50:14 INFO - 'NO_EM_RESTART': '1', 22:50:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:50:14 INFO - 'PWD': '/builds/slave/test', 22:50:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:50:14 INFO - 'SHELL': '/bin/bash', 22:50:14 INFO - 'SHLVL': '1', 22:50:14 INFO - 'TERM': 'linux', 22:50:14 INFO - 'TMOUT': '86400', 22:50:14 INFO - 'USER': 'cltbld', 22:50:14 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390', 22:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:14 INFO - '_': '/tools/buildbot/bin/python'} 22:50:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:50:14 INFO - mozversion application_buildid: 20161020193007 22:50:14 INFO - mozversion application_changeset: 1171f3ae792b91d7ca49ef0907b251e381f1df56 22:50:14 INFO - mozversion application_display_name: Nightly 22:50:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:50:14 INFO - mozversion application_name: Firefox 22:50:14 INFO - mozversion application_remotingname: firefox 22:50:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:50:14 INFO - mozversion application_vendor: Mozilla 22:50:14 INFO - mozversion application_version: 52.0a1 22:50:14 INFO - mozversion platform_buildid: 20161020193007 22:50:14 INFO - mozversion platform_changeset: 1171f3ae792b91d7ca49ef0907b251e381f1df56 22:50:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:50:14 INFO - mozversion platform_version: 52.0a1 22:50:14 INFO - using testdate: 1477029014 22:50:14 INFO - actual date: 1477029014 22:50:14 INFO - starting webserver on 'localhost:49373' 22:50:14 INFO - SUITE-START | Running 2 tests 22:50:14 INFO - TEST-START | dromaeo_css 22:50:14 INFO - operating with platform_type : linux_ 22:50:14 INFO - Initialising browser for dromaeo_css test... 22:50:14 INFO - TEST-INFO | started process 7330 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIgqiJQ/profile http://localhost:49373/getInfo.html) 22:50:19 INFO - PROCESS | 7330 | __metrics Screen width/height:1600/1200 22:50:19 INFO - PROCESS | 7330 | colorDepth:24 22:50:19 INFO - PROCESS | 7330 | Browser inner width/height: 1024/697 22:50:19 INFO - PROCESS | 7330 | __metrics 22:50:19 INFO - PROCESS | 7330 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:50:19 INFO - PROCESS | 7330 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:50:20 INFO - PROCESS | 7330 | console.error: PushService: 22:50:20 INFO - PROCESS | 7330 | stateChangeProcessEnqueue: Error transitioning state 22:50:20 INFO - PROCESS | 7330 | UnknownError 22:50:21 INFO - TEST-INFO | 7330: exit 0 22:50:21 INFO - Browser initialized. 22:50:21 INFO - Running cycle 1/1 for dromaeo_css test... 22:50:21 INFO - TEST-INFO | started process 7412 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIgqiJQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:50:33 INFO - PROCESS | 7412 | RSS: Main: 171757568 22:50:33 INFO - PROCESS | 7412 | 22:51:24 INFO - PROCESS | 7412 | 1477029084458 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] 22:53:34 INFO - PROCESS | 7412 | Cycle 1(1): loaded http://localhost:49373/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49373/tests/dromaeo/cssquery-ext.html) 22:53:37 INFO - PROCESS | 7412 | RSS: Main: 423661568 22:53:37 INFO - PROCESS | 7412 | 22:56:39 INFO - PROCESS | 7412 | Cycle 1(1): loaded http://localhost:49373/tests/dromaeo/cssquery-ext.html (next: http://localhost:49373/tests/dromaeo/cssquery-jquery.html) 22:56:40 INFO - PROCESS | 7412 | RSS: Main: 289275904 22:56:40 INFO - PROCESS | 7412 | 22:59:42 INFO - PROCESS | 7412 | Cycle 1(1): loaded http://localhost:49373/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49373/tests/dromaeo/cssquery-mootools.html) 22:59:43 INFO - PROCESS | 7412 | RSS: Main: 246358016 22:59:43 INFO - PROCESS | 7412 | 23:02:45 INFO - PROCESS | 7412 | Cycle 1(1): loaded http://localhost:49373/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49373/tests/dromaeo/cssquery-prototype.html) 23:02:45 INFO - PROCESS | 7412 | RSS: Main: 278872064 23:02:45 INFO - PROCESS | 7412 | 23:05:48 INFO - PROCESS | 7412 | Cycle 1(1): loaded http://localhost:49373/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49373/tests/dromaeo/cssquery-yui.html) 23:05:48 INFO - PROCESS | 7412 | RSS: Main: 219697152 23:05:48 INFO - PROCESS | 7412 | 23:08:51 INFO - PROCESS | 7412 | Cycle 1(1): loaded http://localhost:49373/tests/dromaeo/cssquery-yui.html (next: http://localhost:49373/tests/dromaeo/cssquery-dojo.html) 23:08:52 INFO - PROCESS | 7412 | RSS: Main: 312950784 23:08:52 INFO - PROCESS | 7412 | 23:08:52 INFO - PROCESS | 7412 | __start_tp_report 23:08:52 INFO - PROCESS | 7412 | _x_x_mozilla_page_load 23:08:52 INFO - PROCESS | 7412 | _x_x_mozilla_page_load_details 23:08:52 INFO - PROCESS | 7412 | |i|pagename|runs| 23:08:52 INFO - PROCESS | 7412 | |0;dojo.html;2928.4875146849304;2966.169472547687;2968.0809168448795;2972.3460838615524;2987.880484780609;5022.472640372763;5124.128898087325;5125.333706618139;5276.445973172819;5296.179092240699;5115.872103197422;5212.66117702349;5271.525562699357;5296.867578310545;5381.0852155133625;4667.043256132485;4718.811247550094;4728.125296820082;4814.54261845125;4833.3958255218095;4689.718616882998;4778.976105119469;4800.279958006309;4852.4662287148385;4875.561199492045;4822.9758851205515;4854.951450485503;4867;4872.3909511311085;4923.458419573844;4630.398048253739;4656.41794775653;4673.345731597579;4680.040591678698;4857.73282469464;4690.788914498856;4801.831935882262;4821.059893320804;4822;4822.180229361017;5211.661242019257;5243.947560524384;5251.658642188246;5263.499967503081;5275.340582427197;5571.888562228733;5573.916391254134;5577.442255774431;5577.776888924438;5632.324121105453;5308.177232528964;5356.866078348073;5486.835394938118;5522.447755224445;5535.529479994165;5211.062008838446;5217.034848553029;5218.556422704037;5222.817201397971;5272.367315922113;5696.23100881384;5701.486866182064;5703.62926409782;5704.11586204139;5768.423157684198;5176.430592634807;5267.446918073624;5471.042567550663;5476;5521.171824226318;5609.046462101453;5648.717564121777;5651.124075768263;5696.060150075191;5725.799597014085;5623.831285061455;5628.71856407178;5631.943680563224;5632.718364081779;5635.802746903839;5358.812441564526;5414.783408663609;5415.1335786274;5620.1569764534825;5673.744681489343;4244.702870799076;4251.149770046003;4297.033167537342;4336.479622445327;4352.608265256142;3826.1582451860545;3829.7319187657154;3830.961690383116;3869.709771767072;3872.5740168581433;5272.367315922037;5314.654547454403;5327.334083239595;5331.573474122061;5336.1195402758885;5330.093884039723;5401.7299135043095;5544.362398324163;5608.887822243532;5619.100943848965;5354.330708661418;5360.839174824761;5362.678239305654;5364.7317634118135;5378.596605254622;4885.731284779371;4894.290327902434;4896.828610998598;4897.094037602984;4960.553550180501;5631.549476041907;5696.971515142398;5701.885962280814;5742.59801813869;5824.068149096124;5610.410906854885;5614.69119198448;5620.072688006597;5661.575381846295;5678.886422271614;5779.595428319977;5782.161586570008;5783.392743761844;5787.450192231731;5788.131780232999;5240.397354304304;5335.919961200508;5379.946200538101;5504.91742623869;5508.366537848199;5511.779528818963;5555.555555555465;5557.555395568425;5562.471565201299;5565.081761509306;5421.701806400686;5434.184872269033;5434.456554344692;5436.700981445901;5436.782528698966;5411.1883217516115;5420.403755586961;5422.783088676409;5424.538914192338;5425.348958125051;5309.33633295838;5357.8392648220615;5359.544438722753;5362;5393.298871146882;5380.381256155592;5399.703016333982;5403.324584426947;5409.161579955114;5409.513143817076;5144.6398752087;5245.606579506476;5287.127623942007;5298.576113910801;5319.946800531945 23:08:52 INFO - PROCESS | 7412 | |1;ext.html;595.422440232974;615.7260019291416;625.4214851262581;627.1126356205968;636.3986033198629;31608.841955790216;45455.54544454555;46914;47046.529534704685;47055;44873.94201782758;45294;45306.54693453065;45347;45389.31916021254;8880.067592902766;9043.050479699636;9045.502497362642;9053.411528250675;9055.275577953747;7955.323797477221;8156.143604921487;10306.536205870716;10525.473726313692;10540.262181647287;10758.193135514828;10846.457677116152;10850.72873178169;10851;10851.348919064882;10707.036366726992;10796.190285728602;10847.403392813392;10854.837177442345;10856.837147442795;10578.471076446147;10655;10664.200184986157;10664.840027399596;10668.573257069707;41792.79103604493;41988;42050;42090.368644470356;42113.36829947553;3286.9835650821833;3464.5149679044953;3552.8401221945073;3613.7470377073614;3827.0623697194087;30983.690163098305;31073.22316942072;31808.363832723215;31852.681473185203;32000;3872.8838134856;3938.5667576566557;3996.440498330236;4094.7747873866924;4120.608542188487;230104;230414;231244.84377578172;231840;232128;57986.420135798944;58397;58448.70775646094;58476.41523584795;58484.41515584875;61179.6941015301;61559;61616.919154042116;61678.69160654168;61678.691606542576;15890.205489725698;16037.198140092949;16053.839461605468;16117.677646447006;16125.758113628304;11094.889051109547;11401.657950261506;11473.311601303949;11507.597234096766;11522.251053681484;16019;16123.516294511184;16157.919210404109;16828.326866925185;17485.300587976337;5785.247917770663;5813.186153938452;5948.583599148104;5996.2504686914135;6133.1413602095745;844.8521508735946;904.556767184075;936.7236665183788;987.4470296633908;1054.926155169146;28698.282542936595;29783.553246701318;29838.701612983594;30514.237144071576;30652;999.7850462150673;1045.900639439252;1096.1066730614523;1104.1332553945115;1130.6947124276398;15076.54770356869;15768.76346854798;15861.762073568905;15891.602709932113;16247.350105995863;468293;470921;471151;472189;472231;48562.27156592654;49359;55125.72437137869;56307.71846140825;56425;1287.2855565161237;1296.2870421268453;1302.3097758188176;1305.301663609983;1315.0400207848134;29594.260143496584;31158.22104447407;31232;31242.843785780926;31869.20326991844;51397.74301128471;52155.217671735714;52264.47735522596;52267.73866130645;52284.738576306874;416681;417647;420734;426425;427288;41220.1755964885;41399.7930010348;41774;42205.24716045541;42298.7885060585;46802;47322.52677473319;47444.28833567568;48366.51633483761;48480.51519484901;39109.41335879907;39971.40042899301;40587.39118913278;41347.58652413437;42807.3578896323;38723.41914871336;39267.41098883462;39842.80078599588;40820;41692.374614380205;37192.62807372;38064;38588.61411385963;38643.420348695356;38867.6113238864;32084.839575801972;34620;34979.30041399107;35080.82459587788;35197.64802351944;25519.744802551737;25911.481770364866;25931.22206333813;25953.22140335793;26366.209013729618 23:08:52 INFO - PROCESS | 7412 | |2;jquery.html;341;342.42814499785356;356.94288913773795;360.29562205887487;379.83097521602883;14200.928995355021;18082.276708931644;18091.185896634666;18541.16564754586;19786.30747923823;17924.462266132003;18173.636527269446;18504.53738656531;18592.163352649128;19067.237310507564;4875.878103047426;5114.667546609477;5116.027954688598;5116.897662046776;5124.103281925667;3727.105494681284;3857.864974725885;5025.623078269126;5095.388553373582;5096.082705113078;5338.733063346836;5590.664560126385;5623.044082505984;5674.09214525676;5675.9432405675825;5653.434656534334;5663.0655941769555;5776.335721392031;6227.532935029891;6274.309825919146;5495.395506494282;5502.294288770494;5503.422140675251;5504.834854954358;5510.559155267569;12002.219855709438;12015.21901076436;12158.148929574932;12322.691932701664;16687.499375018768;2154.4721543221854;2217.977820221793;2318.6406107053267;2447.5227330670527;2769.6399468069226;8933.151350621745;9258;9809.068138526829;9813.018698130201;9846.753831154207;1849.34348306352;1875.5967466994525;1881.9435416937513;1888.4806678163477;1895.7156426535992;81803;82155;83044;83449.58275208646;85606;9866.112049915542;9911.454869982075;10215.387076775418;10222.335548189343;10349.63776267827;13848.930755346159;13895.305234738222;13924;13979.930100349637;14017.579472615838;7339.88990165148;7506.399488040944;7626.923730762733;7684.692612295557;7831.451798374173;7075.893861592081;7259.673314700851;7366;7432.40203356281;7639;4124.731892426983;4208.305629571087;4260.360945858146;4377.496587892433;4404.66964977628;1707.6926153292527;1765.3909401256547;1807.629435965624;1839.586093129062;1849.8705090643796;805.6253841963398;830.8213734047088;832.3632421197789;990.8464188050864;1011.4386515483977;17025.914870425568;18645.533861653566;18716;18777.371168036487;19098.90450547766;870.1994165367877;872.4024043530202;912.0879120879121;930.093159169804;938.5025936253796;9841.065098815601;10101.19190464761;10276.486175691185;10288.537015834305;10382.273240873066;429060;430355;488660;528370;529177;49475.752621236665;83952.16047839566;84941;85660;89866;905.5608030105394;908.3868388837641;935.742670765545;946.9621215151454;950.9239260859115;15664.267293197434;16026.679466410373;16158.757618635966;16881.831181688518;17246.91376543109;36580.26839463249;36604.26791464209;38021;38303.61696383112;39343.80328098341;48966.75516622394;49561.75219123881;50594;51327.230091549405;53559.732201338746;7613.885791713239;7723.189065148079;7765.262300081483;7933.642986065756;7993.400494963017;8339.416240863082;9655.951720241354;12191.268523888595;12888.742225155633;12967.870321296667;10520.526576303932;10809.432632268434;10867.0762985144;10928.890711092787;11119.091797849063;11110.16673749456;11373.829392559284;11467.483963221508;11569.88430115688;11887.108466864847;11195.44022798873;11403.31580105163;11447.141464390037;11501.194916355775;12021.519139234333;7880.645370958436;8060.959695201486;8113.269805717514;8275.62759675828;8360.958195208985;10294.845577316197;10614.734631633963;10745.785084298113;10943.233973621771;11406.372649504357 23:08:52 INFO - PROCESS | 7412 | |3;mootools.html;1333.6265845563246;1350.223621417685;1448.8188976377953;1452.8329242137154;1697.0835748695704;7559.357454616357;8383.077861435246;8603.526806025666;8631.827363452727;8914.687985920495;8984.91015089849;9069.72790816275;9070.77323066922;9073.274138068955;9077;2243.999999999996;2260.8530445520987;2265.014718597407;2267.240474441064;2268.410213344534;2203.272919936417;2230.197129033547;2252.6958860553777;2269.1150451323997;2269.7730226977337;2231.2748356784027;2233.1737257214854;2235.10595761695;2238.731352237734;2272.556851413975;2139.7432308123125;2144.088762276042;2165.361218440548;2177.314146043999;2181.7163768710125;2175.8150557202657;2198.0328655391577;2198.241606645721;2201.482651576878;2204.272590045281;8962.283017358595;9034.32242581809;9036.683716069905;9037.819243615091;9040.141186587329;4974.577160941324;5152.562032227265;5152.768125434327;5179.818706345298;5190.091733946544;3135.925933160139;3244.480883058723;3274.2305558193807;3296.950545741816;3303.6861498157637;937.2642475656645;948.2745699539857;959.3188835926501;967.0522887570221;979.7893452907659;11965.46155423008;12043.470871117075;12048.216865903689;12049;12060.638180854588;4260.55264197261;4532.138893610204;4632.25883858581;4636.466806317249;4657.930131048037;9750.122488976027;9814.460204688668;9832;9838.704838854846;9845.113939745313;5192.402873669501;5194.662346947436;5201.843944681666;5208.166693329125;5208.8437346879655;4090.550039495653;4124.154548317588;4601.585857272795;4724.551167639069;4894.461609222983;3531.205478767257;3594.892153235407;3629.8366573504254;3679.4480827875495;3725.925481490355;1058.444316733721;1067.7330667333167;1070.973225669349;1080.4975686305906;1084.7017070305728;877.7586163805005;890.7283278600089;907.4872696926216;912.466207268742;920.4293338130402;5610.382857885629;5729.742161602655;5739.655620662774;5779.508741756914;5962.940370596325;405.67343288652916;407.8225971702319;415.621784176398;415.74639469923324;424.02051261585837;3720.3489389356755;3767.773933563995;3770.057485628593;3775.093977445448;3815.236952609489;10839.187060970458;11122.777544449065;11189.776204475866;11192.160587955936;11248.156388270912;11111.166662500345;11147.94426027881;11155.888441115485;11172.10623150146;11181.105511559219;7837.255460731221;8180.386471014816;8310.958445207736;8341;8405.495670259805;6014.518838492998;6142.600730952474;6178.474829639351;6208.906866396917;6250.749970001331;10270.383776973405;10388.792224155626;10434.060934515626;10447.791044179226;10574.312669676447;9867;10249.180065594586;10265.281430299807;10533.104686101768;10617.416042117758;6991.405730512964;7206.279372062962;7208.675609597476;7582.582957937146;7753.92246077532;7671.309582137635;7859.882101768364;8457.365697572584;8533.615987280711;8690.130986901511;7742.303192712683;7770.92229077702;7932.325752311118;8017.63920623585;8062.314703250289;7367.742129025459;7454.4781865268915;7463;7566.205548417337;7596.126445458843;6970.686319115754;7137.1435427749;7146.178189508065;7151.356377926011;7154.499185056996;4656.41794775653;4696.319033740157;4723.929141062818;4912.533309335608;4959.82640607577;4824.421069471686;4848.0788650156355;4852.393450818648;5025;5031.345925029723 23:08:52 INFO - PROCESS | 7412 | |4;prototype.html;287.94529039482495;303.60986132819323;306.9616297962755;307.1446022826429;308.18792481810425;5093.108705976458;5175.637705360627;5222.843314700555;5255.264263003182;5266.447023062581;5094.1594636884865;5154.92267615986;5182.663126896749;5193.766280517376;5199.766010529525;4037.576054514278;4041.4948131483493;4059.8579049733266;4064.7967601619803;4065.451164092854;3796.6013568575318;3814.569536423841;4056.452378928851;4064.248114098886;4067;3994.4208089826957;4007.6994225433064;4014.197160567898;4018.2164477926817;4025.778582177979;3957.6438120569287;3965.4250133730734;3981.6416522512823;3984.641382275609;4022.45696830927;3514.859405623772;3520.507129001942;3529.5588051493564;3533.2050288685095;3540;4929.742915556546;5013.699178049329;5040.974795126038;5059.241113832918;5060.266261392115;4579.977100114512;4596.161535385839;4596.471405788344;4598.241290187115;4605.125026245003;5394.460553944614;5399.595030372738;5410.8917821643345;5419.783208671648;5427.83716488506;3841.3661745811905;3900.102976315435;3905.266313580505;3926.7840268785208;3945.861894833667;5666.914996275059;5673.971630141864;5683.744231509592;5687.630304030225;5700.201971723962;4030.052937559671;4031.657309128698;4032.919341613151;4033.233685599727;4059.208454351432;4009.7393669411395;4071.6742660587674;4085.795710214537;4092.9795351023054;4107.732997355222;4581.679282450264;4587.61005314552;4611.308303754397;4615.699979501322;4619.099275641218;5417.891642167135;5447.319085114361;5453.3455985281225;5462.126059830408;5466.64466809664;1273.7134144817342;1307.5423601739315;1318.8944884409225;1390.3951780975308;1403.5298175111247;846.8856704344958;857.3698331726176;880.1330689271063;881.4314766975265;882.5543100734088;4744.0037592105355;4754.857354279377;4759.857204283877;4777.426708794897;4786.688865223749;4853.296272040534;4939.333190019373;4957.264957264929;4989.975050124799;4999.650024498323;4696.553827386393;4698.763716635375;4728.40894888139;4731.33761273422;4768.690035147704;2539.3143851160453;2633.7761290290155;2651.986740066326;2663.8268512546624;2664.9600255996174;5042;5110.2590124431745;5113.897722045538;5127.846164615067;5137.229415587692;5005.874853128628;5007.2224360352275;5011.298418221452;5017.84946451607;5333.57331413486;5793.768249270066;5812.82561523155;5819.243498345273;5819.679917604488;5830.416958304136;5650.067738823048;5661.433856614306;5662.716864156693;5664.348599911063;5681.8863622726485;5473.671579705071;5581.944180558143;5602.2717046783655;5607.467290607386;5611.410801865745;5810.73851676684;5812.82561523155;5815.79644712433;5825.737841797045;5835.44563266489;3722.8696995605023;3948.44721738951;3958.584348643351;3972.8212230450276;3985.3025720499377;5169.121249387538;5384.838454846361;5452.182172674131;5626.24045753818;5673.262475878275;5480.342358916796;5496;5506.752196151263;5520.254765606592;5520.806771762969;5401.594880384066;5433.478625984572;5494.890102198014;5520.199571062254;5547.667139971614;5473.698946557818;5477.698726569917;5477.945220547744;5483.259759932358;5494.390164671749;5534.976029434568;5535.8892822142525;5548.223248745259;5569.6936668482;5576.693281869536;5289.550388217045;5320.2177270614775;5366.812161574326;5369.248305237348;5399.973000134974 23:08:52 INFO - PROCESS | 7412 | |5;yui.html;653.9738410463578;673.4141297071549;717.4224749076992;720.4740539406233;760.6653072648031;14342.06776559523;15599.688006239869;15612.141332226724;15657.451989180381;16412.67174656506;14510.27448627567;15052.54842354731;15113.622159446018;15121.924390378033;15140.772888406682;662.1656712542183;797.0793733238105;818.6275244763618;818.6848063495538;821.5768879027306;672.0557616548757;684.849333146707;685.5612408058821;685.866256080062;772.4399810137661;853.1724227499316;855.1064137975831;862.5816479007676;864.2394692670441;865.0657290126679;852.4288726553224;852.6078004118114;852.7058164933151;852.722865068852;853.1979938857485;509.0963539716995;514.3236643813411;608.3733754233147;627.8430392401899;631.192074145095;14612.342444590018;15432.768508472382;15470.149141797197;15476.380944762195;15485.767713484307;13438.596842094752;14149.434022639081;14175.149491030572;14195.78706319406;14260.500882469063;12514.436850341757;12991.935040324832;13045.152065115737;13103.86896131036;13263.204207747565;4454.710443821141;4519.322101684741;4530.229860923618;4532.5240849710635;4538.682292239545;82582;82666.58666706688;83617.58191209006;83703.16296837015;86052.98814541461;10417.791644167075;11046.558137674563;11084.501197446134;11109.222354435113;11506.88493115075;20783.480412989495;21084.47288817792;21099.8945005274;21199.15203391847;21281.89359053195;7937.32532734724;8100.635471403801;8262.958685206655;8394.328453723687;8397.958010210032;4379.627731642846;4509.233430316854;4541.710906258354;4592.6555508337005;4602.976985115053;3248.1067706380936;3304.3886880927107;3327.301266734013;3333.100062982981;3339.382214290364;593.989346063578;619.5198720991177;620.7237779188308;629.9905501417483;643.0611307491115;603.6649659439054;620.1751670278519;624.2914292278297;636.700750647195;644.6454450052453;8600.5699715014;8626.91373086261;8688.826223475495;8826.161514656098;8861.689840855539;524.7114087251996;607.8358843112424;627.4415769964735;641.8202903187115;644.6848429204464;3800.315943130263;4071.307877660805;4197.580241975839;4205.158968206371;4310.590493903074;117670.41164794292;119862.400687996;121115;121500.39249803871;128268.35865820611;68225.65887170532;100000;103869;104028;108771.45614271877;91063;92948.53525732328;93219.53390233142;93844.49244060459;94114;7762.292295694938;7969.177330165771;7991;8139.348852091937;8290.668373265244;54027.189592155366;54853.72573137109;55134;56347;57383.42616573948;75583.62208188923;81121;81953.59023204846;82416.12478557523;84204.57897710717;9727.124558789743;10034;10364.134455798028;10446.216533759847;10491.632792852213;11350.489227984926;11355.261907975955;11508.94245528767;11565.074794016291;11675.360768053008;10873.782524349626;11069.5572177112;11162.776744465227;11238.55045798159;11693.12301577368;10242.795144097225;10771.946140269249;13275.468981240641;13914.304284785923;14596.489122880648;13230.96455581057;13416.932915335361;13486.93256533711;13688.31558422055;13887.285825157853;11281.323120612462;11546.826797597874;11707;11891.524339026688;11925.463354148911;11034.448277586249;11988.520459181535;11994.700132496757;12250.326232057323;12374.81437778452 23:08:52 INFO - PROCESS | 7412 | __end_tp_report 23:08:52 INFO - PROCESS | 7412 | __start_cc_report 23:08:52 INFO - PROCESS | 7412 | _x_x_mozilla_cycle_collect,2647 23:08:52 INFO - PROCESS | 7412 | __end_cc_report 23:08:52 INFO - PROCESS | 7412 | __startTimestamp1477030132117__endTimestamp 23:08:52 INFO - PROCESS | 7412 | 23:08:52 INFO - PROCESS | 7412 | ------- Summary: start ------- 23:08:52 INFO - PROCESS | 7412 | Number of tests: 6 23:08:52 INFO - PROCESS | 7412 | 23:08:52 INFO - PROCESS | 7412 | [#0] dojo.html Cycles:165 Average:5178.25 Median:5356.87 stddev:579.00 (10.8%) stddev-sans-first:553.22 23:08:52 INFO - PROCESS | 7412 | Values: 2928.5 2966.2 2968.1 2972.3 2987.9 5022.5 5124.1 5125.3 5276.4 5296.2 5115.9 5212.7 5271.5 5296.9 5381.1 4667.0 4718.8 4728.1 4814.5 4833.4 4689.7 4779.0 4800.3 4852.5 4875.6 4823.0 4855.0 4867.0 4872.4 4923.5 4630.4 4656.4 4673.3 4680.0 4857.7 4690.8 4801.8 4821.1 4822.0 4822.2 5211.7 5243.9 5251.7 5263.5 5275.3 5571.9 5573.9 5577.4 5577.8 5632.3 5308.2 5356.9 5486.8 5522.4 5535.5 5211.1 5217.0 5218.6 5222.8 5272.4 5696.2 5701.5 5703.6 5704.1 5768.4 5176.4 5267.4 5471.0 5476.0 5521.2 5609.0 5648.7 5651.1 5696.1 5725.8 5623.8 5628.7 5631.9 5632.7 5635.8 5358.8 5414.8 5415.1 5620.2 5673.7 4244.7 4251.1 4297.0 4336.5 4352.6 3826.2 3829.7 3831.0 3869.7 3872.6 5272.4 5314.7 5327.3 5331.6 5336.1 5330.1 5401.7 5544.4 5608.9 5619.1 5354.3 5360.8 5362.7 5364.7 5378.6 4885.7 4894.3 4896.8 4897.1 4960.6 5631.5 5697.0 5701.9 5742.6 5824.1 5610.4 5614.7 5620.1 5661.6 5678.9 5779.6 5782.2 5783.4 5787.5 5788.1 5240.4 5335.9 5379.9 5504.9 5508.4 5511.8 5555.6 5557.6 5562.5 5565.1 5421.7 5434.2 5434.5 5436.7 5436.8 5411.2 5420.4 5422.8 5424.5 5425.3 5309.3 5357.8 5359.5 5362.0 5393.3 5380.4 5399.7 5403.3 5409.2 5409.5 5144.6 5245.6 5287.1 5298.6 5319.9 23:08:52 INFO - PROCESS | 7412 | 23:08:52 INFO - PROCESS | 7412 | [#1] ext.html Cycles:180 Average:54699.50 Median:38988.51 stddev:102873.53 (263.9%) stddev-sans-first:103081.91 23:08:52 INFO - PROCESS | 7412 | Values: 595.4 615.7 625.4 627.1 636.4 31608.8 45455.5 46914.0 47046.5 47055.0 44873.9 45294.0 45306.5 45347.0 45389.3 8880.1 9043.1 9045.5 9053.4 9055.3 7955.3 8156.1 10306.5 10525.5 10540.3 10758.2 10846.5 10850.7 10851.0 10851.3 10707.0 10796.2 10847.4 10854.8 10856.8 10578.5 10655.0 10664.2 10664.8 10668.6 41792.8 41988.0 42050.0 42090.4 42113.4 3287.0 3464.5 3552.8 3613.7 3827.1 30983.7 31073.2 31808.4 31852.7 32000.0 3872.9 3938.6 3996.4 4094.8 4120.6 230104.0 230414.0 231244.8 231840.0 232128.0 57986.4 58397.0 58448.7 58476.4 58484.4 61179.7 61559.0 61616.9 61678.7 61678.7 15890.2 16037.2 16053.8 16117.7 16125.8 11094.9 11401.7 11473.3 11507.6 11522.3 16019.0 16123.5 16157.9 16828.3 17485.3 5785.2 5813.2 5948.6 5996.3 6133.1 844.9 904.6 936.7 987.4 1054.9 28698.3 29783.6 29838.7 30514.2 30652.0 999.8 1045.9 1096.1 1104.1 1130.7 15076.5 15768.8 15861.8 15891.6 16247.4 468293.0 470921.0 471151.0 472189.0 472231.0 48562.3 49359.0 55125.7 56307.7 56425.0 1287.3 1296.3 1302.3 1305.3 1315.0 29594.3 31158.2 31232.0 31242.8 31869.2 51397.7 52155.2 52264.5 52267.7 52284.7 416681.0 417647.0 420734.0 426425.0 427288.0 41220.2 41399.8 41774.0 42205.2 42298.8 46802.0 47322.5 47444.3 48366.5 48480.5 39109.4 39971.4 40587.4 41347.6 42807.4 38723.4 39267.4 39842.8 40820.0 41692.4 37192.6 38064.0 38588.6 38643.4 38867.6 32084.8 34620.0 34979.3 35080.8 35197.6 25519.7 25911.5 25931.2 25953.2 26366.2 23:08:52 INFO - PROCESS | 7412 | 23:08:52 INFO - PROCESS | 7412 | [#2] jquery.html Cycles:180 Average:27397.74 Median:216660.18 stddev:79589.48 (36.7%) stddev-sans-first:79786.82 23:08:52 INFO - PROCESS | 7412 | Values: 341.0 342.4 356.9 360.3 379.8 14200.9 18082.3 18091.2 18541.2 19786.3 17924.5 18173.6 18504.5 18592.2 19067.2 4875.9 5114.7 5116.0 5116.9 5124.1 3727.1 3857.9 5025.6 5095.4 5096.1 5338.7 5590.7 5623.0 5674.1 5675.9 5653.4 5663.1 5776.3 6227.5 6274.3 5495.4 5502.3 5503.4 5504.8 5510.6 12002.2 12015.2 12158.1 12322.7 16687.5 2154.5 2218.0 2318.6 2447.5 2769.6 8933.2 9258.0 9809.1 9813.0 9846.8 1849.3 1875.6 1881.9 1888.5 1895.7 81803.0 82155.0 83044.0 83449.6 85606.0 9866.1 9911.5 10215.4 10222.3 10349.6 13848.9 13895.3 13924.0 13979.9 14017.6 7339.9 7506.4 7626.9 7684.7 7831.5 7075.9 7259.7 7366.0 7432.4 7639.0 4124.7 4208.3 4260.4 4377.5 4404.7 1707.7 1765.4 1807.6 1839.6 1849.9 805.6 830.8 832.4 990.8 1011.4 17025.9 18645.5 18716.0 18777.4 19098.9 870.2 872.4 912.1 930.1 938.5 9841.1 10101.2 10276.5 10288.5 10382.3 429060.0 430355.0 488660.0 528370.0 529177.0 49475.8 83952.2 84941.0 85660.0 89866.0 905.6 908.4 935.7 947.0 950.9 15664.3 16026.7 16158.8 16881.8 17246.9 36580.3 36604.3 38021.0 38303.6 39343.8 48966.8 49561.8 50594.0 51327.2 53559.7 7613.9 7723.2 7765.3 7933.6 7993.4 8339.4 9656.0 12191.3 12888.7 12967.9 10520.5 10809.4 10867.1 10928.9 11119.1 11110.2 11373.8 11467.5 11569.9 11887.1 11195.4 11403.3 11447.1 11501.2 12021.5 7880.6 8061.0 8113.3 8275.6 8361.0 10294.8 10614.7 10745.8 10943.2 11406.4 23:08:52 INFO - PROCESS | 7412 | 23:08:52 INFO - PROCESS | 7412 | [#3] mootools.html Cycles:180 Average:5700.35 Median:4774.49 stddev:3376.68 (70.7%) stddev-sans-first:3370.21 23:08:52 INFO - PROCESS | 7412 | Values: 1333.6 1350.2 1448.8 1452.8 1697.1 7559.4 8383.1 8603.5 8631.8 8914.7 8984.9 9069.7 9070.8 9073.3 9077.0 2244.0 2260.9 2265.0 2267.2 2268.4 2203.3 2230.2 2252.7 2269.1 2269.8 2231.3 2233.2 2235.1 2238.7 2272.6 2139.7 2144.1 2165.4 2177.3 2181.7 2175.8 2198.0 2198.2 2201.5 2204.3 8962.3 9034.3 9036.7 9037.8 9040.1 4974.6 5152.6 5152.8 5179.8 5190.1 3135.9 3244.5 3274.2 3297.0 3303.7 937.3 948.3 959.3 967.1 979.8 11965.5 12043.5 12048.2 12049.0 12060.6 4260.6 4532.1 4632.3 4636.5 4657.9 9750.1 9814.5 9832.0 9838.7 9845.1 5192.4 5194.7 5201.8 5208.2 5208.8 4090.6 4124.2 4601.6 4724.6 4894.5 3531.2 3594.9 3629.8 3679.4 3725.9 1058.4 1067.7 1071.0 1080.5 1084.7 877.8 890.7 907.5 912.5 920.4 5610.4 5729.7 5739.7 5779.5 5962.9 405.7 407.8 415.6 415.7 424.0 3720.3 3767.8 3770.1 3775.1 3815.2 10839.2 11122.8 11189.8 11192.2 11248.2 11111.2 11147.9 11155.9 11172.1 11181.1 7837.3 8180.4 8311.0 8341.0 8405.5 6014.5 6142.6 6178.5 6208.9 6250.7 10270.4 10388.8 10434.1 10447.8 10574.3 9867.0 10249.2 10265.3 10533.1 10617.4 6991.4 7206.3 7208.7 7582.6 7753.9 7671.3 7859.9 8457.4 8533.6 8690.1 7742.3 7770.9 7932.3 8017.6 8062.3 7367.7 7454.5 7463.0 7566.2 7596.1 6970.7 7137.1 7146.2 7151.4 7154.5 4656.4 4696.3 4723.9 4912.5 4959.8 4824.4 4848.1 4852.4 5025.0 5031.3 23:08:52 INFO - PROCESS | 7412 | 23:08:52 INFO - PROCESS | 7412 | [#4] prototype.html Cycles:180 Average:4501.72 Median:5029.41 stddev:1341.91 (26.7%) stddev-sans-first:1307.87 23:08:52 INFO - PROCESS | 7412 | Values: 287.9 303.6 307.0 307.1 308.2 5093.1 5175.6 5222.8 5255.3 5266.4 5094.2 5154.9 5182.7 5193.8 5199.8 4037.6 4041.5 4059.9 4064.8 4065.5 3796.6 3814.6 4056.5 4064.2 4067.0 3994.4 4007.7 4014.2 4018.2 4025.8 3957.6 3965.4 3981.6 3984.6 4022.5 3514.9 3520.5 3529.6 3533.2 3540.0 4929.7 5013.7 5041.0 5059.2 5060.3 4580.0 4596.2 4596.5 4598.2 4605.1 5394.5 5399.6 5410.9 5419.8 5427.8 3841.4 3900.1 3905.3 3926.8 3945.9 5666.9 5674.0 5683.7 5687.6 5700.2 4030.1 4031.7 4032.9 4033.2 4059.2 4009.7 4071.7 4085.8 4093.0 4107.7 4581.7 4587.6 4611.3 4615.7 4619.1 5417.9 5447.3 5453.3 5462.1 5466.6 1273.7 1307.5 1318.9 1390.4 1403.5 846.9 857.4 880.1 881.4 882.6 4744.0 4754.9 4759.9 4777.4 4786.7 4853.3 4939.3 4957.3 4990.0 4999.7 4696.6 4698.8 4728.4 4731.3 4768.7 2539.3 2633.8 2652.0 2663.8 2665.0 5042.0 5110.3 5113.9 5127.8 5137.2 5005.9 5007.2 5011.3 5017.8 5333.6 5793.8 5812.8 5819.2 5819.7 5830.4 5650.1 5661.4 5662.7 5664.3 5681.9 5473.7 5581.9 5602.3 5607.5 5611.4 5810.7 5812.8 5815.8 5825.7 5835.4 3722.9 3948.4 3958.6 3972.8 3985.3 5169.1 5384.8 5452.2 5626.2 5673.3 5480.3 5496.0 5506.8 5520.3 5520.8 5401.6 5433.5 5494.9 5520.2 5547.7 5473.7 5477.7 5477.9 5483.3 5494.4 5535.0 5535.9 5548.2 5569.7 5576.7 5289.6 5320.2 5366.8 5369.2 5400.0 23:08:52 INFO - PROCESS | 7412 | 23:08:52 INFO - PROCESS | 7412 | [#5] yui.html Cycles:180 Average:21315.96 Median:4514.28 stddev:31849.47 (705.5%) stddev-sans-first:31901.03 23:08:52 INFO - PROCESS | 7412 | Values: 654.0 673.4 717.4 720.5 760.7 14342.1 15599.7 15612.1 15657.5 16412.7 14510.3 15052.5 15113.6 15121.9 15140.8 662.2 797.1 818.6 818.7 821.6 672.1 684.8 685.6 685.9 772.4 853.2 855.1 862.6 864.2 865.1 852.4 852.6 852.7 852.7 853.2 509.1 514.3 608.4 627.8 631.2 14612.3 15432.8 15470.1 15476.4 15485.8 13438.6 14149.4 14175.1 14195.8 14260.5 12514.4 12991.9 13045.2 13103.9 13263.2 4454.7 4519.3 4530.2 4532.5 4538.7 82582.0 82666.6 83617.6 83703.2 86053.0 10417.8 11046.6 11084.5 11109.2 11506.9 20783.5 21084.5 21099.9 21199.2 21281.9 7937.3 8100.6 8263.0 8394.3 8398.0 4379.6 4509.2 4541.7 4592.7 4603.0 3248.1 3304.4 3327.3 3333.1 3339.4 594.0 619.5 620.7 630.0 643.1 603.7 620.2 624.3 636.7 644.6 8600.6 8626.9 8688.8 8826.2 8861.7 524.7 607.8 627.4 641.8 644.7 3800.3 4071.3 4197.6 4205.2 4310.6 117670.4 119862.4 121115.0 121500.4 128268.4 68225.7 100000.0 103869.0 104028.0 108771.5 91063.0 92948.5 93219.5 93844.5 94114.0 7762.3 7969.2 7991.0 8139.3 8290.7 54027.2 54853.7 55134.0 56347.0 57383.4 75583.6 81121.0 81953.6 82416.1 84204.6 9727.1 10034.0 10364.1 10446.2 10491.6 11350.5 11355.3 11508.9 11565.1 11675.4 10873.8 11069.6 11162.8 11238.6 11693.1 10242.8 10771.9 13275.5 13914.3 14596.5 13231.0 13416.9 13486.9 13688.3 13887.3 11281.3 11546.8 11707.0 11891.5 11925.5 11034.4 11988.5 11994.7 12250.3 12374.8 23:08:52 INFO - PROCESS | 7412 | -------- Summary: end -------- 23:08:52 INFO - PROCESS | 7412 | 23:08:53 INFO - TEST-INFO | 7412: exit 0 23:08:53 INFO - TEST-OK | dromaeo_css | took 1118266ms 23:08:53 INFO - TEST-START | kraken 23:08:53 INFO - operating with platform_type : linux_ 23:08:53 INFO - Initialising browser for kraken test... 23:08:53 INFO - TEST-INFO | started process 7723 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg2khJy/profile http://localhost:49373/getInfo.html) 23:08:57 INFO - PROCESS | 7723 | __metrics Screen width/height:1600/1200 23:08:57 INFO - PROCESS | 7723 | colorDepth:24 23:08:57 INFO - PROCESS | 7723 | Browser inner width/height: 1024/697 23:08:57 INFO - PROCESS | 7723 | __metrics 23:08:57 INFO - PROCESS | 7723 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:08:57 INFO - PROCESS | 7723 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:08:58 INFO - PROCESS | 7723 | console.error: PushService: 23:08:58 INFO - PROCESS | 7723 | stateChangeProcessEnqueue: Error transitioning state 23:08:58 INFO - PROCESS | 7723 | UnknownError 23:08:59 INFO - TEST-INFO | 7723: exit 0 23:08:59 INFO - Browser initialized. 23:08:59 INFO - Running cycle 1/1 for kraken test... 23:08:59 INFO - TEST-INFO | started process 7807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg2khJy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:09:11 INFO - PROCESS | 7807 | RSS: Main: 171737088 23:09:11 INFO - PROCESS | 7807 | 23:09:13 INFO - PROCESS | 7807 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49373/tests/kraken/driver.html?testName=audio-beat-detection) 23:09:14 INFO - PROCESS | 7807 | RSS: Main: 233156608 23:09:14 INFO - PROCESS | 7807 | 23:09:17 INFO - PROCESS | 7807 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49373/tests/kraken/driver.html?testName=audio-dft) 23:09:18 INFO - PROCESS | 7807 | RSS: Main: 215789568 23:09:18 INFO - PROCESS | 7807 | 23:09:21 INFO - PROCESS | 7807 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49373/tests/kraken/driver.html?testName=audio-fft) 23:09:21 INFO - PROCESS | 7807 | RSS: Main: 297566208 23:09:21 INFO - PROCESS | 7807 | 23:09:23 INFO - PROCESS | 7807 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49373/tests/kraken/driver.html?testName=audio-oscillator) 23:09:24 INFO - PROCESS | 7807 | RSS: Main: 206127104 23:09:24 INFO - PROCESS | 7807 | 23:09:26 INFO - PROCESS | 7807 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49373/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:09:27 INFO - PROCESS | 7807 | RSS: Main: 211492864 23:09:27 INFO - PROCESS | 7807 | 23:09:30 INFO - PROCESS | 7807 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49373/tests/kraken/driver.html?testName=imaging-darkroom) 23:09:30 INFO - PROCESS | 7807 | RSS: Main: 247771136 23:09:30 INFO - PROCESS | 7807 | 23:09:34 INFO - PROCESS | 7807 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49373/tests/kraken/driver.html?testName=imaging-desaturate) 23:09:34 INFO - PROCESS | 7807 | RSS: Main: 246308864 23:09:34 INFO - PROCESS | 7807 | 23:09:37 INFO - PROCESS | 7807 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49373/tests/kraken/driver.html?testName=json-parse-financial) 23:09:37 INFO - PROCESS | 7807 | RSS: Main: 246054912 23:09:37 INFO - PROCESS | 7807 | 23:09:39 INFO - PROCESS | 7807 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49373/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:09:40 INFO - PROCESS | 7807 | RSS: Main: 208752640 23:09:40 INFO - PROCESS | 7807 | 23:09:41 INFO - PROCESS | 7807 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49373/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:09:42 INFO - PROCESS | 7807 | RSS: Main: 215949312 23:09:42 INFO - PROCESS | 7807 | 23:09:44 INFO - PROCESS | 7807 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49373/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:09:45 INFO - PROCESS | 7807 | RSS: Main: 225488896 23:09:45 INFO - PROCESS | 7807 | 23:09:47 INFO - PROCESS | 7807 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:09:48 INFO - PROCESS | 7807 | RSS: Main: 233844736 23:09:48 INFO - PROCESS | 7807 | 23:09:51 INFO - PROCESS | 7807 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:09:51 INFO - PROCESS | 7807 | RSS: Main: 230592512 23:09:51 INFO - PROCESS | 7807 | 23:09:53 INFO - PROCESS | 7807 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49373/tests/kraken/driver.html?testName=ai-astar) 23:09:53 INFO - PROCESS | 7807 | RSS: Main: 281743360 23:09:53 INFO - PROCESS | 7807 | 23:09:53 INFO - PROCESS | 7807 | __start_tp_report 23:09:53 INFO - PROCESS | 7807 | _x_x_mozilla_page_load 23:09:53 INFO - PROCESS | 7807 | _x_x_mozilla_page_load_details 23:09:53 INFO - PROCESS | 7807 | |i|pagename|runs| 23:09:53 INFO - PROCESS | 7807 | |0;ai-astar;105;111;111;112;112;112;112;112;111;110 23:09:53 INFO - PROCESS | 7807 | |1;audio-beat-detection;148;132;127;167;125;129;122;120;152;125 23:09:53 INFO - PROCESS | 7807 | |2;audio-dft;160;161;160;159;160;161;161;161;160;162 23:09:53 INFO - PROCESS | 7807 | |3;audio-fft;75;75;76;111;85;76;76;76;97;74 23:09:53 INFO - PROCESS | 7807 | |4;audio-oscillator;83;83;122;83;83;83;104;83;83;108 23:09:53 INFO - PROCESS | 7807 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;116;117;117 23:09:53 INFO - PROCESS | 7807 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;145 23:09:53 INFO - PROCESS | 7807 | |7;imaging-desaturate;85;85;86;85;85;85;86;86;85;85 23:09:53 INFO - PROCESS | 7807 | |8;json-parse-financial;56;53;53;53;53;54;55;55;54;53 23:09:53 INFO - PROCESS | 7807 | |9;json-stringify-tinderbox;60;62;61;61;62;61;61;60;61;60 23:09:53 INFO - PROCESS | 7807 | |10;stanford-crypto-aes;80;84;79;83;88;80;79;79;80;82 23:09:53 INFO - PROCESS | 7807 | |11;stanford-crypto-ccm;142;142;133;141;135;141;141;139;182;152 23:09:53 INFO - PROCESS | 7807 | |12;stanford-crypto-pbkdf2;166;166;167;170;165;167;170;165;164;165 23:09:53 INFO - PROCESS | 7807 | |13;stanford-crypto-sha256-iterative;65;66;66;69;65;67;65;64;65;64 23:09:53 INFO - PROCESS | 7807 | __end_tp_report 23:09:53 INFO - PROCESS | 7807 | __start_cc_report 23:09:53 INFO - PROCESS | 7807 | _x_x_mozilla_cycle_collect,1688 23:09:53 INFO - PROCESS | 7807 | __end_cc_report 23:09:53 INFO - PROCESS | 7807 | __startTimestamp1477030193815__endTimestamp 23:09:53 INFO - PROCESS | 7807 | 23:09:53 INFO - PROCESS | 7807 | ------- Summary: start ------- 23:09:53 INFO - PROCESS | 7807 | Number of tests: 14 23:09:53 INFO - PROCESS | 7807 | 23:09:53 INFO - PROCESS | 7807 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:2.15 (1.9%) stddev-sans-first:0.73 23:09:53 INFO - PROCESS | 7807 | Values: 105.0 111.0 111.0 112.0 112.0 112.0 112.0 112.0 111.0 110.0 23:09:53 INFO - PROCESS | 7807 | 23:09:53 INFO - PROCESS | 7807 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:130.50 stddev:15.58 (11.9%) stddev-sans-first:15.76 23:09:53 INFO - PROCESS | 7807 | Values: 148.0 132.0 127.0 167.0 125.0 129.0 122.0 120.0 152.0 125.0 23:09:53 INFO - PROCESS | 7807 | 23:09:53 INFO - PROCESS | 7807 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 23:09:53 INFO - PROCESS | 7807 | Values: 160.0 161.0 160.0 159.0 160.0 161.0 161.0 161.0 160.0 162.0 23:09:53 INFO - PROCESS | 7807 | 23:09:53 INFO - PROCESS | 7807 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:12.39 (16.3%) stddev-sans-first:12.87 23:09:53 INFO - PROCESS | 7807 | Values: 75.0 75.0 76.0 111.0 85.0 76.0 76.0 76.0 97.0 74.0 23:09:53 INFO - PROCESS | 7807 | 23:09:53 INFO - PROCESS | 7807 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:83.00 stddev:14.39 (17.3%) stddev-sans-first:14.93 23:09:53 INFO - PROCESS | 7807 | Values: 83.0 83.0 122.0 83.0 83.0 83.0 104.0 83.0 83.0 108.0 23:09:53 INFO - PROCESS | 7807 | 23:09:53 INFO - PROCESS | 7807 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:09:53 INFO - PROCESS | 7807 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 23:09:53 INFO - PROCESS | 7807 | 23:09:53 INFO - PROCESS | 7807 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 23:09:53 INFO - PROCESS | 7807 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 23:09:53 INFO - PROCESS | 7807 | 23:09:53 INFO - PROCESS | 7807 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 23:09:53 INFO - PROCESS | 7807 | Values: 85.0 85.0 86.0 85.0 85.0 85.0 86.0 86.0 85.0 85.0 23:09:53 INFO - PROCESS | 7807 | 23:09:53 INFO - PROCESS | 7807 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:1.10 (2.0%) stddev-sans-first:0.87 23:09:53 INFO - PROCESS | 7807 | Values: 56.0 53.0 53.0 53.0 53.0 54.0 55.0 55.0 54.0 53.0 23:09:53 INFO - PROCESS | 7807 | 23:09:53 INFO - PROCESS | 7807 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 23:09:53 INFO - PROCESS | 7807 | Values: 60.0 62.0 61.0 61.0 62.0 61.0 61.0 60.0 61.0 60.0 23:09:53 INFO - PROCESS | 7807 | 23:09:53 INFO - PROCESS | 7807 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.00 stddev:2.91 (3.6%) stddev-sans-first:3.05 23:09:53 INFO - PROCESS | 7807 | Values: 80.0 84.0 79.0 83.0 88.0 80.0 79.0 79.0 80.0 82.0 23:09:53 INFO - PROCESS | 7807 | 23:09:53 INFO - PROCESS | 7807 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:141.50 stddev:14.00 (9.9%) stddev-sans-first:14.81 23:09:53 INFO - PROCESS | 7807 | Values: 142.0 142.0 133.0 141.0 135.0 141.0 141.0 139.0 182.0 152.0 23:09:53 INFO - PROCESS | 7807 | 23:09:53 INFO - PROCESS | 7807 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:166.50 stddev:2.07 (1.2%) stddev-sans-first:2.19 23:09:53 INFO - PROCESS | 7807 | Values: 166.0 166.0 167.0 170.0 165.0 167.0 170.0 165.0 164.0 165.0 23:09:53 INFO - PROCESS | 7807 | 23:09:53 INFO - PROCESS | 7807 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:1.51 (2.3%) stddev-sans-first:1.58 23:09:53 INFO - PROCESS | 7807 | Values: 65.0 66.0 66.0 69.0 65.0 67.0 65.0 64.0 65.0 64.0 23:09:53 INFO - PROCESS | 7807 | -------- Summary: end -------- 23:09:53 INFO - PROCESS | 7807 | 23:09:55 INFO - TEST-INFO | 7807: exit 0 23:09:55 INFO - TEST-OK | kraken | took 61991ms 23:09:55 INFO - SUITE-END | took 1180s 23:09:55 INFO - Completed test suite (00:19:40) 23:09:55 INFO - javascript benchmark 23:09:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2928.4875146849304, 2966.169472547687, 2968.0809168448795, 2972.3460838615524, 2987.880484780609, 5022.472640372763, 5124.128898087325, 5125.333706618139, 5276.445973172819, 5296.179092240699, 5115.872103197422, 5212.66117702349, 5271.525562699357, 5296.867578310545, 5381.0852155133625, 4667.043256132485, 4718.811247550094, 4728.125296820082, 4814.54261845125, 4833.3958255218095, 4689.718616882998, 4778.976105119469, 4800.279958006309, 4852.4662287148385, 4875.561199492045, 4822.9758851205515, 4854.951450485503, 4867.0, 4872.3909511311085, 4923.458419573844, 4630.398048253739, 4656.41794775653, 4673.345731597579, 4680.040591678698, 4857.73282469464, 4690.788914498856, 4801.831935882262, 4821.059893320804, 4822.0, 4822.180229361017, 5211.661242019257, 5243.947560524384, 5251.658642188246, 5263.499967503081, 5275.340582427197, 5571.888562228733, 5573.916391254134, 5577.442255774431, 5577.776888924438, 5632.324121105453, 5308.177232528964, 5356.866078348073, 5486.835394938118, 5522.447755224445, 5535.529479994165, 5211.062008838446, 5217.034848553029, 5218.556422704037, 5222.817201397971, 5272.367315922113, 5696.23100881384, 5701.486866182064, 5703.62926409782, 5704.11586204139, 5768.423157684198, 5176.430592634807, 5267.446918073624, 5471.042567550663, 5476.0, 5521.171824226318, 5609.046462101453, 5648.717564121777, 5651.124075768263, 5696.060150075191, 5725.799597014085, 5623.831285061455, 5628.71856407178, 5631.943680563224, 5632.718364081779, 5635.802746903839, 5358.812441564526, 5414.783408663609, 5415.1335786274, 5620.1569764534825, 5673.744681489343, 4244.702870799076, 4251.149770046003, 4297.033167537342, 4336.479622445327, 4352.608265256142, 3826.1582451860545, 3829.7319187657154, 3830.961690383116, 3869.709771767072, 3872.5740168581433, 5272.367315922037, 5314.654547454403, 5327.334083239595, 5331.573474122061, 5336.1195402758885, 5330.093884039723, 5401.7299135043095, 5544.362398324163, 5608.887822243532, 5619.100943848965, 5354.330708661418, 5360.839174824761, 5362.678239305654, 5364.7317634118135, 5378.596605254622, 4885.731284779371, 4894.290327902434, 4896.828610998598, 4897.094037602984, 4960.553550180501, 5631.549476041907, 5696.971515142398, 5701.885962280814, 5742.59801813869, 5824.068149096124, 5610.410906854885, 5614.69119198448, 5620.072688006597, 5661.575381846295, 5678.886422271614, 5779.595428319977, 5782.161586570008, 5783.392743761844, 5787.450192231731, 5788.131780232999, 5240.397354304304, 5335.919961200508, 5379.946200538101, 5504.91742623869, 5508.366537848199, 5511.779528818963, 5555.555555555465, 5557.555395568425, 5562.471565201299, 5565.081761509306, 5421.701806400686, 5434.184872269033, 5434.456554344692, 5436.700981445901, 5436.782528698966, 5411.1883217516115, 5420.403755586961, 5422.783088676409, 5424.538914192338, 5425.348958125051, 5309.33633295838, 5357.8392648220615, 5359.544438722753, 5362.0, 5393.298871146882, 5380.381256155592, 5399.703016333982, 5403.324584426947, 5409.161579955114, 5409.513143817076, 5144.6398752087, 5245.606579506476, 5287.127623942007, 5298.576113910801, 5319.946800531945], "value": 5139.338654085158, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.422440232974, 615.7260019291416, 625.4214851262581, 627.1126356205968, 636.3986033198629, 31608.841955790216, 45455.54544454555, 46914.0, 47046.529534704685, 47055.0, 44873.94201782758, 45294.0, 45306.54693453065, 45347.0, 45389.31916021254, 8880.067592902766, 9043.050479699636, 9045.502497362642, 9053.411528250675, 9055.275577953747, 7955.323797477221, 8156.143604921487, 10306.536205870716, 10525.473726313692, 10540.262181647287, 10758.193135514828, 10846.457677116152, 10850.72873178169, 10851.0, 10851.348919064882, 10707.036366726992, 10796.190285728602, 10847.403392813392, 10854.837177442345, 10856.837147442795, 10578.471076446147, 10655.0, 10664.200184986157, 10664.840027399596, 10668.573257069707, 41792.79103604493, 41988.0, 42050.0, 42090.368644470356, 42113.36829947553, 3286.9835650821833, 3464.5149679044953, 3552.8401221945073, 3613.7470377073614, 3827.0623697194087, 30983.690163098305, 31073.22316942072, 31808.363832723215, 31852.681473185203, 32000.0, 3872.8838134856, 3938.5667576566557, 3996.440498330236, 4094.7747873866924, 4120.608542188487, 230104.0, 230414.0, 231244.84377578172, 231840.0, 232128.0, 57986.420135798944, 58397.0, 58448.70775646094, 58476.41523584795, 58484.41515584875, 61179.6941015301, 61559.0, 61616.919154042116, 61678.69160654168, 61678.691606542576, 15890.205489725698, 16037.198140092949, 16053.839461605468, 16117.677646447006, 16125.758113628304, 11094.889051109547, 11401.657950261506, 11473.311601303949, 11507.597234096766, 11522.251053681484, 16019.0, 16123.516294511184, 16157.919210404109, 16828.326866925185, 17485.300587976337, 5785.247917770663, 5813.186153938452, 5948.583599148104, 5996.2504686914135, 6133.1413602095745, 844.8521508735946, 904.556767184075, 936.7236665183788, 987.4470296633908, 1054.926155169146, 28698.282542936595, 29783.553246701318, 29838.701612983594, 30514.237144071576, 30652.0, 999.7850462150673, 1045.900639439252, 1096.1066730614523, 1104.1332553945115, 1130.6947124276398, 15076.54770356869, 15768.76346854798, 15861.762073568905, 15891.602709932113, 16247.350105995863, 468293.0, 470921.0, 471151.0, 472189.0, 472231.0, 48562.27156592654, 49359.0, 55125.72437137869, 56307.71846140825, 56425.0, 1287.2855565161237, 1296.2870421268453, 1302.3097758188176, 1305.301663609983, 1315.0400207848134, 29594.260143496584, 31158.22104447407, 31232.0, 31242.843785780926, 31869.20326991844, 51397.74301128471, 52155.217671735714, 52264.47735522596, 52267.73866130645, 52284.738576306874, 416681.0, 417647.0, 420734.0, 426425.0, 427288.0, 41220.1755964885, 41399.7930010348, 41774.0, 42205.24716045541, 42298.7885060585, 46802.0, 47322.52677473319, 47444.28833567568, 48366.51633483761, 48480.51519484901, 39109.41335879907, 39971.40042899301, 40587.39118913278, 41347.58652413437, 42807.3578896323, 38723.41914871336, 39267.41098883462, 39842.80078599588, 40820.0, 41692.374614380205, 37192.62807372, 38064.0, 38588.61411385963, 38643.420348695356, 38867.6113238864, 32084.839575801972, 34620.0, 34979.30041399107, 35080.82459587788, 35197.64802351944, 25519.744802551737, 25911.481770364866, 25931.22206333813, 25953.22140335793, 26366.209013729618], "value": 19747.38686505224, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.0, 342.42814499785356, 356.94288913773795, 360.29562205887487, 379.83097521602883, 14200.928995355021, 18082.276708931644, 18091.185896634666, 18541.16564754586, 19786.30747923823, 17924.462266132003, 18173.636527269446, 18504.53738656531, 18592.163352649128, 19067.237310507564, 4875.878103047426, 5114.667546609477, 5116.027954688598, 5116.897662046776, 5124.103281925667, 3727.105494681284, 3857.864974725885, 5025.623078269126, 5095.388553373582, 5096.082705113078, 5338.733063346836, 5590.664560126385, 5623.044082505984, 5674.09214525676, 5675.9432405675825, 5653.434656534334, 5663.0655941769555, 5776.335721392031, 6227.532935029891, 6274.309825919146, 5495.395506494282, 5502.294288770494, 5503.422140675251, 5504.834854954358, 5510.559155267569, 12002.219855709438, 12015.21901076436, 12158.148929574932, 12322.691932701664, 16687.499375018768, 2154.4721543221854, 2217.977820221793, 2318.6406107053267, 2447.5227330670527, 2769.6399468069226, 8933.151350621745, 9258.0, 9809.068138526829, 9813.018698130201, 9846.753831154207, 1849.34348306352, 1875.5967466994525, 1881.9435416937513, 1888.4806678163477, 1895.7156426535992, 81803.0, 82155.0, 83044.0, 83449.58275208646, 85606.0, 9866.112049915542, 9911.454869982075, 10215.387076775418, 10222.335548189343, 10349.63776267827, 13848.930755346159, 13895.305234738222, 13924.0, 13979.930100349637, 14017.579472615838, 7339.88990165148, 7506.399488040944, 7626.923730762733, 7684.692612295557, 7831.451798374173, 7075.893861592081, 7259.673314700851, 7366.0, 7432.40203356281, 7639.0, 4124.731892426983, 4208.305629571087, 4260.360945858146, 4377.496587892433, 4404.66964977628, 1707.6926153292527, 1765.3909401256547, 1807.629435965624, 1839.586093129062, 1849.8705090643796, 805.6253841963398, 830.8213734047088, 832.3632421197789, 990.8464188050864, 1011.4386515483977, 17025.914870425568, 18645.533861653566, 18716.0, 18777.371168036487, 19098.90450547766, 870.1994165367877, 872.4024043530202, 912.0879120879121, 930.093159169804, 938.5025936253796, 9841.065098815601, 10101.19190464761, 10276.486175691185, 10288.537015834305, 10382.273240873066, 429060.0, 430355.0, 488660.0, 528370.0, 529177.0, 49475.752621236665, 83952.16047839566, 84941.0, 85660.0, 89866.0, 905.5608030105394, 908.3868388837641, 935.742670765545, 946.9621215151454, 950.9239260859115, 15664.267293197434, 16026.679466410373, 16158.757618635966, 16881.831181688518, 17246.91376543109, 36580.26839463249, 36604.26791464209, 38021.0, 38303.61696383112, 39343.80328098341, 48966.75516622394, 49561.75219123881, 50594.0, 51327.230091549405, 53559.732201338746, 7613.885791713239, 7723.189065148079, 7765.262300081483, 7933.642986065756, 7993.400494963017, 8339.416240863082, 9655.951720241354, 12191.268523888595, 12888.742225155633, 12967.870321296667, 10520.526576303932, 10809.432632268434, 10867.0762985144, 10928.890711092787, 11119.091797849063, 11110.16673749456, 11373.829392559284, 11467.483963221508, 11569.88430115688, 11887.108466864847, 11195.44022798873, 11403.31580105163, 11447.141464390037, 11501.194916355775, 12021.519139234333, 7880.645370958436, 8060.959695201486, 8113.269805717514, 8275.62759675828, 8360.958195208985, 10294.845577316197, 10614.734631633963, 10745.785084298113, 10943.233973621771, 11406.372649504357], "value": 8472.201220956686, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.6265845563246, 1350.223621417685, 1448.8188976377953, 1452.8329242137154, 1697.0835748695704, 7559.357454616357, 8383.077861435246, 8603.526806025666, 8631.827363452727, 8914.687985920495, 8984.91015089849, 9069.72790816275, 9070.77323066922, 9073.274138068955, 9077.0, 2243.999999999996, 2260.8530445520987, 2265.014718597407, 2267.240474441064, 2268.410213344534, 2203.272919936417, 2230.197129033547, 2252.6958860553777, 2269.1150451323997, 2269.7730226977337, 2231.2748356784027, 2233.1737257214854, 2235.10595761695, 2238.731352237734, 2272.556851413975, 2139.7432308123125, 2144.088762276042, 2165.361218440548, 2177.314146043999, 2181.7163768710125, 2175.8150557202657, 2198.0328655391577, 2198.241606645721, 2201.482651576878, 2204.272590045281, 8962.283017358595, 9034.32242581809, 9036.683716069905, 9037.819243615091, 9040.141186587329, 4974.577160941324, 5152.562032227265, 5152.768125434327, 5179.818706345298, 5190.091733946544, 3135.925933160139, 3244.480883058723, 3274.2305558193807, 3296.950545741816, 3303.6861498157637, 937.2642475656645, 948.2745699539857, 959.3188835926501, 967.0522887570221, 979.7893452907659, 11965.46155423008, 12043.470871117075, 12048.216865903689, 12049.0, 12060.638180854588, 4260.55264197261, 4532.138893610204, 4632.25883858581, 4636.466806317249, 4657.930131048037, 9750.122488976027, 9814.460204688668, 9832.0, 9838.704838854846, 9845.113939745313, 5192.402873669501, 5194.662346947436, 5201.843944681666, 5208.166693329125, 5208.8437346879655, 4090.550039495653, 4124.154548317588, 4601.585857272795, 4724.551167639069, 4894.461609222983, 3531.205478767257, 3594.892153235407, 3629.8366573504254, 3679.4480827875495, 3725.925481490355, 1058.444316733721, 1067.7330667333167, 1070.973225669349, 1080.4975686305906, 1084.7017070305728, 877.7586163805005, 890.7283278600089, 907.4872696926216, 912.466207268742, 920.4293338130402, 5610.382857885629, 5729.742161602655, 5739.655620662774, 5779.508741756914, 5962.940370596325, 405.67343288652916, 407.8225971702319, 415.621784176398, 415.74639469923324, 424.02051261585837, 3720.3489389356755, 3767.773933563995, 3770.057485628593, 3775.093977445448, 3815.236952609489, 10839.187060970458, 11122.777544449065, 11189.776204475866, 11192.160587955936, 11248.156388270912, 11111.166662500345, 11147.94426027881, 11155.888441115485, 11172.10623150146, 11181.105511559219, 7837.255460731221, 8180.386471014816, 8310.958445207736, 8341.0, 8405.495670259805, 6014.518838492998, 6142.600730952474, 6178.474829639351, 6208.906866396917, 6250.749970001331, 10270.383776973405, 10388.792224155626, 10434.060934515626, 10447.791044179226, 10574.312669676447, 9867.0, 10249.180065594586, 10265.281430299807, 10533.104686101768, 10617.416042117758, 6991.405730512964, 7206.279372062962, 7208.675609597476, 7582.582957937146, 7753.92246077532, 7671.309582137635, 7859.882101768364, 8457.365697572584, 8533.615987280711, 8690.130986901511, 7742.303192712683, 7770.92229077702, 7932.325752311118, 8017.63920623585, 8062.314703250289, 7367.742129025459, 7454.4781865268915, 7463.0, 7566.205548417337, 7596.126445458843, 6970.686319115754, 7137.1435427749, 7146.178189508065, 7151.356377926011, 7154.499185056996, 4656.41794775653, 4696.319033740157, 4723.929141062818, 4912.533309335608, 4959.82640607577, 4824.421069471686, 4848.0788650156355, 4852.393450818648, 5025.0, 5031.345925029723], "value": 4394.1221810785955, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.94529039482495, 303.60986132819323, 306.9616297962755, 307.1446022826429, 308.18792481810425, 5093.108705976458, 5175.637705360627, 5222.843314700555, 5255.264263003182, 5266.447023062581, 5094.1594636884865, 5154.92267615986, 5182.663126896749, 5193.766280517376, 5199.766010529525, 4037.576054514278, 4041.4948131483493, 4059.8579049733266, 4064.7967601619803, 4065.451164092854, 3796.6013568575318, 3814.569536423841, 4056.452378928851, 4064.248114098886, 4067.0, 3994.4208089826957, 4007.6994225433064, 4014.197160567898, 4018.2164477926817, 4025.778582177979, 3957.6438120569287, 3965.4250133730734, 3981.6416522512823, 3984.641382275609, 4022.45696830927, 3514.859405623772, 3520.507129001942, 3529.5588051493564, 3533.2050288685095, 3540.0, 4929.742915556546, 5013.699178049329, 5040.974795126038, 5059.241113832918, 5060.266261392115, 4579.977100114512, 4596.161535385839, 4596.471405788344, 4598.241290187115, 4605.125026245003, 5394.460553944614, 5399.595030372738, 5410.8917821643345, 5419.783208671648, 5427.83716488506, 3841.3661745811905, 3900.102976315435, 3905.266313580505, 3926.7840268785208, 3945.861894833667, 5666.914996275059, 5673.971630141864, 5683.744231509592, 5687.630304030225, 5700.201971723962, 4030.052937559671, 4031.657309128698, 4032.919341613151, 4033.233685599727, 4059.208454351432, 4009.7393669411395, 4071.6742660587674, 4085.795710214537, 4092.9795351023054, 4107.732997355222, 4581.679282450264, 4587.61005314552, 4611.308303754397, 4615.699979501322, 4619.099275641218, 5417.891642167135, 5447.319085114361, 5453.3455985281225, 5462.126059830408, 5466.64466809664, 1273.7134144817342, 1307.5423601739315, 1318.8944884409225, 1390.3951780975308, 1403.5298175111247, 846.8856704344958, 857.3698331726176, 880.1330689271063, 881.4314766975265, 882.5543100734088, 4744.0037592105355, 4754.857354279377, 4759.857204283877, 4777.426708794897, 4786.688865223749, 4853.296272040534, 4939.333190019373, 4957.264957264929, 4989.975050124799, 4999.650024498323, 4696.553827386393, 4698.763716635375, 4728.40894888139, 4731.33761273422, 4768.690035147704, 2539.3143851160453, 2633.7761290290155, 2651.986740066326, 2663.8268512546624, 2664.9600255996174, 5042.0, 5110.2590124431745, 5113.897722045538, 5127.846164615067, 5137.229415587692, 5005.874853128628, 5007.2224360352275, 5011.298418221452, 5017.84946451607, 5333.57331413486, 5793.768249270066, 5812.82561523155, 5819.243498345273, 5819.679917604488, 5830.416958304136, 5650.067738823048, 5661.433856614306, 5662.716864156693, 5664.348599911063, 5681.8863622726485, 5473.671579705071, 5581.944180558143, 5602.2717046783655, 5607.467290607386, 5611.410801865745, 5810.73851676684, 5812.82561523155, 5815.79644712433, 5825.737841797045, 5835.44563266489, 3722.8696995605023, 3948.44721738951, 3958.584348643351, 3972.8212230450276, 3985.3025720499377, 5169.121249387538, 5384.838454846361, 5452.182172674131, 5626.24045753818, 5673.262475878275, 5480.342358916796, 5496.0, 5506.752196151263, 5520.254765606592, 5520.806771762969, 5401.594880384066, 5433.478625984572, 5494.890102198014, 5520.199571062254, 5547.667139971614, 5473.698946557818, 5477.698726569917, 5477.945220547744, 5483.259759932358, 5494.390164671749, 5534.976029434568, 5535.8892822142525, 5548.223248745259, 5569.6936668482, 5576.693281869536, 5289.550388217045, 5320.2177270614775, 5366.812161574326, 5369.248305237348, 5399.973000134974], "value": 4064.219902594689, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.9738410463578, 673.4141297071549, 717.4224749076992, 720.4740539406233, 760.6653072648031, 14342.06776559523, 15599.688006239869, 15612.141332226724, 15657.451989180381, 16412.67174656506, 14510.27448627567, 15052.54842354731, 15113.622159446018, 15121.924390378033, 15140.772888406682, 662.1656712542183, 797.0793733238105, 818.6275244763618, 818.6848063495538, 821.5768879027306, 672.0557616548757, 684.849333146707, 685.5612408058821, 685.866256080062, 772.4399810137661, 853.1724227499316, 855.1064137975831, 862.5816479007676, 864.2394692670441, 865.0657290126679, 852.4288726553224, 852.6078004118114, 852.7058164933151, 852.722865068852, 853.1979938857485, 509.0963539716995, 514.3236643813411, 608.3733754233147, 627.8430392401899, 631.192074145095, 14612.342444590018, 15432.768508472382, 15470.149141797197, 15476.380944762195, 15485.767713484307, 13438.596842094752, 14149.434022639081, 14175.149491030572, 14195.78706319406, 14260.500882469063, 12514.436850341757, 12991.935040324832, 13045.152065115737, 13103.86896131036, 13263.204207747565, 4454.710443821141, 4519.322101684741, 4530.229860923618, 4532.5240849710635, 4538.682292239545, 82582.0, 82666.58666706688, 83617.58191209006, 83703.16296837015, 86052.98814541461, 10417.791644167075, 11046.558137674563, 11084.501197446134, 11109.222354435113, 11506.88493115075, 20783.480412989495, 21084.47288817792, 21099.8945005274, 21199.15203391847, 21281.89359053195, 7937.32532734724, 8100.635471403801, 8262.958685206655, 8394.328453723687, 8397.958010210032, 4379.627731642846, 4509.233430316854, 4541.710906258354, 4592.6555508337005, 4602.976985115053, 3248.1067706380936, 3304.3886880927107, 3327.301266734013, 3333.100062982981, 3339.382214290364, 593.989346063578, 619.5198720991177, 620.7237779188308, 629.9905501417483, 643.0611307491115, 603.6649659439054, 620.1751670278519, 624.2914292278297, 636.700750647195, 644.6454450052453, 8600.5699715014, 8626.91373086261, 8688.826223475495, 8826.161514656098, 8861.689840855539, 524.7114087251996, 607.8358843112424, 627.4415769964735, 641.8202903187115, 644.6848429204464, 3800.315943130263, 4071.307877660805, 4197.580241975839, 4205.158968206371, 4310.590493903074, 117670.41164794292, 119862.400687996, 121115.0, 121500.39249803871, 128268.35865820611, 68225.65887170532, 100000.0, 103869.0, 104028.0, 108771.45614271877, 91063.0, 92948.53525732328, 93219.53390233142, 93844.49244060459, 94114.0, 7762.292295694938, 7969.177330165771, 7991.0, 8139.348852091937, 8290.668373265244, 54027.189592155366, 54853.72573137109, 55134.0, 56347.0, 57383.42616573948, 75583.62208188923, 81121.0, 81953.59023204846, 82416.12478557523, 84204.57897710717, 9727.124558789743, 10034.0, 10364.134455798028, 10446.216533759847, 10491.632792852213, 11350.489227984926, 11355.261907975955, 11508.94245528767, 11565.074794016291, 11675.360768053008, 10873.782524349626, 11069.5572177112, 11162.776744465227, 11238.55045798159, 11693.12301577368, 10242.795144097225, 10771.946140269249, 13275.468981240641, 13914.304284785923, 14596.489122880648, 13230.96455581057, 13416.932915335361, 13486.93256533711, 13688.31558422055, 13887.285825157853, 11281.323120612462, 11546.826797597874, 11707.0, 11891.524339026688, 11925.463354148911, 11034.448277586249, 11988.520459181535, 11994.700132496757, 12250.326232057323, 12374.81437778452], "value": 7304.11649311684, "unit": "score"}], "name": "dromaeo_css", "value": 6944.585097816522, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 111.0, 112.0, 112.0, 112.0, 112.0, 112.0, 111.0, 110.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 132.0, 127.0, 167.0, 125.0, 129.0, 122.0, 120.0, 152.0, 125.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 159.0, 160.0, 161.0, 161.0, 161.0, 160.0, 162.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 111.0, 85.0, 76.0, 76.0, 76.0, 97.0, 74.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 122.0, 83.0, 83.0, 83.0, 104.0, 83.0, 83.0, 108.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 85.0, 85.0, 85.0, 86.0, 86.0, 85.0, 85.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 53.0, 53.0, 54.0, 55.0, 55.0, 54.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 60.0, 61.0, 60.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 79.0, 83.0, 88.0, 80.0, 79.0, 79.0, 80.0, 82.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 142.0, 133.0, 141.0, 135.0, 141.0, 141.0, 139.0, 182.0, 152.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 167.0, 170.0, 165.0, 167.0, 170.0, 165.0, 164.0, 165.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 69.0, 65.0, 67.0, 65.0, 64.0, 65.0, 64.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1500.6999999999998, "alertThreshold": 2.0}]} 23:09:55 INFO - Return code: 0 23:09:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:09:55 INFO - # TBPL SUCCESS # 23:09:55 INFO - Running post-action listener: _resource_record_post_action 23:09:55 INFO - [mozharness: 2016-10-21 06:09:55.591033Z] Finished run-tests step (success) 23:09:55 INFO - Running post-run listener: _resource_record_post_run 23:09:55 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 396333056; Read time: 16; Write time: 378816 23:09:55 INFO - TinderboxPrint: CPU usage
13.1% 23:09:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 23:09:55 INFO - TinderboxPrint: I/O write bytes / time
396,333,056 / 378,816 23:09:55 INFO - TinderboxPrint: CPU idle
8,306.2 (86.9%) 23:09:55 INFO - TinderboxPrint: CPU user
1,200.2 (12.6%) 23:09:55 INFO - TinderboxPrint: Swap in / out
0 / 0 23:09:55 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103825408; Read time: 0; Write time: 141812 23:09:55 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288964608; Read time: 0; Write time: 236160 23:09:56 INFO - Running post-run listener: _upload_blobber_files 23:09:56 INFO - Blob upload gear active. 23:09:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:09:56 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 23:09:56 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'] 23:09:56 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 23:09:56 INFO - (blobuploader) - INFO - Open directory for files ... 23:09:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:09:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:09:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:09:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:09:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:09:57 INFO - (blobuploader) - INFO - Done attempting. 23:09:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:09:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:09:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:10:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:10:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:10:00 INFO - (blobuploader) - INFO - Done attempting. 23:10:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:10:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:10:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:10:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:10:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:10:01 INFO - (blobuploader) - INFO - Done attempting. 23:10:01 INFO - (blobuploader) - INFO - Iteration through files over. 23:10:01 INFO - Return code: 0 23:10:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:10:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:10:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa9532900e26ff963f3eb312836e5c080d7f74f32f4e7971366b2cbae599ca6878a7e380b027190f57082173d7526b6a8875af05bccaa5f726939dd1b23d3211", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e1bf87ab82903992c738afb623fcf9cb0ae97ad0a36a3b2d965be4532452b6c033157f1eaeb181431303a2ee3de3355302c92dea7855fd26aa5acdf5c0427e2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dad37e29822b23c4ca7f988813a8833553075e74addf919bf1a7e43a5afc9403f427fa1c4b99770dd3842d30bccb018533291a1b5a7c937adfa45532a8f67ba5"} 23:10:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:10:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:10:01 INFO - Contents: 23:10:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa9532900e26ff963f3eb312836e5c080d7f74f32f4e7971366b2cbae599ca6878a7e380b027190f57082173d7526b6a8875af05bccaa5f726939dd1b23d3211", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e1bf87ab82903992c738afb623fcf9cb0ae97ad0a36a3b2d965be4532452b6c033157f1eaeb181431303a2ee3de3355302c92dea7855fd26aa5acdf5c0427e2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dad37e29822b23c4ca7f988813a8833553075e74addf919bf1a7e43a5afc9403f427fa1c4b99770dd3842d30bccb018533291a1b5a7c937adfa45532a8f67ba5"} 23:10:01 INFO - Running post-run listener: copy_logs_to_upload_dir 23:10:01 INFO - Copying logs to upload dir... 23:10:01 INFO - mkdir: /builds/slave/test/build/upload/logs 23:10:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.349757 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-20 23:10:01.204013) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 23:10:01.209090) ========= 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=836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa9532900e26ff963f3eb312836e5c080d7f74f32f4e7971366b2cbae599ca6878a7e380b027190f57082173d7526b6a8875af05bccaa5f726939dd1b23d3211", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e1bf87ab82903992c738afb623fcf9cb0ae97ad0a36a3b2d965be4532452b6c033157f1eaeb181431303a2ee3de3355302c92dea7855fd26aa5acdf5c0427e2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dad37e29822b23c4ca7f988813a8833553075e74addf919bf1a7e43a5afc9403f427fa1c4b99770dd3842d30bccb018533291a1b5a7c937adfa45532a8f67ba5"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011433 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477017007/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa9532900e26ff963f3eb312836e5c080d7f74f32f4e7971366b2cbae599ca6878a7e380b027190f57082173d7526b6a8875af05bccaa5f726939dd1b23d3211", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e1bf87ab82903992c738afb623fcf9cb0ae97ad0a36a3b2d965be4532452b6c033157f1eaeb181431303a2ee3de3355302c92dea7855fd26aa5acdf5c0427e2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dad37e29822b23c4ca7f988813a8833553075e74addf919bf1a7e43a5afc9403f427fa1c4b99770dd3842d30bccb018533291a1b5a7c937adfa45532a8f67ba5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 23:10:01.237309) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 23:10:01.238031) ========= 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=836cfdc75598d54cb747368e000001a9-1477028960.911658-157136390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 23:10:01.325719) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 23:10:01.326377) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 23:10:01.327096) ========= ========= Total master_lag: 0.18 =========