builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1477016927.1 results: success (0) buildid: 20161020185753 builduid: 5fa1117a79414851806b0918776a6006 revision: 50dcca551b63ee6e9b07207208d6cb1c239467af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 19:28:47.095601) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 19:28:47.096080) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 19:28:47.096423) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 19:28:47.118385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 19:28:47.118703) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 19:28:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.1M=0s 2016-10-20 19:28:47 (88.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112673 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 19:28:47.245699) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 19:28:47.246058) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021804 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 19:28:47.299682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 19:28:47.300616) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 50dcca551b63ee6e9b07207208d6cb1c239467af --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 50dcca551b63ee6e9b07207208d6cb1c239467af --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=82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 19:28:47,700 truncating revision to first 12 chars 2016-10-20 19:28:47,700 Setting DEBUG logging. 2016-10-20 19:28:47,700 attempt 1/10 2016-10-20 19:28:47,700 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/50dcca551b63?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 19:28:48,018 unpacking tar archive at: mozilla-inbound-50dcca551b63/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628306 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 19:28:47.949830) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 19:28:47.950872) ========= script_repo_revision: 50dcca551b63ee6e9b07207208d6cb1c239467af ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 19:28:47.951967) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 19:28:47.952660) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 19:28:47.964844) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-20 19:28:47.965178) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:28:48 INFO - MultiFileLogger online at 20161020 19:28:48 in /builds/slave/test 19:28:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 19:28:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:28:48 INFO - {'append_to_log': False, 19:28:48 INFO - 'base_work_dir': '/builds/slave/test', 19:28:48 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:28:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:28:48 INFO - 'branch': 'Mozilla-Inbound', 19:28:48 INFO - 'buildbot_json_path': 'buildprops.json', 19:28:48 INFO - 'config_files': ('talos/linux_config.py',), 19:28:48 INFO - 'default_actions': ('clobber', 19:28:48 INFO - 'read-buildbot-config', 19:28:48 INFO - 'download-and-extract', 19:28:48 INFO - 'populate-webroot', 19:28:48 INFO - 'create-virtualenv', 19:28:48 INFO - 'install', 19:28:48 INFO - 'run-tests'), 19:28:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:28:48 INFO - 'download_minidump_stackwalk': True, 19:28:48 INFO - 'download_symbols': 'ondemand', 19:28:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:28:48 INFO - 'tooltool.py': '/tools/tooltool.py', 19:28:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:28:48 INFO - '/tools/misc-python/virtualenv.py')}, 19:28:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:28:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:28:48 INFO - 'installer_path': 'installer.exe', 19:28:48 INFO - 'log_level': 'info', 19:28:48 INFO - 'log_name': 'talos', 19:28:48 INFO - 'log_to_console': True, 19:28:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:28:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:28:48 INFO - 'opt_config_files': (), 19:28:48 INFO - 'pip_index': False, 19:28:48 INFO - 'sps_profile': False, 19:28:48 INFO - 'sps_profile_interval': 0, 19:28:48 INFO - 'suite': 'dromaeojs-e10s', 19:28:48 INFO - 'system_bits': '32', 19:28:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:28:48 INFO - 'title': 'talos-linux64-ix-066', 19:28:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:28:48 INFO - 'use_talos_json': True, 19:28:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:28:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:28:48 INFO - 'work_dir': 'build'} 19:28:48 INFO - [mozharness: 2016-10-21 02:28:48.462240Z] Running clobber step. 19:28:48 INFO - Running pre-action listener: _resource_record_pre_action 19:28:48 INFO - Running main action method: clobber 19:28:48 INFO - rmtree: /builds/slave/test/build 19:28:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:28:48 INFO - Running post-action listener: _resource_record_post_action 19:28:48 INFO - [mozharness: 2016-10-21 02:28:48.949949Z] Finished clobber step (success) 19:28:48 INFO - [mozharness: 2016-10-21 02:28:48.950050Z] Running read-buildbot-config step. 19:28:48 INFO - Running pre-action listener: _resource_record_pre_action 19:28:48 INFO - Running main action method: read_buildbot_config 19:28:48 INFO - Using buildbot properties: 19:28:48 INFO - { 19:28:48 INFO - "project": "", 19:28:48 INFO - "product": "firefox", 19:28:48 INFO - "script_repo_revision": "production", 19:28:48 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 19:28:48 INFO - "repository": "", 19:28:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 19:28:48 INFO - "buildid": "20161020185753", 19:28:48 INFO - "stage_platform": "linux64-pgo", 19:28:48 INFO - "basedir": "/builds/slave/test", 19:28:48 INFO - "buildnumber": 1333, 19:28:48 INFO - "platform": "ubuntu64_hw", 19:28:48 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:28:48 INFO - "slavebuilddir": "test", 19:28:48 INFO - "branch": "mozilla-inbound", 19:28:48 INFO - "revision": "50dcca551b63ee6e9b07207208d6cb1c239467af", 19:28:48 INFO - "slavename": "talos-linux64-ix-066", 19:28:48 INFO - "builduid": "5fa1117a79414851806b0918776a6006", 19:28:48 INFO - "repo_path": "integration/mozilla-inbound" 19:28:48 INFO - } 19:28:48 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 19:28:48 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 19:28:48 INFO - Running post-action listener: _resource_record_post_action 19:28:48 INFO - [mozharness: 2016-10-21 02:28:48.953016Z] Finished read-buildbot-config step (success) 19:28:48 INFO - [mozharness: 2016-10-21 02:28:48.953102Z] Running download-and-extract step. 19:28:48 INFO - Running pre-action listener: _resource_record_pre_action 19:28:48 INFO - Running main action method: download_and_extract 19:28:48 INFO - mkdir: /builds/slave/test/build/tests 19:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:48 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:28:48 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/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 19:28:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/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 19:28:48 INFO - Downloaded 1361 bytes. 19:28:48 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:28:48 INFO - Using the following test package requirements: 19:28:48 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 19:28:48 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:28:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:28:48 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:28:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:28:48 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:28:48 INFO - u'jsshell-linux-x86_64.zip'], 19:28:48 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:28:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:28:48 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 19:28:48 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:28:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:28:48 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:28:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:28:48 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:28:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:28:48 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:28:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:28:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:28:48 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/1477002865/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 19:28:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:28:48 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:28:49 INFO - Http code: 200 19:28:49 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 19:28:49 INFO - x-amz-cf-id: pe7h7Iw1CHG4P9Uw7UvrmCUXzy5PWzRl9en0Wj6V6NF7OFhQUSPWFw== 19:28:49 INFO - x-amz-replication-status: COMPLETED 19:28:49 INFO - x-amz-version-id: QiZD6FIjaPwFqqakVrUmt7IXg5ozxCLh 19:28:49 INFO - Expected file size: 22119986 19:28:49 INFO - Obtained file size: 22119986 19:28:53 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 19:28:53 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/1477002865/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 19:28:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:28:53 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:28:53 INFO - Http code: 200 19:28:53 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 19:28:53 INFO - x-amz-cf-id: ofDk_yYgXszYonnmUHsqyhkdHi9AhUMT2K0jhWIahLZb0lp9-Jt0kA== 19:28:53 INFO - x-amz-replication-status: COMPLETED 19:28:53 INFO - x-amz-version-id: QiZD6FIjaPwFqqakVrUmt7IXg5ozxCLh 19:28:53 INFO - Expected file size: 22119986 19:28:53 INFO - Obtained file size: 22119986 19:28:58 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/1477002865/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 19:28:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:28:58 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 19:28:58 INFO - Http code: 200 19:28:58 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 19:28:58 INFO - x-amz-cf-id: XftPIik3rjjE4RrNb9Fk5UbyY8rpbvBvs20Wz57jvDrFPSBTtSOUTg== 19:28:58 INFO - x-amz-replication-status: COMPLETED 19:28:58 INFO - x-amz-version-id: Gg.jfKw8HO.TmQQBuK1O.FZFzxHeKj9I 19:28:58 INFO - Expected file size: 14409028 19:28:58 INFO - Obtained file size: 14409028 19:28:58 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')]} 19:28:58 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:28:58 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/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 19:28:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/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 19:28:59 INFO - Downloaded 59498339 bytes. 19:28:59 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:28:59 INFO - mkdir: /builds/slave/test/properties 19:28:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:28:59 INFO - Writing to file /builds/slave/test/properties/build_url 19:28:59 INFO - Contents: 19:28:59 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:29:00 INFO - Running post-action listener: _resource_record_post_action 19:29:00 INFO - Running post-action listener: set_extra_try_arguments 19:29:00 INFO - [mozharness: 2016-10-21 02:29:00.014245Z] Finished download-and-extract step (success) 19:29:00 INFO - [mozharness: 2016-10-21 02:29:00.014471Z] Running populate-webroot step. 19:29:00 INFO - Running pre-action listener: _resource_record_pre_action 19:29:00 INFO - Running main action method: populate_webroot 19:29:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:29:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:29:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:29:00 INFO - '--tppagecycles', 19:29:00 INFO - '7'], 19:29:00 INFO - 'tests': ['tsvgm']}}, 19:29:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:29:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:29:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:29:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:29:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:29:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:29:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:29:00 INFO - 'talos_options': ['--disable-e10s'], 19:29:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:29:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:29:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:29:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:29:00 INFO - 'talos_options': ['--disable-e10s'], 19:29:00 INFO - 'tests': ['damp', 'tps']}, 19:29:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:29:00 INFO - 'tests': ['damp', 'tps']}, 19:29:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:29:00 INFO - 'tests': ['dromaeo_dom']}, 19:29:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:29:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:29:00 INFO - 'tests': ['basic_compositor_video']}, 19:29:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:29:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:29:00 INFO - 'tests': ['a11yr', 19:29:00 INFO - 'ts_paint', 19:29:00 INFO - 'tpaint', 19:29:00 INFO - 'sessionrestore', 19:29:00 INFO - 'sessionrestore_no_auto_restore', 19:29:00 INFO - 'tabpaint']}, 19:29:00 INFO - 'other-e10s': {'tests': ['a11yr', 19:29:00 INFO - 'ts_paint', 19:29:00 INFO - 'tpaint', 19:29:00 INFO - 'sessionrestore', 19:29:00 INFO - 'sessionrestore_no_auto_restore', 19:29:00 INFO - 'tabpaint']}, 19:29:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:29:00 INFO - 'ts_paint', 19:29:00 INFO - 'tpaint', 19:29:00 INFO - 'sessionrestore', 19:29:00 INFO - 'sessionrestore_no_auto_restore', 19:29:00 INFO - 'tabpaint']}, 19:29:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:29:00 INFO - 'ts_paint', 19:29:00 INFO - 'tpaint', 19:29:00 INFO - 'sessionrestore', 19:29:00 INFO - 'sessionrestore_no_auto_restore', 19:29:00 INFO - 'tabpaint']}, 19:29:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:29:00 INFO - 'tests': ['a11yr', 19:29:00 INFO - 'ts_paint', 19:29:00 INFO - 'tpaint', 19:29:00 INFO - 'sessionrestore', 19:29:00 INFO - 'sessionrestore_no_auto_restore', 19:29:00 INFO - 'tabpaint']}, 19:29:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:29:00 INFO - 'tests': ['a11yr', 19:29:00 INFO - 'ts_paint', 19:29:00 INFO - 'tpaint', 19:29:00 INFO - 'sessionrestore', 19:29:00 INFO - 'sessionrestore_no_auto_restore', 19:29:00 INFO - 'tabpaint']}, 19:29:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:29:00 INFO - 'tests': ['tsvgx', 19:29:00 INFO - 'tsvgr_opacity', 19:29:00 INFO - 'tart', 19:29:00 INFO - 'tscrollx', 19:29:00 INFO - 'cart']}, 19:29:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:29:00 INFO - 'tsvgr_opacity', 19:29:00 INFO - 'tart', 19:29:00 INFO - 'tscrollx', 19:29:00 INFO - 'cart']}, 19:29:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:29:00 INFO - 'talos_options': ['--disable-e10s'], 19:29:00 INFO - 'tests': ['tp5o']}, 19:29:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:29:00 INFO - 'tests': ['tp5o']}, 19:29:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:29:00 INFO - 'talos_options': ['--disable-e10s', 19:29:00 INFO - '--xperf_path', 19:29:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:29:00 INFO - 'tests': ['tp5n']}, 19:29:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:29:00 INFO - 'talos_options': ['--xperf_path', 19:29:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:29:00 INFO - 'tests': ['tp5n']}}, 19:29:00 INFO - 'talos.zip': {'path': '', 19:29:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:29:00 INFO - Running post-action listener: _resource_record_post_action 19:29:00 INFO - [mozharness: 2016-10-21 02:29:00.033544Z] Finished populate-webroot step (success) 19:29:00 INFO - [mozharness: 2016-10-21 02:29:00.033632Z] Running create-virtualenv step. 19:29:00 INFO - Running pre-action listener: _resource_record_pre_action 19:29:00 INFO - Running main action method: create_virtualenv 19:29:00 INFO - Creating virtualenv /builds/slave/test/build/venv 19:29:00 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 19:29:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:29:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:29:00 INFO - Using real prefix '/usr' 19:29:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:29:00 INFO - Installing distribute.............................................................................................................................................................................................done. 19:29:02 INFO - Installing pip.................done. 19:29:02 INFO - Return code: 0 19:29:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:29:02 INFO - Reading from file tmpfile_stdout 19:29:02 INFO - Output received: 19:29:02 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) 19:29:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:02 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 0x7f3a9d7f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1670f60>, '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 0x1671d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16721d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', '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 19:29:02 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 19:29:02 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 19:29:02 INFO - Using env: {'DISPLAY': ':0', 19:29:02 INFO - 'HOME': '/home/cltbld', 19:29:02 INFO - 'LANG': 'en_US.UTF-8', 19:29:02 INFO - 'LANGUAGE': 'en_US:en', 19:29:02 INFO - 'LOGNAME': 'cltbld', 19:29:02 INFO - 'MAIL': '/var/mail/cltbld', 19:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:29:02 INFO - 'MOZ_NO_REMOTE': '1', 19:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:29:02 INFO - 'NO_EM_RESTART': '1', 19:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:29:02 INFO - 'PWD': '/builds/slave/test', 19:29:02 INFO - 'SHELL': '/bin/bash', 19:29:02 INFO - 'SHLVL': '1', 19:29:02 INFO - 'TERM': 'linux', 19:29:02 INFO - 'TMOUT': '86400', 19:29:02 INFO - 'USER': 'cltbld', 19:29:02 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', 19:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:29:02 INFO - '_': '/tools/buildbot/bin/python'} 19:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:29:03 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 19:29:03 INFO - Cleaning up... 19:29:03 INFO - Return code: 0 19:29:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:29:03 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')]} 19:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:29:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:03 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')]} 19:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:29:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:03 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 0x7f3a9d7f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1670f60>, '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 0x1671d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16721d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', '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 19:29:03 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 19:29:03 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 19:29:03 INFO - Using env: {'DISPLAY': ':0', 19:29:03 INFO - 'HOME': '/home/cltbld', 19:29:03 INFO - 'LANG': 'en_US.UTF-8', 19:29:03 INFO - 'LANGUAGE': 'en_US:en', 19:29:03 INFO - 'LOGNAME': 'cltbld', 19:29:03 INFO - 'MAIL': '/var/mail/cltbld', 19:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:29:03 INFO - 'MOZ_NO_REMOTE': '1', 19:29:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:29:03 INFO - 'NO_EM_RESTART': '1', 19:29:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:29:03 INFO - 'PWD': '/builds/slave/test', 19:29:03 INFO - 'SHELL': '/bin/bash', 19:29:03 INFO - 'SHLVL': '1', 19:29:03 INFO - 'TERM': 'linux', 19:29:03 INFO - 'TMOUT': '86400', 19:29:03 INFO - 'USER': 'cltbld', 19:29:03 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', 19:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:29:03 INFO - '_': '/tools/buildbot/bin/python'} 19:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:29:03 INFO - Downloading/unpacking psutil>=3.1.1 19:29:03 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 19:29:03 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 19:29:03 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 19:29:03 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 19:29:03 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 19:29:03 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 19:29:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:29:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:29:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:29:05 INFO - Installing collected packages: psutil 19:29:05 INFO - Running setup.py install for psutil 19:29:05 INFO - building 'psutil._psutil_linux' extension 19:29:05 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 19:29:05 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 19:29:05 INFO - building 'psutil._psutil_posix' extension 19:29:05 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 19:29:05 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 19:29:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:29:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:29:05 INFO - Successfully installed psutil 19:29:05 INFO - Cleaning up... 19:29:05 INFO - Return code: 0 19:29:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:29:05 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')]} 19:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:29:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:05 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')]} 19:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:29:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:05 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 0x7f3a9d7f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1670f60>, '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 0x1671d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16721d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', '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 19:29:05 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 19:29:05 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 19:29:05 INFO - Using env: {'DISPLAY': ':0', 19:29:05 INFO - 'HOME': '/home/cltbld', 19:29:05 INFO - 'LANG': 'en_US.UTF-8', 19:29:05 INFO - 'LANGUAGE': 'en_US:en', 19:29:05 INFO - 'LOGNAME': 'cltbld', 19:29:05 INFO - 'MAIL': '/var/mail/cltbld', 19:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:29:05 INFO - 'MOZ_NO_REMOTE': '1', 19:29:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:29:05 INFO - 'NO_EM_RESTART': '1', 19:29:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:29:05 INFO - 'PWD': '/builds/slave/test', 19:29:05 INFO - 'SHELL': '/bin/bash', 19:29:05 INFO - 'SHLVL': '1', 19:29:05 INFO - 'TERM': 'linux', 19:29:05 INFO - 'TMOUT': '86400', 19:29:05 INFO - 'USER': 'cltbld', 19:29:05 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', 19:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:29:05 INFO - '_': '/tools/buildbot/bin/python'} 19:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:29:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:29:06 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 19:29:06 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 19:29:06 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 19:29:06 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 19:29:06 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 19:29:06 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 19:29:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:29:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:29:08 INFO - Installing collected packages: mozsystemmonitor 19:29:08 INFO - Running setup.py install for mozsystemmonitor 19:29:08 INFO - Successfully installed mozsystemmonitor 19:29:08 INFO - Cleaning up... 19:29:08 INFO - Return code: 0 19:29:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:29:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:29:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a9d7f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1670f60>, '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 0x1671d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16721d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', '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 19:29:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:29:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:29:08 INFO - Using env: {'DISPLAY': ':0', 19:29:08 INFO - 'HOME': '/home/cltbld', 19:29:08 INFO - 'LANG': 'en_US.UTF-8', 19:29:08 INFO - 'LANGUAGE': 'en_US:en', 19:29:08 INFO - 'LOGNAME': 'cltbld', 19:29:08 INFO - 'MAIL': '/var/mail/cltbld', 19:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:29:08 INFO - 'MOZ_NO_REMOTE': '1', 19:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:29:08 INFO - 'NO_EM_RESTART': '1', 19:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:29:08 INFO - 'PWD': '/builds/slave/test', 19:29:08 INFO - 'SHELL': '/bin/bash', 19:29:08 INFO - 'SHLVL': '1', 19:29:08 INFO - 'TERM': 'linux', 19:29:08 INFO - 'TMOUT': '86400', 19:29:08 INFO - 'USER': 'cltbld', 19:29:08 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', 19:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:29:08 INFO - '_': '/tools/buildbot/bin/python'} 19:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:29:08 INFO - Downloading/unpacking jsonschema==2.5.1 19:29:08 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 19:29:08 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 19:29:08 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 19:29:08 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 19:29:08 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 19:29:08 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 19:29:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:29:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:29:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:29:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:29:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:29:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:29:10 INFO - Downloading functools32-3.2.3-2.tar.gz 19:29:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:29:10 INFO - warning: no files found matching '*.txt' 19:29:10 INFO - no previously-included directories found matching 'build' 19:29:10 INFO - no previously-included directories found matching 'dist' 19:29:10 INFO - no previously-included directories found matching '.git*' 19:29:10 INFO - Installing collected packages: jsonschema, functools32 19:29:10 INFO - Running setup.py install for functools32 19:29:10 INFO - warning: no files found matching '*.txt' 19:29:10 INFO - no previously-included directories found matching 'build' 19:29:10 INFO - no previously-included directories found matching 'dist' 19:29:10 INFO - no previously-included directories found matching '.git*' 19:29:10 INFO - Successfully installed jsonschema functools32 19:29:10 INFO - Cleaning up... 19:29:10 INFO - Return code: 0 19:29:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:29:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:29:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3a9d7f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1670f60>, '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 0x1671d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16721d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', '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 19:29:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:29:10 INFO - Using env: {'DISPLAY': ':0', 19:29:10 INFO - 'HOME': '/home/cltbld', 19:29:10 INFO - 'LANG': 'en_US.UTF-8', 19:29:10 INFO - 'LANGUAGE': 'en_US:en', 19:29:10 INFO - 'LOGNAME': 'cltbld', 19:29:10 INFO - 'MAIL': '/var/mail/cltbld', 19:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:29:10 INFO - 'MOZ_NO_REMOTE': '1', 19:29:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:29:10 INFO - 'NO_EM_RESTART': '1', 19:29:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:29:10 INFO - 'PWD': '/builds/slave/test', 19:29:10 INFO - 'SHELL': '/bin/bash', 19:29:10 INFO - 'SHLVL': '1', 19:29:10 INFO - 'TERM': 'linux', 19:29:10 INFO - 'TMOUT': '86400', 19:29:10 INFO - 'USER': 'cltbld', 19:29:10 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', 19:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:29:10 INFO - '_': '/tools/buildbot/bin/python'} 19:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:29:11 INFO - Cleaning up... 19:29:11 INFO - Return code: 0 19:29:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:29:11 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')]} 19:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:11 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')]} 19:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:11 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 0x7f3a9d7f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1670f60>, '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 0x1671d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16721d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', '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 19:29:11 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 19:29:11 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 19:29:11 INFO - Using env: {'DISPLAY': ':0', 19:29:11 INFO - 'HOME': '/home/cltbld', 19:29:11 INFO - 'LANG': 'en_US.UTF-8', 19:29:11 INFO - 'LANGUAGE': 'en_US:en', 19:29:11 INFO - 'LOGNAME': 'cltbld', 19:29:11 INFO - 'MAIL': '/var/mail/cltbld', 19:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:29:11 INFO - 'MOZ_NO_REMOTE': '1', 19:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:29:11 INFO - 'NO_EM_RESTART': '1', 19:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:29:11 INFO - 'PWD': '/builds/slave/test', 19:29:11 INFO - 'SHELL': '/bin/bash', 19:29:11 INFO - 'SHLVL': '1', 19:29:11 INFO - 'TERM': 'linux', 19:29:11 INFO - 'TMOUT': '86400', 19:29:11 INFO - 'USER': 'cltbld', 19:29:11 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', 19:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:29:11 INFO - '_': '/tools/buildbot/bin/python'} 19:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:29:11 INFO - Downloading/unpacking blobuploader==1.2.4 19:29:11 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 19:29:11 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 19:29:11 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 19:29:11 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 19:29:11 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 19:29:11 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 19:29:13 INFO - Downloading blobuploader-1.2.4.tar.gz 19:29:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:29:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:29:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:29:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:29:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:29:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:29:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:29:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:29:13 INFO - Downloading docopt-0.6.1.tar.gz 19:29:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:29:13 INFO - Installing collected packages: blobuploader, requests, docopt 19:29:13 INFO - Running setup.py install for blobuploader 19:29:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:29:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:29:14 INFO - Running setup.py install for requests 19:29:14 INFO - Running setup.py install for docopt 19:29:14 INFO - Successfully installed blobuploader requests docopt 19:29:14 INFO - Cleaning up... 19:29:14 INFO - Return code: 0 19:29:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:29: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')]} 19:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:29:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29: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')]} 19:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:29:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:14 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 0x7f3a9d7f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1670f60>, '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 0x1671d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16721d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', '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 19:29:14 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 19:29:14 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 19:29:14 INFO - Using env: {'DISPLAY': ':0', 19:29:14 INFO - 'HOME': '/home/cltbld', 19:29:14 INFO - 'LANG': 'en_US.UTF-8', 19:29:14 INFO - 'LANGUAGE': 'en_US:en', 19:29:14 INFO - 'LOGNAME': 'cltbld', 19:29:14 INFO - 'MAIL': '/var/mail/cltbld', 19:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:29:14 INFO - 'MOZ_NO_REMOTE': '1', 19:29:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:29:14 INFO - 'NO_EM_RESTART': '1', 19:29:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:29:14 INFO - 'PWD': '/builds/slave/test', 19:29:14 INFO - 'SHELL': '/bin/bash', 19:29:14 INFO - 'SHLVL': '1', 19:29:14 INFO - 'TERM': 'linux', 19:29:14 INFO - 'TMOUT': '86400', 19:29:14 INFO - 'USER': 'cltbld', 19:29:14 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', 19:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:29:14 INFO - '_': '/tools/buildbot/bin/python'} 19:29:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:29:14 INFO - Running setup.py (path:/tmp/pip-ddhKAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:29:14 INFO - Running setup.py (path:/tmp/pip-oie_bF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:29:14 INFO - Running setup.py (path:/tmp/pip-hdTRH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:29:15 INFO - Running setup.py (path:/tmp/pip-6Tuawd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:29:15 INFO - Running setup.py (path:/tmp/pip-5ZoTQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:29:15 INFO - Running setup.py (path:/tmp/pip-pTR9br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:29:15 INFO - Running setup.py (path:/tmp/pip-gWeEKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:29:15 INFO - Running setup.py (path:/tmp/pip-IquoEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:29:15 INFO - Running setup.py (path:/tmp/pip-S2KKm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:29:15 INFO - Running setup.py (path:/tmp/pip-TD7DQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:29:15 INFO - Running setup.py (path:/tmp/pip-N3iSMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:29:15 INFO - Running setup.py (path:/tmp/pip-92AGR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:29:15 INFO - Running setup.py (path:/tmp/pip-K9qitt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:29:15 INFO - Running setup.py (path:/tmp/pip-dZNYmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:29:15 INFO - Running setup.py (path:/tmp/pip-TI7Q1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:29:15 INFO - Running setup.py (path:/tmp/pip-ESvnTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:29:15 INFO - Running setup.py (path:/tmp/pip-uG6As7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:29:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:29:16 INFO - Running setup.py install for manifestparser 19:29:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:29:16 INFO - Running setup.py install for mozcrash 19:29:16 INFO - Running setup.py install for mozdebug 19:29:16 INFO - Running setup.py install for mozdevice 19:29:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:29:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:29:16 INFO - Running setup.py install for mozfile 19:29:16 INFO - Running setup.py install for mozhttpd 19:29:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:29:16 INFO - Running setup.py install for mozinfo 19:29:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:29:16 INFO - Running setup.py install for mozInstall 19:29:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:29:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:29:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:29:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:29:16 INFO - Running setup.py install for mozleak 19:29:16 INFO - Running setup.py install for mozlog 19:29:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:29:17 INFO - Running setup.py install for moznetwork 19:29:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:29:17 INFO - Running setup.py install for mozprocess 19:29:17 INFO - Running setup.py install for mozprofile 19:29:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:29:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:29:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:29:17 INFO - Running setup.py install for mozrunner 19:29:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:29:17 INFO - Running setup.py install for mozscreenshot 19:29:17 INFO - Running setup.py install for moztest 19:29:17 INFO - Running setup.py install for mozversion 19:29:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:29:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:29:17 INFO - Cleaning up... 19:29:17 INFO - Return code: 0 19:29:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:17 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 0x7f3a9d7f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1670f60>, '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 0x1671d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16721d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', '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 19:29:17 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 19:29:17 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 19:29:17 INFO - Using env: {'DISPLAY': ':0', 19:29:17 INFO - 'HOME': '/home/cltbld', 19:29:17 INFO - 'LANG': 'en_US.UTF-8', 19:29:17 INFO - 'LANGUAGE': 'en_US:en', 19:29:17 INFO - 'LOGNAME': 'cltbld', 19:29:17 INFO - 'MAIL': '/var/mail/cltbld', 19:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:29:17 INFO - 'MOZ_NO_REMOTE': '1', 19:29:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:29:17 INFO - 'NO_EM_RESTART': '1', 19:29:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:29:17 INFO - 'PWD': '/builds/slave/test', 19:29:17 INFO - 'SHELL': '/bin/bash', 19:29:17 INFO - 'SHLVL': '1', 19:29:17 INFO - 'TERM': 'linux', 19:29:17 INFO - 'TMOUT': '86400', 19:29:17 INFO - 'USER': 'cltbld', 19:29:17 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', 19:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:29:17 INFO - '_': '/tools/buildbot/bin/python'} 19:29:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:29:18 INFO - Running setup.py (path:/tmp/pip-qDcMwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:29:18 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)) 19:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:29:18 INFO - Running setup.py (path:/tmp/pip-sbY3uJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:29:18 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)) 19:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:29:18 INFO - Running setup.py (path:/tmp/pip-pjcjXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:29:18 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)) 19:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:29:18 INFO - Running setup.py (path:/tmp/pip-PKDaCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:29:18 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)) 19:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:29:18 INFO - Running setup.py (path:/tmp/pip-2BdubT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:29:18 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)) 19:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:29:18 INFO - Running setup.py (path:/tmp/pip-hrlqFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:29:18 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)) 19:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:29:18 INFO - Running setup.py (path:/tmp/pip-iqEZsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:29:18 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)) 19:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:29:18 INFO - Running setup.py (path:/tmp/pip-FiRgSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:29:18 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)) 19:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:29:18 INFO - Running setup.py (path:/tmp/pip-eikCZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:29:18 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)) 19:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:29:18 INFO - Running setup.py (path:/tmp/pip-tZ_ayY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:29:18 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)) 19:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:29:18 INFO - Running setup.py (path:/tmp/pip-EJMou9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:29:18 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)) 19:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:29:18 INFO - Running setup.py (path:/tmp/pip-1qTNOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:29:18 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)) 19:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:29:18 INFO - Running setup.py (path:/tmp/pip-D6GamZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:29:19 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)) 19:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:29:19 INFO - Running setup.py (path:/tmp/pip-OQme2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:29:19 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)) 19:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:29:19 INFO - Running setup.py (path:/tmp/pip-J2zcSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:29:19 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)) 19:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:29:19 INFO - Running setup.py (path:/tmp/pip-NNuyAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:29:19 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)) 19:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:29:19 INFO - Running setup.py (path:/tmp/pip-K7QtHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:29:19 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)) 19:29:19 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)) 19:29:19 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)) 19:29:19 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)) 19:29:19 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)) 19:29:19 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)) 19:29:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:29:19 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 19:29:19 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 19:29:19 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 19:29:19 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 19:29:19 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 19:29:19 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 19:29:21 INFO - Downloading blessings-1.6.tar.gz 19:29:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:29:21 INFO - Installing collected packages: blessings 19:29:21 INFO - Running setup.py install for blessings 19:29:21 INFO - Successfully installed blessings 19:29:21 INFO - Cleaning up... 19:29:21 INFO - Return code: 0 19:29:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:29:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:29:21 INFO - Reading from file tmpfile_stdout 19:29:21 INFO - Current package versions: 19:29:21 INFO - argparse == 1.2.1 19:29:21 INFO - blessings == 1.6 19:29:21 INFO - blobuploader == 1.2.4 19:29:21 INFO - docopt == 0.6.1 19:29:21 INFO - functools32 == 3.2.3-2 19:29:21 INFO - jsonschema == 2.5.1 19:29:21 INFO - manifestparser == 1.1 19:29:21 INFO - mozInstall == 1.12 19:29:21 INFO - mozcrash == 0.17 19:29:21 INFO - mozdebug == 0.1 19:29:21 INFO - mozdevice == 0.48 19:29:21 INFO - mozfile == 1.2 19:29:21 INFO - mozhttpd == 0.7 19:29:21 INFO - mozinfo == 0.9 19:29:21 INFO - mozleak == 0.1 19:29:21 INFO - mozlog == 3.4 19:29:21 INFO - moznetwork == 0.27 19:29:21 INFO - mozprocess == 0.23 19:29:21 INFO - mozprofile == 0.28 19:29:21 INFO - mozrunner == 6.12 19:29:21 INFO - mozscreenshot == 0.1 19:29:21 INFO - mozsystemmonitor == 0.3 19:29:21 INFO - moztest == 0.7 19:29:21 INFO - mozversion == 1.4 19:29:21 INFO - psutil == 3.1.1 19:29:21 INFO - requests == 1.2.3 19:29:21 INFO - wsgiref == 0.1.2 19:29:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:29:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:29:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:21 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 0x7f3a9d7f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1670f60>, '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 0x1671d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16721d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', '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 19:29:21 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 19:29:21 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 19:29:21 INFO - Using env: {'DISPLAY': ':0', 19:29:21 INFO - 'HOME': '/home/cltbld', 19:29:21 INFO - 'LANG': 'en_US.UTF-8', 19:29:21 INFO - 'LANGUAGE': 'en_US:en', 19:29:21 INFO - 'LOGNAME': 'cltbld', 19:29:21 INFO - 'MAIL': '/var/mail/cltbld', 19:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:29:21 INFO - 'MOZ_NO_REMOTE': '1', 19:29:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:29:21 INFO - 'NO_EM_RESTART': '1', 19:29:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:29:21 INFO - 'PWD': '/builds/slave/test', 19:29:21 INFO - 'SHELL': '/bin/bash', 19:29:21 INFO - 'SHLVL': '1', 19:29:21 INFO - 'TERM': 'linux', 19:29:21 INFO - 'TMOUT': '86400', 19:29:21 INFO - 'USER': 'cltbld', 19:29:21 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', 19:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:29:21 INFO - '_': '/tools/buildbot/bin/python'} 19:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:29:21 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)) 19:29:21 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)) 19:29:21 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)) 19:29:21 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)) 19:29:21 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)) 19:29:21 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)) 19:29:21 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)) 19:29:21 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)) 19:29:21 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)) 19:29:21 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)) 19:29:21 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)) 19:29:21 INFO - Cleaning up... 19:29:21 INFO - Return code: 0 19:29:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:29:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:29:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:21 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 0x7f3a9d7f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1670f60>, '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 0x1671d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16721d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', '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 19:29:21 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 19:29:21 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 19:29:21 INFO - Using env: {'DISPLAY': ':0', 19:29:21 INFO - 'HOME': '/home/cltbld', 19:29:21 INFO - 'LANG': 'en_US.UTF-8', 19:29:21 INFO - 'LANGUAGE': 'en_US:en', 19:29:21 INFO - 'LOGNAME': 'cltbld', 19:29:21 INFO - 'MAIL': '/var/mail/cltbld', 19:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:29:21 INFO - 'MOZ_NO_REMOTE': '1', 19:29:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:29:21 INFO - 'NO_EM_RESTART': '1', 19:29:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:29:21 INFO - 'PWD': '/builds/slave/test', 19:29:21 INFO - 'SHELL': '/bin/bash', 19:29:21 INFO - 'SHLVL': '1', 19:29:21 INFO - 'TERM': 'linux', 19:29:21 INFO - 'TMOUT': '86400', 19:29:21 INFO - 'USER': 'cltbld', 19:29:21 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', 19:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:29:21 INFO - '_': '/tools/buildbot/bin/python'} 19:29:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:29:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:29:22 INFO - Cleaning up... 19:29:22 INFO - Return code: 0 19:29:22 INFO - Running post-action listener: _resource_record_post_action 19:29:22 INFO - Running post-action listener: _start_resource_monitoring 19:29:22 INFO - Starting resource monitoring. 19:29:22 INFO - [mozharness: 2016-10-21 02:29:22.181024Z] Finished create-virtualenv step (success) 19:29:22 INFO - [mozharness: 2016-10-21 02:29:22.181488Z] Running install step. 19:29:22 INFO - Running pre-action listener: _resource_record_pre_action 19:29:22 INFO - Running main action method: install 19:29:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:29:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:29:22 INFO - Reading from file tmpfile_stdout 19:29:22 INFO - Detecting whether we're running mozinstall >=1.0... 19:29:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:29:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:29:22 INFO - Reading from file tmpfile_stdout 19:29:22 INFO - Output received: 19:29:22 INFO - Usage: mozinstall [options] installer 19:29:22 INFO - Options: 19:29:22 INFO - -h, --help show this help message and exit 19:29:22 INFO - -d DEST, --destination=DEST 19:29:22 INFO - Directory to install application into. [default: 19:29:22 INFO - "/builds/slave/test"] 19:29:22 INFO - --app=APP Application being installed. [default: firefox] 19:29:22 INFO - mkdir: /builds/slave/test/build/application 19:29:22 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'] 19:29:22 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 19:29:39 INFO - Reading from file tmpfile_stdout 19:29:39 INFO - Output received: 19:29:39 INFO - /builds/slave/test/build/application/firefox/firefox 19:29:39 INFO - Running post-action listener: _resource_record_post_action 19:29:39 INFO - [mozharness: 2016-10-21 02:29:39.408216Z] Finished install step (success) 19:29:39 INFO - [mozharness: 2016-10-21 02:29:39.408487Z] Running run-tests step. 19:29:39 INFO - Running pre-action listener: _resource_record_pre_action 19:29:39 INFO - Running main action method: run_tests 19:29:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:29:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:29:39 INFO - Python 2.7.3 19:29:39 INFO - Return code: 0 19:29:39 INFO - grabbing minidump binary from tooltool 19:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:29:39 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 0x1670f60>, '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 0x1671d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16721d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:29:39 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 19:29:39 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 19:29:39 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 19:29:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:29:39 INFO - Return code: 0 19:29:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:29:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:29:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:29:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:29:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:29:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:29:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:29:39 INFO - Using env: {'DISPLAY': ':0', 19:29:39 INFO - 'HOME': '/home/cltbld', 19:29:39 INFO - 'LANG': 'en_US.UTF-8', 19:29:39 INFO - 'LANGUAGE': 'en_US:en', 19:29:39 INFO - 'LOGNAME': 'cltbld', 19:29:39 INFO - 'MAIL': '/var/mail/cltbld', 19:29:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:29:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:29:39 INFO - 'MOZ_NO_REMOTE': '1', 19:29:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:29:39 INFO - 'NO_EM_RESTART': '1', 19:29:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:29:39 INFO - 'PWD': '/builds/slave/test', 19:29:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:29:39 INFO - 'SHELL': '/bin/bash', 19:29:39 INFO - 'SHLVL': '1', 19:29:39 INFO - 'TERM': 'linux', 19:29:39 INFO - 'TMOUT': '86400', 19:29:39 INFO - 'USER': 'cltbld', 19:29:39 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908', 19:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:29:39 INFO - '_': '/tools/buildbot/bin/python'} 19:29:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:29:39 INFO - mozversion application_buildid: 20161020153425 19:29:39 INFO - mozversion application_changeset: 50dcca551b63ee6e9b07207208d6cb1c239467af 19:29:39 INFO - mozversion application_display_name: Nightly 19:29:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:29:39 INFO - mozversion application_name: Firefox 19:29:39 INFO - mozversion application_remotingname: firefox 19:29:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:29:39 INFO - mozversion application_vendor: Mozilla 19:29:39 INFO - mozversion application_version: 52.0a1 19:29:39 INFO - mozversion platform_buildid: 20161020153425 19:29:39 INFO - mozversion platform_changeset: 50dcca551b63ee6e9b07207208d6cb1c239467af 19:29:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:29:39 INFO - mozversion platform_version: 52.0a1 19:29:39 INFO - using testdate: 1477016979 19:29:39 INFO - actual date: 1477016979 19:29:39 INFO - starting webserver on 'localhost:52367' 19:29:39 INFO - SUITE-START | Running 2 tests 19:29:39 INFO - TEST-START | dromaeo_css 19:29:39 INFO - operating with platform_type : linux_ 19:29:39 INFO - Initialising browser for dromaeo_css test... 19:29:39 INFO - TEST-INFO | started process 11342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHmeg4_/profile http://localhost:52367/getInfo.html) 19:29:44 INFO - PROCESS | 11342 | __metrics Screen width/height:1600/1200 19:29:44 INFO - PROCESS | 11342 | colorDepth:24 19:29:44 INFO - PROCESS | 11342 | Browser inner width/height: 1024/697 19:29:44 INFO - PROCESS | 11342 | __metrics 19:29:45 ERROR - PROCESS | 11342 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 19:29:46 INFO - TEST-INFO | 11342: exit 0 19:29:46 INFO - Browser initialized. 19:29:46 INFO - Running cycle 1/1 for dromaeo_css test... 19:29:46 INFO - TEST-INFO | started process 11467 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHmeg4_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:29:58 INFO - PROCESS | 11467 | RSS: Main: 182386688 19:29:58 INFO - PROCESS | 11467 | 19:30:47 INFO - PROCESS | 11467 | 1477017047989 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] 19:32:59 INFO - PROCESS | 11467 | Cycle 1(1): loaded http://localhost:52367/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52367/tests/dromaeo/cssquery-ext.html) 19:33:00 INFO - PROCESS | 11467 | RSS: Main: 195842048 19:33:00 INFO - PROCESS | 11467 | 19:36:03 INFO - PROCESS | 11467 | Cycle 1(1): loaded http://localhost:52367/tests/dromaeo/cssquery-ext.html (next: http://localhost:52367/tests/dromaeo/cssquery-jquery.html) 19:36:03 INFO - PROCESS | 11467 | RSS: Main: 194506752 19:36:03 INFO - PROCESS | 11467 | 19:39:05 INFO - PROCESS | 11467 | Cycle 1(1): loaded http://localhost:52367/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52367/tests/dromaeo/cssquery-mootools.html) 19:39:06 INFO - PROCESS | 11467 | RSS: Main: 195993600 19:39:06 INFO - PROCESS | 11467 | 19:42:08 INFO - PROCESS | 11467 | Cycle 1(1): loaded http://localhost:52367/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52367/tests/dromaeo/cssquery-prototype.html) 19:42:08 INFO - PROCESS | 11467 | RSS: Main: 193204224 19:42:08 INFO - PROCESS | 11467 | 19:45:11 INFO - PROCESS | 11467 | Cycle 1(1): loaded http://localhost:52367/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52367/tests/dromaeo/cssquery-yui.html) 19:45:12 INFO - PROCESS | 11467 | RSS: Main: 196550656 19:45:12 INFO - PROCESS | 11467 | 19:48:15 INFO - PROCESS | 11467 | Cycle 1(1): loaded http://localhost:52367/tests/dromaeo/cssquery-yui.html (next: http://localhost:52367/tests/dromaeo/cssquery-dojo.html) 19:48:15 INFO - PROCESS | 11467 | RSS: Main: 196026368 19:48:15 INFO - PROCESS | 11467 | 19:48:15 INFO - PROCESS | 11467 | __start_tp_report 19:48:15 INFO - PROCESS | 11467 | _x_x_mozilla_page_load 19:48:15 INFO - PROCESS | 11467 | _x_x_mozilla_page_load_details 19:48:15 INFO - PROCESS | 11467 | |i|pagename|runs| 19:48:15 INFO - PROCESS | 11467 | |0;dojo.html;3150.747940164787;3162.193640621641;3179.8887038953635;3198.680131986802;3206.182423482012;5262.526372626463;5490.945090549093;5493;5529.198266251391;5579.832605021846;5303.018941495826;5420.349558053039;5517.034518959176;5557.3886872444;5587.608867379285;4828.830990915319;4849.054434385296;4921.557059864612;4960.851174464772;5017.147084995559;4756;4925.433575138851;4989.925151122736;5008.499150084981;5057.544820966113;4816.662833601649;4831.855044348676;4896.681715688469;4912.778924948386;4935.383077115361;4850.733209673466;4880.463149053601;4891.779869905863;4947.653664243504;4964.900701985976;4823.300621409876;4837.492063333335;4848.296996935424;4865.41615006198;4898.118338699032;5248.475152484759;5272;5295.232191332274;5368.570514358842;5478;5749.3963133871175;5841.357450680422;5870.823875283749;5886.411358864122;5960.195373624549;5901.586888917777;5939.524838012949;5941.1088336749835;5954.255718035246;5960.552958528127;5266.131088370453;5544;5551.167324901297;5569.721513924328;5573.470520300605;5749.425057494301;5910.290765108214;5948.226730525004;5958;6056.152138700585;5710.685912274782;5750.1949727038245;5752.798652047159;5756.1653560233535;5760.0783874579865;5651.095824668033;5772.278465191851;5816.302043754777;5840.707964601753;5851.063829787214;5641.238432811518;5857.7949771757785;5954.166416701665;5960.672163031075;5962.284525856925;5924.763009479659;5927.1405646181065;5932;5932.851678707981;5939.4357536034;4511.3458548510935;4513.842015529441;4521.231390663529;4522.479914809774;4584.61030812378;3908.9609103909165;3927.23418933311;3943.290207762573;3951.1702542466405;3953.426753120839;5487.890242195133;5523.917141242885;5534.446555344433;5549.667019978814;5553;5798.9420105799245;5849.181114643953;5854.824355269348;5858.794942177004;5862.296524417097;5309.070912590281;5428.8099916503525;5488.039593071197;5494.917576236359;5571.749271282802;5043.167877300204;5057.494250574987;5072.847814565569;5088.109580823341;5099.821506247337;6021.42796434338;6036.939630603725;6040.244969378828;6047.848803779941;6078.726457309432;5561.555075593862;5620.8875822482505;5626.071698169756;5871;5924.555658325729;5842.737076831638;5860.267466566679;5873.676947767914;5912.852178695395;5914.763409463745;5580.720963951705;5620.269364982526;5624.887502250014;5638.85902852432;5655.066913959316;5706.087026075808;5732.59871808986;5742.540596752333;5748.540116790563;5748.54011679073;5594.748236329457;5608.691521966168;5613.438656134354;5614.438556144353;5616.747246373841;5583.218349431002;5669.036263835075;5683.545316374597;5690.118031705092;5750.568707347049;5578.553715702815;5627.099664053731;5686.57350698691;5743.885122297447;5797.652140871562;5795.478406943395;5824.854378640568;5825.883482330414;5827.650340979555;5861.7655293787775;5373.167159090347;5425.565954723692;5459.508644222039;5485.945140548543;5705.400932902152 19:48:15 INFO - PROCESS | 11467 | |1;ext.html;554.5587995433046;573.4867293772074;586.0769288370817;590.6515156057927;598.1446531460011;41400.58599414005;42075.99999999996;42102.36846447302;45330.773346133305;45339.31991020129;43216.56783432165;43320;43590;43619.12761744763;43811.561884381146;8665.740027799176;8806.559672016405;8813.42712723671;8837.160469755363;8849.380543361967;8709.608067636971;8743.12568743127;8743.256823170039;8786.560671966376;8838.602262898185;8760.518171500566;8861.955690221539;8864.73405797827;8907.599158037872;8913.509756963364;8851.77870553238;8883.822323553557;8889.19997200255;8912.866307005368;8916.598753056129;8440.57797110142;8489.957550212272;8520.105388934197;8537.786555336104;8554.101819308946;39907.40138897919;40163.3975490365;40195;40263.39604905929;40266;3058.4036112957983;3198.8400579970908;3224.6614105518815;3251.6748325167296;3273.1817045738567;29697.70302296971;30608.2347941301;30878.22804429907;31105.533416998536;31138.532922006187;4122.649574786146;4239.894002649928;4282.892927676802;4310.396544483775;4366.934495982563;317354;318483;318986;319078;320960;48333.275000875015;48364;48390.75804620954;48482.27276590854;48591.75704121528;55859;55963.72018139964;55998.440015600136;56052;56084.719576401854;15928;16148.708103351704;16199.271032803552;16202.513924582281;16206.108664023592;11891.28652280866;11906.821397679041;11922.105842061706;11938.28370297785;11938.403079845973;14701.55895323142;14800.629984250265;15077.170755608548;15133.924330378277;15135.167565783988;5689.886202275931;6059.091136329585;6103.35914728956;6128.2033335666965;6152.2924863640355;864.8789169516273;1019.4851599941982;1030.9793304628363;1120.5965852293168;1156.919015668912;29345.559816602767;30861;30908.53637195444;31246.719094495205;31408.371832563676;1031.3141760729181;1032.318669678024;1072.5709716113618;1099.3074363151163;1113.437713954464;14848.183349915858;15747.685046299239;15805.209739513208;15880;15945.521634350987;484953;491521;493153;493535;494506;47989.76005119952;48314;48369;48422.757886211046;48518;1331.7669407853587;1346.0577595683062;1372.2041216094642;1375.6698392385756;1376.5526203983745;27988.16035518938;28605.427891442472;29441.85279073591;29837.165469280382;30037.849810750806;46305.768471157426;46588;46718.299225510964;46725.2991205139;46815;405894;408090;409938;410553;411550;25525.3618659535;25681.357966050997;26247.60628590611;26485.470290594465;26594;44850.775746121064;45399.773001136105;45916.54083459123;46139.077218456114;46520.53479465162;38927.416088758124;39241.80379098086;39465.802670986464;40511.59488405196;40755;36740.26519469542;38832.223355532165;39084;39875.60124398835;41208.58791412047;37246.813765930994;38296.61703382931;38597.80701096589;38711;38796.030099246615;33011.834940825145;35809.64190358063;36314.8184259077;36351;36495.81752091223;27142.72857271481;27164.32089197707;27543.31141721473;27737.167884963485;28022.71977280201 19:48:15 INFO - PROCESS | 11467 | |2;jquery.html;381.69273734643616;389.890830567441;394.2548583177793;397.1778418673346;416.5001997602877;16086.75869861953;16801.07594082325;17807.198676059576;19403.320883769073;19443.319483818068;11294.717632059183;11458.427078646077;11676.649700508999;11893.643190704272;11902.7619447611;4958.87602809929;5226.425093239741;5260.842174734745;5262.342207224097;5271.683698978054;5116.258142569325;5133.512316329943;5216.895662086756;5219.634625576211;5720.79977200798;5676.091825307952;5681.289838770153;5683.658980461186;5699.401562835905;5733.713314334287;5112.41207261166;5169.069567477853;5403.459654034585;5644.435556444364;5674.148877668342;4963.751812409365;4978.601711863079;4982.9252561211615;4996.1756310208775;5022.974885125587;12900.741985160337;12910.677233069155;13045.608631741063;13396.732065358638;13405.329733513285;2031.3296612117965;2076.4497408186844;2166.10106805677;2289.1530133850415;2312.4450131968374;9606.183474404685;9657.806843863154;9677.951610241975;10025.248106391977;10217.080462758313;1785.1966615023161;1859.470051035462;1871.8876867388;1932.6134773045446;1945.9124339404761;79243.20756792415;84370;84730.15269847345;84913.15086849114;86906;9920.355176913621;10234.590616375262;10336;10544.472776361152;10657.84013239802;14204;14299.356528956221;14363.784543231859;14397.352119154662;14523.273836308143;7777.688892444352;7818.459000824755;7932.682692692228;7972.083210430758;8151.225633564802;7628.9618551908;7667.0416197975255;7739.303462688273;7861;7875.684972601031;4201.369794530784;4283.807228674717;4314.61168494837;4401.239504198346;4436.6007059364165;1905.3521802587186;1929.527265819855;1959.7844237133904;1961.2351183038627;2025.5948810238012;844.8056946902246;902.7427183252742;937.5546615357787;950.083169741203;1059.655611926127;18164.545886352684;18865;19089.2364305429;19108.713369299472;19564.510887227934;885.4687187687465;931.1107891963159;936.1527817325332;952.3476418653245;1001.7145113642576;7586.810329741801;10799.892001080047;10830.025297723243;10848.78302433947;10912.23614347004;445449;450554;457932;459715;461559;89140;89284.5535772317;90008;90474.54762726145;91034.54482727544;951.3578334624101;972.6498460554195;985.0248254228262;998.0069830518536;998.4308943902051;16206.432774852823;16473;17203;17266.395676151275;17304.307827686753;38888.222235555695;39772.602273978046;39958.40062399124;40338.1932361357;40989;55490.72254638701;57370.713146434;58435;58606.706966464895;58920.705396472746;5438.83683489496;7997.720364741614;8069.919300806917;8224.83550329002;8543.658253669784;9251.167394934488;12390.132690711564;12908;12937.676558086123;13017.284049377375;10969.670909872717;11063.557457701923;11277.21059525858;11596.536138554364;11735.295882247092;11429.942850285695;11459.713507162054;11480.081593472336;11542.884571154182;11594.130440217186;11300.604478843201;11592.826107608562;11687;11709.707257318636;11816.586419475278;8046.235607617267;8188.181181881764;8200.466969646954;8220.054693710299;8739.257163141205;9180.127887850644;10630.096441802534;10735.570577176826;10972.780544389227;11128.443577820915 19:48:15 INFO - PROCESS | 11467 | |3;mootools.html;1437.1592618318284;1471.1099784630298;1604.7352186889163;1733.4106403822698;1751.1944505527456;8345.165483451652;8754.737357879258;8999.325050621197;9028.68399606014;9072.954635226823;9010.54947252638;9169.954150229256;9175.816483670322;9181.21959633432;9186.494742789144;2269.2965180793967;2294.598445272079;2295.5753185660624;2305.0664480885184;2310.722713274401;2231.419830843976;2249.853759505635;2318.686977258074;2327.662488939103;2328.429534763985;2244.427670943907;2254.2448279826276;2277.749447560767;2290.0267386360815;2299.8045166160896;2244.8316376271846;2246.0454306919496;2254.211026140854;2256.1652188690127;2280.9657855132186;2213.7896899794496;2216.767239439852;2218.5119273759747;2225.254539729193;2225.810806081485;8967.103289671046;9038.457692538468;9041.412308200011;9051.773705657346;9077;5204.219367094928;5390.110631745757;5396.082665946798;5401.297831281908;5435.483629055233;3143.811371317728;3206.0862654143457;3366.3267346530793;3384.170878134848;3389.4915762635555;1030.428112397619;1030.6186710916934;1046.3146638951498;1052.3896140238644;1069.5561342043043;11801.114916381306;12256.754864902741;12292.139550231488;12567.497300107985;12635.557755478514;4392.7364358137975;4498.977505112453;4602.930956035662;4610.861674149781;4654.976725116353;9665.178459830853;9709.805803883883;9747.853782193273;9783.315167938175;9810.65662701802;5195.584353251731;5277.182036784305;5297.5232229099565;5304.787808487617;5313.44208858072;4761.928571071437;4934.8026078957155;4951.702897826142;4983.352164218701;5051.191809310566;3756.8121593920196;3819.4843696101225;3892.338302488584;3915.5888631693833;3934;1153.529250205994;1164.0338519029185;1165.7027457998156;1173.4308860202796;1184.9703757405962;736.488140742179;884.8805411269396;888.0054339140075;891.7458524320538;892.4868200784575;5274.26160337553;5573.857359241346;5593.804216852391;5706.400827913092;5791.189233507313;846.2341580869323;899;900.9504477253682;931.3201363004908;960.4237457525429;3492.5983511895947;3690.612485689018;3766.303233901737;3803.67668748154;3846.3845784674318;10535.262531622713;11073.833892491619;11114.555417783198;11117.666470005914;11132.220744547803;10609.257351985441;10856.022957933825;10861.83707244392;10876.564937402574;10917.126629869592;7797.532148071134;8100.068492123363;8126.228008339316;8133.5526546039355;8394.076651568323;5501.835924742014;5691.14632805066;5706.743196556082;5747.36778954323;5779.248697669276;9679.370840895319;9899;9914.851277230991;9988;10095.949520252352;10070.798584028425;10158.644447444303;10160.33957792741;10335.379877207391;10388.272820902464;7111.715531378687;7312.305330993547;7969.800754981172;8098.838023239385;8218.137095605114;8444.155584441753;8580.871286930576;8587.871181932402;8588.441751286146;8604.698835540727;7477.700891964478;7642.694292228249;7771.611419428893;7773.067231932205;7879.763607091796;7429.851402972018;7455.478116531791;7574.3183113520045;7669.271419215165;7745.535267883945;6578.671066446563;6624.8343791405605;6642.202935647753;6660.500462465237;6692.732290708317;4520.932186017147;4662.393888794435;4669.7898594564;4689.648276379217;4759.904801903874;4770.141374552614;4783.115123702126;4798.928016079832;4907.33750943618;5008.273800299009 19:48:15 INFO - PROCESS | 11467 | |4;prototype.html;317.8161348975068;320.4952200284551;328.08300799266055;335.3176286257465;336.3928109761882;5265;5365.812196573121;5405.567554595633;5437.238786569884;5473.261109750182;5195.844124676256;5336.599755018379;5355.223492593572;5413.810516631918;5458.4541545845395;4235.729281215638;4239.7668128252935;4243.257429949762;4244.469441319828;4244.745315281078;4131.256373852705;4180.665546756252;4186.079062606237;4192.37114432836;4247.299195632717;4153.646940010103;4154.293770059097;4163.770992595406;4165.791710414467;4171.395147703581;4112.465379500646;4155.33514637658;4161.042960119159;4173.686973476971;4178.811953462071;3697.482352470656;3706.3143318485895;3707.610700876396;3712.480252764615;3733.383991641376;5047.596192304643;5186.92219616706;5195.766190521435;5202.297689811865;5228.2680424740565;4773.665843390964;4790.568848803589;4798.952010479886;4813.676239034258;4824.565789079;5409.702466364349;5589.664620122765;5611.691356975365;5633.971830140864;5634.549236061105;4043.4432743394004;4067.3898915162667;4067.755934643901;4068.6338229559187;4078.5921407858978;5827.271591051119;5828.5337173026055;5837.482254613831;5843.766249350021;5861.3552509223955;4187.183499217624;4192.350185721218;4202.831886724558;4203.91592168155;4205.516365617993;3874.9225015499533;4117.661759928035;4126.277901367249;4136.91726165475;4137.358709400048;4753.667243292936;4776.785044672998;4788.946431785002;4795.112904112751;4828.179209534387;5714.257146570919;5728.627639203439;5731.828045158652;5737.483626473638;5746.339170995389;1380.5168191133223;1433.7490939085826;1447.261896432827;1451.4484495891493;1454.5927140400704;891.5497673674882;905;918.8621706743908;925.1765928323797;926.8795056642593;4842.322074909515;4858.441279252931;4908.680935739166;4909.2881532177635;4912.287718280901;5077.466865979019;5087.949120508822;5092;5117;5128.845759857661;4891.6575839691595;4922.753862306942;4928.531789479994;4939.6542242042715;5199.2201169824075;3097.6612657443484;3138.544910987894;3159.241781972356;3159.6524382317925;3160.873565057372;6019.668918209541;6037.758489660452;6078.662694207267;6107.816765497042;6132.0070976932675;5677;5963.970180149072;5989.55078369124;6037.758489660452;6039.698015099315;6101.755929762849;6113.602615829956;6117.908231376533;6126.908096378558;6128.846778830565;5563.610547261653;5801.738921748447;5882.617629854046;5886.970565147147;5916.674582897982;5774.971125144348;5827.79602713903;5828.766849326149;5840.474357307863;5864.44287792659;5970.253718285215;6062.787802426894;6083.954170476583;6099.969500152471;6118.235220597426;3993.660538854114;4060.451839001697;4147.232761939051;4148.651688201407;4155.812988415468;5819.388964158702;5823.854403639943;5840.182374467663;5867.266591676041;5885.735141918538;5730.426957304237;5737.655740655574;5737.799177028784;5738.22533957927;5744.626599271034;5532.419095995024;5626.96144082191;5668.744906479301;5672.7730890763905;5692.857678558069;5668.744906479136;5677.943220567907;5691.459311365414;5707.286589176353;5713.428657134254;5562;5716.142578613075;5748.103125968504;5765.7117144141785;5777.768889244383;5532.474414930736;5619.325680918316;5625.718714064362;5646.71766411686;5647.830565083054 19:48:15 INFO - PROCESS | 11467 | |5;yui.html;655.3119224813944;728.8724473217189;742.6138408027829;745.8732015557355;760.619261710845;14364.569062928103;14948.701025979473;15067.773983390258;15135.848641513581;15168.620784480394;13297.534586289481;13398.062135650509;13423.328833558331;13425.530106446251;13473.595792126227;804.0351578106281;828.9875651865227;832.1803024021334;832.2509741232878;833.5123952487771;795.2047952047952;815.7389635316702;820.1552401026952;830.8919840420767;831.8710599857002;859.9269062129727;871.020102384817;874.1215078845751;874.2525141004445;879.7140929198036;871.7471933139382;872.3849685971375;873.724776695339;874.1127755328347;876.4565969099135;636.1856823266227;638.5051585021599;638.8850006998738;642.3672682407824;642.5470043619238;15069.321880515294;15156.924215378964;15189.164595947219;15208.239588020666;15215.847841521554;14664.266786660732;14768.852311476856;14932.50674932509;15202.239888005555;15236.847631523653;10295.124914382286;10473.633422830164;10505.31715438494;10577;10731.195160363004;3646.5441819772527;3716.5005098555703;3762;3896.1623251000888;3903.941440878389;80404;80662.59668701678;81809;82084;82723;11279.830802537968;11304.717382065513;11386.601468948547;11411.315321080761;11422.086233101332;21693.34919952404;21693.457663558536;21771.891140544514;21837.45406364822;21890.562188756136;7995.320397766255;8096.230858068474;8269.669213231404;8324.876141720912;8572.91427085721;4562.384078149474;4590.793414296365;4670.95329046712;4710.528947105262;4913.70517768935;3299;3379.850850710721;3386.9661303387143;3397.8810741623925;3432.828358582061;568.4912003756615;582.3322952197357;583.6556431705229;598.9401059893976;602.5571205164201;583.1981026089128;590.7784580782206;606.8379054111416;618.6195489773756;647.4334956912701;8344.165583441607;8776.210141087333;8940.955295223483;9076.137766912132;9149.954250228839;503.59209040677166;515.4510446374599;544.599719206383;616.722474886303;635.7838334966134;4043.251998380309;4227.97886010568;4304.569543045733;4335.6965012449455;4377.365282034151;66224.66887665531;99616.5019174914;101024;104102.47948760208;106039;54364.18453723197;75193.62403187949;75395.24604753882;86533.56733216293;88012.55993720118;24706.752932470805;26364.340891477867;36188;74574.25425745781;75088;9296.116868897443;9675.225981921289;9891.9570208104;9896.406215627085;10068.647597334058;44737.776311118236;46094.76952615215;47986.56208287721;48118.75940620274;49948.50051499438;62137;64051;69574.65212673905;70977.29022709707;72625.63687181531;11315.773684526428;11486.19596628228;11689.707757305796;11711.531538738696;11785.705357365792;13485.730285394433;13504.257265850472;13646.385912634154;13745.24401157906;14368.928155359155;11992.160548761503;12251.142420030512;12277.570285040338;12341.197822141532;12421.93789031049;13141.408636611566;13561.45754169822;13774.65563360884;14044.859551404355;14216.360263788361;12442.875571244173;12686.936565317113;12973.351332433152;13010.869891301345;13026.28355440422;10159;10505.00202480763;10892.945535272273;10936.945315273373;11304.886951130713;9758.316917815968;9981.278256885997;11070.446477675923;11567.595134170264;11655.125865559947 19:48:15 INFO - PROCESS | 11467 | __end_tp_report 19:48:15 INFO - PROCESS | 11467 | __start_cc_report 19:48:15 INFO - PROCESS | 11467 | _x_x_mozilla_cycle_collect,331 19:48:15 INFO - PROCESS | 11467 | __end_cc_report 19:48:15 INFO - PROCESS | 11467 | __startTimestamp1477018095377__endTimestamp 19:48:15 INFO - PROCESS | 11467 | 19:48:15 INFO - PROCESS | 11467 | ------- Summary: start ------- 19:48:15 INFO - PROCESS | 11467 | Number of tests: 6 19:48:15 INFO - PROCESS | 11467 | 19:48:15 INFO - PROCESS | 11467 | [#0] dojo.html Cycles:165 Average:5399.89 Median:5587.61 stddev:616.06 (11.0%) stddev-sans-first:592.14 19:48:15 INFO - PROCESS | 11467 | Values: 3150.7 3162.2 3179.9 3198.7 3206.2 5262.5 5490.9 5493.0 5529.2 5579.8 5303.0 5420.3 5517.0 5557.4 5587.6 4828.8 4849.1 4921.6 4960.9 5017.1 4756.0 4925.4 4989.9 5008.5 5057.5 4816.7 4831.9 4896.7 4912.8 4935.4 4850.7 4880.5 4891.8 4947.7 4964.9 4823.3 4837.5 4848.3 4865.4 4898.1 5248.5 5272.0 5295.2 5368.6 5478.0 5749.4 5841.4 5870.8 5886.4 5960.2 5901.6 5939.5 5941.1 5954.3 5960.6 5266.1 5544.0 5551.2 5569.7 5573.5 5749.4 5910.3 5948.2 5958.0 6056.2 5710.7 5750.2 5752.8 5756.2 5760.1 5651.1 5772.3 5816.3 5840.7 5851.1 5641.2 5857.8 5954.2 5960.7 5962.3 5924.8 5927.1 5932.0 5932.9 5939.4 4511.3 4513.8 4521.2 4522.5 4584.6 3909.0 3927.2 3943.3 3951.2 3953.4 5487.9 5523.9 5534.4 5549.7 5553.0 5798.9 5849.2 5854.8 5858.8 5862.3 5309.1 5428.8 5488.0 5494.9 5571.7 5043.2 5057.5 5072.8 5088.1 5099.8 6021.4 6036.9 6040.2 6047.8 6078.7 5561.6 5620.9 5626.1 5871.0 5924.6 5842.7 5860.3 5873.7 5912.9 5914.8 5580.7 5620.3 5624.9 5638.9 5655.1 5706.1 5732.6 5742.5 5748.5 5748.5 5594.7 5608.7 5613.4 5614.4 5616.7 5583.2 5669.0 5683.5 5690.1 5750.6 5578.6 5627.1 5686.6 5743.9 5797.7 5795.5 5824.9 5825.9 5827.7 5861.8 5373.2 5425.6 5459.5 5485.9 5705.4 19:48:15 INFO - PROCESS | 11467 | 19:48:15 INFO - PROCESS | 11467 | [#1] ext.html Cycles:180 Average:55803.11 Median:40388.80 stddev:109281.08 (270.6%) stddev-sans-first:109508.91 19:48:15 INFO - PROCESS | 11467 | Values: 554.6 573.5 586.1 590.7 598.1 41400.6 42076.0 42102.4 45330.8 45339.3 43216.6 43320.0 43590.0 43619.1 43811.6 8665.7 8806.6 8813.4 8837.2 8849.4 8709.6 8743.1 8743.3 8786.6 8838.6 8760.5 8862.0 8864.7 8907.6 8913.5 8851.8 8883.8 8889.2 8912.9 8916.6 8440.6 8490.0 8520.1 8537.8 8554.1 39907.4 40163.4 40195.0 40263.4 40266.0 3058.4 3198.8 3224.7 3251.7 3273.2 29697.7 30608.2 30878.2 31105.5 31138.5 4122.6 4239.9 4282.9 4310.4 4366.9 317354.0 318483.0 318986.0 319078.0 320960.0 48333.3 48364.0 48390.8 48482.3 48591.8 55859.0 55963.7 55998.4 56052.0 56084.7 15928.0 16148.7 16199.3 16202.5 16206.1 11891.3 11906.8 11922.1 11938.3 11938.4 14701.6 14800.6 15077.2 15133.9 15135.2 5689.9 6059.1 6103.4 6128.2 6152.3 864.9 1019.5 1031.0 1120.6 1156.9 29345.6 30861.0 30908.5 31246.7 31408.4 1031.3 1032.3 1072.6 1099.3 1113.4 14848.2 15747.7 15805.2 15880.0 15945.5 484953.0 491521.0 493153.0 493535.0 494506.0 47989.8 48314.0 48369.0 48422.8 48518.0 1331.8 1346.1 1372.2 1375.7 1376.6 27988.2 28605.4 29441.9 29837.2 30037.8 46305.8 46588.0 46718.3 46725.3 46815.0 405894.0 408090.0 409938.0 410553.0 411550.0 25525.4 25681.4 26247.6 26485.5 26594.0 44850.8 45399.8 45916.5 46139.1 46520.5 38927.4 39241.8 39465.8 40511.6 40755.0 36740.3 38832.2 39084.0 39875.6 41208.6 37246.8 38296.6 38597.8 38711.0 38796.0 33011.8 35809.6 36314.8 36351.0 36495.8 27142.7 27164.3 27543.3 27737.2 28022.7 19:48:15 INFO - PROCESS | 11467 | 19:48:15 INFO - PROCESS | 11467 | [#2] jquery.html Cycles:180 Average:27192.69 Median:4242.59 stddev:75386.94 (1776.9%) stddev-sans-first:75571.54 19:48:15 INFO - PROCESS | 11467 | Values: 381.7 389.9 394.3 397.2 416.5 16086.8 16801.1 17807.2 19403.3 19443.3 11294.7 11458.4 11676.6 11893.6 11902.8 4958.9 5226.4 5260.8 5262.3 5271.7 5116.3 5133.5 5216.9 5219.6 5720.8 5676.1 5681.3 5683.7 5699.4 5733.7 5112.4 5169.1 5403.5 5644.4 5674.1 4963.8 4978.6 4982.9 4996.2 5023.0 12900.7 12910.7 13045.6 13396.7 13405.3 2031.3 2076.4 2166.1 2289.2 2312.4 9606.2 9657.8 9678.0 10025.2 10217.1 1785.2 1859.5 1871.9 1932.6 1945.9 79243.2 84370.0 84730.2 84913.2 86906.0 9920.4 10234.6 10336.0 10544.5 10657.8 14204.0 14299.4 14363.8 14397.4 14523.3 7777.7 7818.5 7932.7 7972.1 8151.2 7629.0 7667.0 7739.3 7861.0 7875.7 4201.4 4283.8 4314.6 4401.2 4436.6 1905.4 1929.5 1959.8 1961.2 2025.6 844.8 902.7 937.6 950.1 1059.7 18164.5 18865.0 19089.2 19108.7 19564.5 885.5 931.1 936.2 952.3 1001.7 7586.8 10799.9 10830.0 10848.8 10912.2 445449.0 450554.0 457932.0 459715.0 461559.0 89140.0 89284.6 90008.0 90474.5 91034.5 951.4 972.6 985.0 998.0 998.4 16206.4 16473.0 17203.0 17266.4 17304.3 38888.2 39772.6 39958.4 40338.2 40989.0 55490.7 57370.7 58435.0 58606.7 58920.7 5438.8 7997.7 8069.9 8224.8 8543.7 9251.2 12390.1 12908.0 12937.7 13017.3 10969.7 11063.6 11277.2 11596.5 11735.3 11429.9 11459.7 11480.1 11542.9 11594.1 11300.6 11592.8 11687.0 11709.7 11816.6 8046.2 8188.2 8200.5 8220.1 8739.3 9180.1 10630.1 10735.6 10972.8 11128.4 19:48:15 INFO - PROCESS | 11467 | 19:48:15 INFO - PROCESS | 11467 | [#3] mootools.html Cycles:180 Average:5724.58 Median:4921.07 stddev:3317.78 (67.4%) stddev-sans-first:3311.44 19:48:15 INFO - PROCESS | 11467 | Values: 1437.2 1471.1 1604.7 1733.4 1751.2 8345.2 8754.7 8999.3 9028.7 9073.0 9010.5 9170.0 9175.8 9181.2 9186.5 2269.3 2294.6 2295.6 2305.1 2310.7 2231.4 2249.9 2318.7 2327.7 2328.4 2244.4 2254.2 2277.7 2290.0 2299.8 2244.8 2246.0 2254.2 2256.2 2281.0 2213.8 2216.8 2218.5 2225.3 2225.8 8967.1 9038.5 9041.4 9051.8 9077.0 5204.2 5390.1 5396.1 5401.3 5435.5 3143.8 3206.1 3366.3 3384.2 3389.5 1030.4 1030.6 1046.3 1052.4 1069.6 11801.1 12256.8 12292.1 12567.5 12635.6 4392.7 4499.0 4602.9 4610.9 4655.0 9665.2 9709.8 9747.9 9783.3 9810.7 5195.6 5277.2 5297.5 5304.8 5313.4 4761.9 4934.8 4951.7 4983.4 5051.2 3756.8 3819.5 3892.3 3915.6 3934.0 1153.5 1164.0 1165.7 1173.4 1185.0 736.5 884.9 888.0 891.7 892.5 5274.3 5573.9 5593.8 5706.4 5791.2 846.2 899.0 901.0 931.3 960.4 3492.6 3690.6 3766.3 3803.7 3846.4 10535.3 11073.8 11114.6 11117.7 11132.2 10609.3 10856.0 10861.8 10876.6 10917.1 7797.5 8100.1 8126.2 8133.6 8394.1 5501.8 5691.1 5706.7 5747.4 5779.2 9679.4 9899.0 9914.9 9988.0 10095.9 10070.8 10158.6 10160.3 10335.4 10388.3 7111.7 7312.3 7969.8 8098.8 8218.1 8444.2 8580.9 8587.9 8588.4 8604.7 7477.7 7642.7 7771.6 7773.1 7879.8 7429.9 7455.5 7574.3 7669.3 7745.5 6578.7 6624.8 6642.2 6660.5 6692.7 4520.9 4662.4 4669.8 4689.6 4759.9 4770.1 4783.1 4798.9 4907.3 5008.3 19:48:15 INFO - PROCESS | 11467 | 19:48:15 INFO - PROCESS | 11467 | [#4] prototype.html Cycles:180 Average:4733.77 Median:5246.63 stddev:1403.64 (26.8%) stddev-sans-first:1367.89 19:48:15 INFO - PROCESS | 11467 | Values: 317.8 320.5 328.1 335.3 336.4 5265.0 5365.8 5405.6 5437.2 5473.3 5195.8 5336.6 5355.2 5413.8 5458.5 4235.7 4239.8 4243.3 4244.5 4244.7 4131.3 4180.7 4186.1 4192.4 4247.3 4153.6 4154.3 4163.8 4165.8 4171.4 4112.5 4155.3 4161.0 4173.7 4178.8 3697.5 3706.3 3707.6 3712.5 3733.4 5047.6 5186.9 5195.8 5202.3 5228.3 4773.7 4790.6 4799.0 4813.7 4824.6 5409.7 5589.7 5611.7 5634.0 5634.5 4043.4 4067.4 4067.8 4068.6 4078.6 5827.3 5828.5 5837.5 5843.8 5861.4 4187.2 4192.4 4202.8 4203.9 4205.5 3874.9 4117.7 4126.3 4136.9 4137.4 4753.7 4776.8 4788.9 4795.1 4828.2 5714.3 5728.6 5731.8 5737.5 5746.3 1380.5 1433.7 1447.3 1451.4 1454.6 891.5 905.0 918.9 925.2 926.9 4842.3 4858.4 4908.7 4909.3 4912.3 5077.5 5087.9 5092.0 5117.0 5128.8 4891.7 4922.8 4928.5 4939.7 5199.2 3097.7 3138.5 3159.2 3159.7 3160.9 6019.7 6037.8 6078.7 6107.8 6132.0 5677.0 5964.0 5989.6 6037.8 6039.7 6101.8 6113.6 6117.9 6126.9 6128.8 5563.6 5801.7 5882.6 5887.0 5916.7 5775.0 5827.8 5828.8 5840.5 5864.4 5970.3 6062.8 6084.0 6100.0 6118.2 3993.7 4060.5 4147.2 4148.7 4155.8 5819.4 5823.9 5840.2 5867.3 5885.7 5730.4 5737.7 5737.8 5738.2 5744.6 5532.4 5627.0 5668.7 5672.8 5692.9 5668.7 5677.9 5691.5 5707.3 5713.4 5562.0 5716.1 5748.1 5765.7 5777.8 5532.5 5619.3 5625.7 5646.7 5647.8 19:48:15 INFO - PROCESS | 11467 | 19:48:15 INFO - PROCESS | 11467 | [#5] yui.html Cycles:180 Average:18134.63 Median:24650.08 stddev:25132.90 (102.0%) stddev-sans-first:25169.14 19:48:15 INFO - PROCESS | 11467 | Values: 655.3 728.9 742.6 745.9 760.6 14364.6 14948.7 15067.8 15135.8 15168.6 13297.5 13398.1 13423.3 13425.5 13473.6 804.0 829.0 832.2 832.3 833.5 795.2 815.7 820.2 830.9 831.9 859.9 871.0 874.1 874.3 879.7 871.7 872.4 873.7 874.1 876.5 636.2 638.5 638.9 642.4 642.5 15069.3 15156.9 15189.2 15208.2 15215.8 14664.3 14768.9 14932.5 15202.2 15236.8 10295.1 10473.6 10505.3 10577.0 10731.2 3646.5 3716.5 3762.0 3896.2 3903.9 80404.0 80662.6 81809.0 82084.0 82723.0 11279.8 11304.7 11386.6 11411.3 11422.1 21693.3 21693.5 21771.9 21837.5 21890.6 7995.3 8096.2 8269.7 8324.9 8572.9 4562.4 4590.8 4671.0 4710.5 4913.7 3299.0 3379.9 3387.0 3397.9 3432.8 568.5 582.3 583.7 598.9 602.6 583.2 590.8 606.8 618.6 647.4 8344.2 8776.2 8941.0 9076.1 9150.0 503.6 515.5 544.6 616.7 635.8 4043.3 4228.0 4304.6 4335.7 4377.4 66224.7 99616.5 101024.0 104102.5 106039.0 54364.2 75193.6 75395.2 86533.6 88012.6 24706.8 26364.3 36188.0 74574.3 75088.0 9296.1 9675.2 9892.0 9896.4 10068.6 44737.8 46094.8 47986.6 48118.8 49948.5 62137.0 64051.0 69574.7 70977.3 72625.6 11315.8 11486.2 11689.7 11711.5 11785.7 13485.7 13504.3 13646.4 13745.2 14368.9 11992.2 12251.1 12277.6 12341.2 12421.9 13141.4 13561.5 13774.7 14044.9 14216.4 12442.9 12686.9 12973.4 13010.9 13026.3 10159.0 10505.0 10892.9 10936.9 11304.9 9758.3 9981.3 11070.4 11567.6 11655.1 19:48:15 INFO - PROCESS | 11467 | -------- Summary: end -------- 19:48:15 INFO - PROCESS | 11467 | 19:48:16 INFO - TEST-INFO | 11467: exit 0 19:48:16 INFO - TEST-OK | dromaeo_css | took 1116761ms 19:48:16 INFO - TEST-START | kraken 19:48:16 INFO - operating with platform_type : linux_ 19:48:16 INFO - Initialising browser for kraken test... 19:48:16 INFO - TEST-INFO | started process 11826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWByjsh/profile http://localhost:52367/getInfo.html) 19:48:21 INFO - PROCESS | 11826 | __metrics Screen width/height:1600/1200 19:48:21 INFO - PROCESS | 11826 | colorDepth:24 19:48:21 INFO - PROCESS | 11826 | Browser inner width/height: 1024/697 19:48:21 INFO - PROCESS | 11826 | __metrics 19:48:21 ERROR - PROCESS | 11826 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 19:48:22 INFO - TEST-INFO | 11826: exit 0 19:48:22 INFO - Browser initialized. 19:48:22 INFO - Running cycle 1/1 for kraken test... 19:48:22 INFO - TEST-INFO | started process 11949 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWByjsh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:48:34 INFO - PROCESS | 11949 | RSS: Main: 182657024 19:48:34 INFO - PROCESS | 11949 | 19:48:37 INFO - PROCESS | 11949 | Cycle 1(1): loaded http://localhost:52367/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52367/tests/kraken/driver.html?testName=audio-beat-detection) 19:48:38 INFO - PROCESS | 11949 | RSS: Main: 196681728 19:48:38 INFO - PROCESS | 11949 | 19:48:41 INFO - PROCESS | 11949 | Cycle 1(1): loaded http://localhost:52367/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52367/tests/kraken/driver.html?testName=audio-dft) 19:48:41 INFO - PROCESS | 11949 | RSS: Main: 194539520 19:48:41 INFO - PROCESS | 11949 | 19:48:44 INFO - PROCESS | 11949 | Cycle 1(1): loaded http://localhost:52367/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52367/tests/kraken/driver.html?testName=audio-fft) 19:48:45 INFO - PROCESS | 11949 | RSS: Main: 191176704 19:48:45 INFO - PROCESS | 11949 | 19:48:47 INFO - PROCESS | 11949 | Cycle 1(1): loaded http://localhost:52367/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52367/tests/kraken/driver.html?testName=audio-oscillator) 19:48:47 INFO - PROCESS | 11949 | RSS: Main: 191692800 19:48:47 INFO - PROCESS | 11949 | 19:48:50 INFO - PROCESS | 11949 | Cycle 1(1): loaded http://localhost:52367/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52367/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:48:50 INFO - PROCESS | 11949 | RSS: Main: 191758336 19:48:50 INFO - PROCESS | 11949 | 19:48:53 INFO - PROCESS | 11949 | Cycle 1(1): loaded http://localhost:52367/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52367/tests/kraken/driver.html?testName=imaging-darkroom) 19:48:54 INFO - PROCESS | 11949 | RSS: Main: 191889408 19:48:54 INFO - PROCESS | 11949 | 19:48:57 INFO - PROCESS | 11949 | Cycle 1(1): loaded http://localhost:52367/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52367/tests/kraken/driver.html?testName=imaging-desaturate) 19:48:58 INFO - PROCESS | 11949 | RSS: Main: 192258048 19:48:58 INFO - PROCESS | 11949 | 19:49:01 INFO - PROCESS | 11949 | Cycle 1(1): loaded http://localhost:52367/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52367/tests/kraken/driver.html?testName=json-parse-financial) 19:49:01 INFO - PROCESS | 11949 | RSS: Main: 192798720 19:49:01 INFO - PROCESS | 11949 | 19:49:03 INFO - PROCESS | 11949 | Cycle 1(1): loaded http://localhost:52367/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52367/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:49:03 INFO - PROCESS | 11949 | RSS: Main: 192573440 19:49:03 INFO - PROCESS | 11949 | 19:49:05 INFO - PROCESS | 11949 | Cycle 1(1): loaded http://localhost:52367/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52367/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:49:06 INFO - PROCESS | 11949 | RSS: Main: 192712704 19:49:06 INFO - PROCESS | 11949 | 19:49:08 INFO - PROCESS | 11949 | Cycle 1(1): loaded http://localhost:52367/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52367/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:49:09 INFO - PROCESS | 11949 | RSS: Main: 192724992 19:49:09 INFO - PROCESS | 11949 | 19:49:11 INFO - PROCESS | 11949 | Cycle 1(1): loaded http://localhost:52367/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52367/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:49:12 INFO - PROCESS | 11949 | RSS: Main: 192487424 19:49:12 INFO - PROCESS | 11949 | 19:49:15 INFO - PROCESS | 11949 | Cycle 1(1): loaded http://localhost:52367/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52367/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:49:16 INFO - PROCESS | 11949 | RSS: Main: 193368064 19:49:16 INFO - PROCESS | 11949 | 19:49:17 INFO - PROCESS | 11949 | Cycle 1(1): loaded http://localhost:52367/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52367/tests/kraken/driver.html?testName=ai-astar) 19:49:18 INFO - PROCESS | 11949 | RSS: Main: 194244608 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | __start_tp_report 19:49:18 INFO - PROCESS | 11949 | _x_x_mozilla_page_load 19:49:18 INFO - PROCESS | 11949 | _x_x_mozilla_page_load_details 19:49:18 INFO - PROCESS | 11949 | |i|pagename|runs| 19:49:18 INFO - PROCESS | 11949 | |0;ai-astar;105;119;111;111;112;111;111;112;111;110 19:49:18 INFO - PROCESS | 11949 | |1;audio-beat-detection;149;123;125;165;125;125;124;125;157;130 19:49:18 INFO - PROCESS | 11949 | |2;audio-dft;164;165;163;166;176;163;162;163;163;163 19:49:18 INFO - PROCESS | 11949 | |3;audio-fft;76;75;77;103;77;76;76;75;102;74 19:49:18 INFO - PROCESS | 11949 | |4;audio-oscillator;83;82;112;85;83;83;105;83;83;128 19:49:18 INFO - PROCESS | 11949 | |5;imaging-gaussian-blur;118;119;118;119;118;119;119;117;120;118 19:49:18 INFO - PROCESS | 11949 | |6;imaging-darkroom;147;147;146;147;147;147;147;149;148;147 19:49:18 INFO - PROCESS | 11949 | |7;imaging-desaturate;85;86;86;86;86;87;86;85;86;85 19:49:18 INFO - PROCESS | 11949 | |8;json-parse-financial;56;55;58;60;56;55;55;60;57;55 19:49:18 INFO - PROCESS | 11949 | |9;json-stringify-tinderbox;61;60;61;61;61;60;61;60;60;61 19:49:18 INFO - PROCESS | 11949 | |10;stanford-crypto-aes;88;82;86;79;81;85;81;80;88;81 19:49:18 INFO - PROCESS | 11949 | |11;stanford-crypto-ccm;137;140;140;143;145;142;134;150;182;136 19:49:18 INFO - PROCESS | 11949 | |12;stanford-crypto-pbkdf2;174;168;173;167;173;174;176;166;168;168 19:49:18 INFO - PROCESS | 11949 | |13;stanford-crypto-sha256-iterative;70;69;70;68;67;69;67;67;68;71 19:49:18 INFO - PROCESS | 11949 | __end_tp_report 19:49:18 INFO - PROCESS | 11949 | __start_cc_report 19:49:18 INFO - PROCESS | 11949 | _x_x_mozilla_cycle_collect,801 19:49:18 INFO - PROCESS | 11949 | __end_cc_report 19:49:18 INFO - PROCESS | 11949 | __startTimestamp1477018158122__endTimestamp 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | ------- Summary: start ------- 19:49:18 INFO - PROCESS | 11949 | Number of tests: 14 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:3.37 (3.0%) stddev-sans-first:2.69 19:49:18 INFO - PROCESS | 11949 | Values: 105.0 119.0 111.0 111.0 112.0 111.0 111.0 112.0 111.0 110.0 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:127.50 stddev:15.88 (12.5%) stddev-sans-first:15.99 19:49:18 INFO - PROCESS | 11949 | Values: 149.0 123.0 125.0 165.0 125.0 125.0 124.0 125.0 157.0 130.0 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | [#2] audio-dft Cycles:10 Average:164.80 Median:163.50 stddev:4.10 (2.5%) stddev-sans-first:4.34 19:49:18 INFO - PROCESS | 11949 | Values: 164.0 165.0 163.0 166.0 176.0 163.0 162.0 163.0 163.0 163.0 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:11.32 (14.9%) stddev-sans-first:11.85 19:49:18 INFO - PROCESS | 11949 | Values: 76.0 75.0 77.0 103.0 77.0 76.0 76.0 75.0 102.0 74.0 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:83.00 stddev:16.38 (19.7%) stddev-sans-first:16.99 19:49:18 INFO - PROCESS | 11949 | Values: 83.0 82.0 112.0 85.0 83.0 83.0 105.0 83.0 83.0 128.0 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:119.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 19:49:18 INFO - PROCESS | 11949 | Values: 118.0 119.0 118.0 119.0 118.0 119.0 119.0 117.0 120.0 118.0 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 19:49:18 INFO - PROCESS | 11949 | Values: 147.0 147.0 146.0 147.0 147.0 147.0 147.0 149.0 148.0 147.0 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 19:49:18 INFO - PROCESS | 11949 | Values: 85.0 86.0 86.0 86.0 86.0 87.0 86.0 85.0 86.0 85.0 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.50 stddev:2.00 (3.5%) stddev-sans-first:2.11 19:49:18 INFO - PROCESS | 11949 | Values: 56.0 55.0 58.0 60.0 56.0 55.0 55.0 60.0 57.0 55.0 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 19:49:18 INFO - PROCESS | 11949 | Values: 61.0 60.0 61.0 61.0 61.0 60.0 61.0 60.0 60.0 61.0 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.50 stddev:3.35 (4.0%) stddev-sans-first:3.05 19:49:18 INFO - PROCESS | 11949 | Values: 88.0 82.0 86.0 79.0 81.0 85.0 81.0 80.0 88.0 81.0 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:142.50 stddev:13.84 (9.7%) stddev-sans-first:14.38 19:49:18 INFO - PROCESS | 11949 | Values: 137.0 140.0 140.0 143.0 145.0 142.0 134.0 150.0 182.0 136.0 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:173.00 stddev:3.62 (2.1%) stddev-sans-first:3.64 19:49:18 INFO - PROCESS | 11949 | Values: 174.0 168.0 173.0 167.0 173.0 174.0 176.0 166.0 168.0 168.0 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.43 (2.1%) stddev-sans-first:1.42 19:49:18 INFO - PROCESS | 11949 | Values: 70.0 69.0 70.0 68.0 67.0 69.0 67.0 67.0 68.0 71.0 19:49:18 INFO - PROCESS | 11949 | -------- Summary: end -------- 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | 19:49:18 INFO - PROCESS | 11949 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 19:49:18 INFO - PROCESS | 11949 | 19:49:19 INFO - TEST-INFO | 11949: exit 0 19:49:19 INFO - TEST-OK | kraken | took 62766ms 19:49:19 INFO - SUITE-END | took 1179s 19:49:19 INFO - Completed test suite (00:19:39) 19:49:19 INFO - javascript benchmark 19:49:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7018.001229625853, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3150.747940164787, 3162.193640621641, 3179.8887038953635, 3198.680131986802, 3206.182423482012, 5262.526372626463, 5490.945090549093, 5493.0, 5529.198266251391, 5579.832605021846, 5303.018941495826, 5420.349558053039, 5517.034518959176, 5557.3886872444, 5587.608867379285, 4828.830990915319, 4849.054434385296, 4921.557059864612, 4960.851174464772, 5017.147084995559, 4756.0, 4925.433575138851, 4989.925151122736, 5008.499150084981, 5057.544820966113, 4816.662833601649, 4831.855044348676, 4896.681715688469, 4912.778924948386, 4935.383077115361, 4850.733209673466, 4880.463149053601, 4891.779869905863, 4947.653664243504, 4964.900701985976, 4823.300621409876, 4837.492063333335, 4848.296996935424, 4865.41615006198, 4898.118338699032, 5248.475152484759, 5272.0, 5295.232191332274, 5368.570514358842, 5478.0, 5749.3963133871175, 5841.357450680422, 5870.823875283749, 5886.411358864122, 5960.195373624549, 5901.586888917777, 5939.524838012949, 5941.1088336749835, 5954.255718035246, 5960.552958528127, 5266.131088370453, 5544.0, 5551.167324901297, 5569.721513924328, 5573.470520300605, 5749.425057494301, 5910.290765108214, 5948.226730525004, 5958.0, 6056.152138700585, 5710.685912274782, 5750.1949727038245, 5752.798652047159, 5756.1653560233535, 5760.0783874579865, 5651.095824668033, 5772.278465191851, 5816.302043754777, 5840.707964601753, 5851.063829787214, 5641.238432811518, 5857.7949771757785, 5954.166416701665, 5960.672163031075, 5962.284525856925, 5924.763009479659, 5927.1405646181065, 5932.0, 5932.851678707981, 5939.4357536034, 4511.3458548510935, 4513.842015529441, 4521.231390663529, 4522.479914809774, 4584.61030812378, 3908.9609103909165, 3927.23418933311, 3943.290207762573, 3951.1702542466405, 3953.426753120839, 5487.890242195133, 5523.917141242885, 5534.446555344433, 5549.667019978814, 5553.0, 5798.9420105799245, 5849.181114643953, 5854.824355269348, 5858.794942177004, 5862.296524417097, 5309.070912590281, 5428.8099916503525, 5488.039593071197, 5494.917576236359, 5571.749271282802, 5043.167877300204, 5057.494250574987, 5072.847814565569, 5088.109580823341, 5099.821506247337, 6021.42796434338, 6036.939630603725, 6040.244969378828, 6047.848803779941, 6078.726457309432, 5561.555075593862, 5620.8875822482505, 5626.071698169756, 5871.0, 5924.555658325729, 5842.737076831638, 5860.267466566679, 5873.676947767914, 5912.852178695395, 5914.763409463745, 5580.720963951705, 5620.269364982526, 5624.887502250014, 5638.85902852432, 5655.066913959316, 5706.087026075808, 5732.59871808986, 5742.540596752333, 5748.540116790563, 5748.54011679073, 5594.748236329457, 5608.691521966168, 5613.438656134354, 5614.438556144353, 5616.747246373841, 5583.218349431002, 5669.036263835075, 5683.545316374597, 5690.118031705092, 5750.568707347049, 5578.553715702815, 5627.099664053731, 5686.57350698691, 5743.885122297447, 5797.652140871562, 5795.478406943395, 5824.854378640568, 5825.883482330414, 5827.650340979555, 5861.7655293787775, 5373.167159090347, 5425.565954723692, 5459.508644222039, 5485.945140548543, 5705.400932902152], "value": 5358.616525520125, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.5587995433046, 573.4867293772074, 586.0769288370817, 590.6515156057927, 598.1446531460011, 41400.58599414005, 42075.99999999996, 42102.36846447302, 45330.773346133305, 45339.31991020129, 43216.56783432165, 43320.0, 43590.0, 43619.12761744763, 43811.561884381146, 8665.740027799176, 8806.559672016405, 8813.42712723671, 8837.160469755363, 8849.380543361967, 8709.608067636971, 8743.12568743127, 8743.256823170039, 8786.560671966376, 8838.602262898185, 8760.518171500566, 8861.955690221539, 8864.73405797827, 8907.599158037872, 8913.509756963364, 8851.77870553238, 8883.822323553557, 8889.19997200255, 8912.866307005368, 8916.598753056129, 8440.57797110142, 8489.957550212272, 8520.105388934197, 8537.786555336104, 8554.101819308946, 39907.40138897919, 40163.3975490365, 40195.0, 40263.39604905929, 40266.0, 3058.4036112957983, 3198.8400579970908, 3224.6614105518815, 3251.6748325167296, 3273.1817045738567, 29697.70302296971, 30608.2347941301, 30878.22804429907, 31105.533416998536, 31138.532922006187, 4122.649574786146, 4239.894002649928, 4282.892927676802, 4310.396544483775, 4366.934495982563, 317354.0, 318483.0, 318986.0, 319078.0, 320960.0, 48333.275000875015, 48364.0, 48390.75804620954, 48482.27276590854, 48591.75704121528, 55859.0, 55963.72018139964, 55998.440015600136, 56052.0, 56084.719576401854, 15928.0, 16148.708103351704, 16199.271032803552, 16202.513924582281, 16206.108664023592, 11891.28652280866, 11906.821397679041, 11922.105842061706, 11938.28370297785, 11938.403079845973, 14701.55895323142, 14800.629984250265, 15077.170755608548, 15133.924330378277, 15135.167565783988, 5689.886202275931, 6059.091136329585, 6103.35914728956, 6128.2033335666965, 6152.2924863640355, 864.8789169516273, 1019.4851599941982, 1030.9793304628363, 1120.5965852293168, 1156.919015668912, 29345.559816602767, 30861.0, 30908.53637195444, 31246.719094495205, 31408.371832563676, 1031.3141760729181, 1032.318669678024, 1072.5709716113618, 1099.3074363151163, 1113.437713954464, 14848.183349915858, 15747.685046299239, 15805.209739513208, 15880.0, 15945.521634350987, 484953.0, 491521.0, 493153.0, 493535.0, 494506.0, 47989.76005119952, 48314.0, 48369.0, 48422.757886211046, 48518.0, 1331.7669407853587, 1346.0577595683062, 1372.2041216094642, 1375.6698392385756, 1376.5526203983745, 27988.16035518938, 28605.427891442472, 29441.85279073591, 29837.165469280382, 30037.849810750806, 46305.768471157426, 46588.0, 46718.299225510964, 46725.2991205139, 46815.0, 405894.0, 408090.0, 409938.0, 410553.0, 411550.0, 25525.3618659535, 25681.357966050997, 26247.60628590611, 26485.470290594465, 26594.0, 44850.775746121064, 45399.773001136105, 45916.54083459123, 46139.077218456114, 46520.53479465162, 38927.416088758124, 39241.80379098086, 39465.802670986464, 40511.59488405196, 40755.0, 36740.26519469542, 38832.223355532165, 39084.0, 39875.60124398835, 41208.58791412047, 37246.813765930994, 38296.61703382931, 38597.80701096589, 38711.0, 38796.030099246615, 33011.834940825145, 35809.64190358063, 36314.8184259077, 36351.0, 36495.81752091223, 27142.72857271481, 27164.32089197707, 27543.31141721473, 27737.167884963485, 28022.71977280201], "value": 18937.18217926716, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.69273734643616, 389.890830567441, 394.2548583177793, 397.1778418673346, 416.5001997602877, 16086.75869861953, 16801.07594082325, 17807.198676059576, 19403.320883769073, 19443.319483818068, 11294.717632059183, 11458.427078646077, 11676.649700508999, 11893.643190704272, 11902.7619447611, 4958.87602809929, 5226.425093239741, 5260.842174734745, 5262.342207224097, 5271.683698978054, 5116.258142569325, 5133.512316329943, 5216.895662086756, 5219.634625576211, 5720.79977200798, 5676.091825307952, 5681.289838770153, 5683.658980461186, 5699.401562835905, 5733.713314334287, 5112.41207261166, 5169.069567477853, 5403.459654034585, 5644.435556444364, 5674.148877668342, 4963.751812409365, 4978.601711863079, 4982.9252561211615, 4996.1756310208775, 5022.974885125587, 12900.741985160337, 12910.677233069155, 13045.608631741063, 13396.732065358638, 13405.329733513285, 2031.3296612117965, 2076.4497408186844, 2166.10106805677, 2289.1530133850415, 2312.4450131968374, 9606.183474404685, 9657.806843863154, 9677.951610241975, 10025.248106391977, 10217.080462758313, 1785.1966615023161, 1859.470051035462, 1871.8876867388, 1932.6134773045446, 1945.9124339404761, 79243.20756792415, 84370.0, 84730.15269847345, 84913.15086849114, 86906.0, 9920.355176913621, 10234.590616375262, 10336.0, 10544.472776361152, 10657.84013239802, 14204.0, 14299.356528956221, 14363.784543231859, 14397.352119154662, 14523.273836308143, 7777.688892444352, 7818.459000824755, 7932.682692692228, 7972.083210430758, 8151.225633564802, 7628.9618551908, 7667.0416197975255, 7739.303462688273, 7861.0, 7875.684972601031, 4201.369794530784, 4283.807228674717, 4314.61168494837, 4401.239504198346, 4436.6007059364165, 1905.3521802587186, 1929.527265819855, 1959.7844237133904, 1961.2351183038627, 2025.5948810238012, 844.8056946902246, 902.7427183252742, 937.5546615357787, 950.083169741203, 1059.655611926127, 18164.545886352684, 18865.0, 19089.2364305429, 19108.713369299472, 19564.510887227934, 885.4687187687465, 931.1107891963159, 936.1527817325332, 952.3476418653245, 1001.7145113642576, 7586.810329741801, 10799.892001080047, 10830.025297723243, 10848.78302433947, 10912.23614347004, 445449.0, 450554.0, 457932.0, 459715.0, 461559.0, 89140.0, 89284.5535772317, 90008.0, 90474.54762726145, 91034.54482727544, 951.3578334624101, 972.6498460554195, 985.0248254228262, 998.0069830518536, 998.4308943902051, 16206.432774852823, 16473.0, 17203.0, 17266.395676151275, 17304.307827686753, 38888.222235555695, 39772.602273978046, 39958.40062399124, 40338.1932361357, 40989.0, 55490.72254638701, 57370.713146434, 58435.0, 58606.706966464895, 58920.705396472746, 5438.83683489496, 7997.720364741614, 8069.919300806917, 8224.83550329002, 8543.658253669784, 9251.167394934488, 12390.132690711564, 12908.0, 12937.676558086123, 13017.284049377375, 10969.670909872717, 11063.557457701923, 11277.21059525858, 11596.536138554364, 11735.295882247092, 11429.942850285695, 11459.713507162054, 11480.081593472336, 11542.884571154182, 11594.130440217186, 11300.604478843201, 11592.826107608562, 11687.0, 11709.707257318636, 11816.586419475278, 8046.235607617267, 8188.181181881764, 8200.466969646954, 8220.054693710299, 8739.257163141205, 9180.127887850644, 10630.096441802534, 10735.570577176826, 10972.780544389227, 11128.443577820915], "value": 8573.625886182972, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.1592618318284, 1471.1099784630298, 1604.7352186889163, 1733.4106403822698, 1751.1944505527456, 8345.165483451652, 8754.737357879258, 8999.325050621197, 9028.68399606014, 9072.954635226823, 9010.54947252638, 9169.954150229256, 9175.816483670322, 9181.21959633432, 9186.494742789144, 2269.2965180793967, 2294.598445272079, 2295.5753185660624, 2305.0664480885184, 2310.722713274401, 2231.419830843976, 2249.853759505635, 2318.686977258074, 2327.662488939103, 2328.429534763985, 2244.427670943907, 2254.2448279826276, 2277.749447560767, 2290.0267386360815, 2299.8045166160896, 2244.8316376271846, 2246.0454306919496, 2254.211026140854, 2256.1652188690127, 2280.9657855132186, 2213.7896899794496, 2216.767239439852, 2218.5119273759747, 2225.254539729193, 2225.810806081485, 8967.103289671046, 9038.457692538468, 9041.412308200011, 9051.773705657346, 9077.0, 5204.219367094928, 5390.110631745757, 5396.082665946798, 5401.297831281908, 5435.483629055233, 3143.811371317728, 3206.0862654143457, 3366.3267346530793, 3384.170878134848, 3389.4915762635555, 1030.428112397619, 1030.6186710916934, 1046.3146638951498, 1052.3896140238644, 1069.5561342043043, 11801.114916381306, 12256.754864902741, 12292.139550231488, 12567.497300107985, 12635.557755478514, 4392.7364358137975, 4498.977505112453, 4602.930956035662, 4610.861674149781, 4654.976725116353, 9665.178459830853, 9709.805803883883, 9747.853782193273, 9783.315167938175, 9810.65662701802, 5195.584353251731, 5277.182036784305, 5297.5232229099565, 5304.787808487617, 5313.44208858072, 4761.928571071437, 4934.8026078957155, 4951.702897826142, 4983.352164218701, 5051.191809310566, 3756.8121593920196, 3819.4843696101225, 3892.338302488584, 3915.5888631693833, 3934.0, 1153.529250205994, 1164.0338519029185, 1165.7027457998156, 1173.4308860202796, 1184.9703757405962, 736.488140742179, 884.8805411269396, 888.0054339140075, 891.7458524320538, 892.4868200784575, 5274.26160337553, 5573.857359241346, 5593.804216852391, 5706.400827913092, 5791.189233507313, 846.2341580869323, 899.0, 900.9504477253682, 931.3201363004908, 960.4237457525429, 3492.5983511895947, 3690.612485689018, 3766.303233901737, 3803.67668748154, 3846.3845784674318, 10535.262531622713, 11073.833892491619, 11114.555417783198, 11117.666470005914, 11132.220744547803, 10609.257351985441, 10856.022957933825, 10861.83707244392, 10876.564937402574, 10917.126629869592, 7797.532148071134, 8100.068492123363, 8126.228008339316, 8133.5526546039355, 8394.076651568323, 5501.835924742014, 5691.14632805066, 5706.743196556082, 5747.36778954323, 5779.248697669276, 9679.370840895319, 9899.0, 9914.851277230991, 9988.0, 10095.949520252352, 10070.798584028425, 10158.644447444303, 10160.33957792741, 10335.379877207391, 10388.272820902464, 7111.715531378687, 7312.305330993547, 7969.800754981172, 8098.838023239385, 8218.137095605114, 8444.155584441753, 8580.871286930576, 8587.871181932402, 8588.441751286146, 8604.698835540727, 7477.700891964478, 7642.694292228249, 7771.611419428893, 7773.067231932205, 7879.763607091796, 7429.851402972018, 7455.478116531791, 7574.3183113520045, 7669.271419215165, 7745.535267883945, 6578.671066446563, 6624.8343791405605, 6642.202935647753, 6660.500462465237, 6692.732290708317, 4520.932186017147, 4662.393888794435, 4669.7898594564, 4689.648276379217, 4759.904801903874, 4770.141374552614, 4783.115123702126, 4798.928016079832, 4907.33750943618, 5008.273800299009], "value": 4536.027085586466, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.8161348975068, 320.4952200284551, 328.08300799266055, 335.3176286257465, 336.3928109761882, 5265.0, 5365.812196573121, 5405.567554595633, 5437.238786569884, 5473.261109750182, 5195.844124676256, 5336.599755018379, 5355.223492593572, 5413.810516631918, 5458.4541545845395, 4235.729281215638, 4239.7668128252935, 4243.257429949762, 4244.469441319828, 4244.745315281078, 4131.256373852705, 4180.665546756252, 4186.079062606237, 4192.37114432836, 4247.299195632717, 4153.646940010103, 4154.293770059097, 4163.770992595406, 4165.791710414467, 4171.395147703581, 4112.465379500646, 4155.33514637658, 4161.042960119159, 4173.686973476971, 4178.811953462071, 3697.482352470656, 3706.3143318485895, 3707.610700876396, 3712.480252764615, 3733.383991641376, 5047.596192304643, 5186.92219616706, 5195.766190521435, 5202.297689811865, 5228.2680424740565, 4773.665843390964, 4790.568848803589, 4798.952010479886, 4813.676239034258, 4824.565789079, 5409.702466364349, 5589.664620122765, 5611.691356975365, 5633.971830140864, 5634.549236061105, 4043.4432743394004, 4067.3898915162667, 4067.755934643901, 4068.6338229559187, 4078.5921407858978, 5827.271591051119, 5828.5337173026055, 5837.482254613831, 5843.766249350021, 5861.3552509223955, 4187.183499217624, 4192.350185721218, 4202.831886724558, 4203.91592168155, 4205.516365617993, 3874.9225015499533, 4117.661759928035, 4126.277901367249, 4136.91726165475, 4137.358709400048, 4753.667243292936, 4776.785044672998, 4788.946431785002, 4795.112904112751, 4828.179209534387, 5714.257146570919, 5728.627639203439, 5731.828045158652, 5737.483626473638, 5746.339170995389, 1380.5168191133223, 1433.7490939085826, 1447.261896432827, 1451.4484495891493, 1454.5927140400704, 891.5497673674882, 905.0, 918.8621706743908, 925.1765928323797, 926.8795056642593, 4842.322074909515, 4858.441279252931, 4908.680935739166, 4909.2881532177635, 4912.287718280901, 5077.466865979019, 5087.949120508822, 5092.0, 5117.0, 5128.845759857661, 4891.6575839691595, 4922.753862306942, 4928.531789479994, 4939.6542242042715, 5199.2201169824075, 3097.6612657443484, 3138.544910987894, 3159.241781972356, 3159.6524382317925, 3160.873565057372, 6019.668918209541, 6037.758489660452, 6078.662694207267, 6107.816765497042, 6132.0070976932675, 5677.0, 5963.970180149072, 5989.55078369124, 6037.758489660452, 6039.698015099315, 6101.755929762849, 6113.602615829956, 6117.908231376533, 6126.908096378558, 6128.846778830565, 5563.610547261653, 5801.738921748447, 5882.617629854046, 5886.970565147147, 5916.674582897982, 5774.971125144348, 5827.79602713903, 5828.766849326149, 5840.474357307863, 5864.44287792659, 5970.253718285215, 6062.787802426894, 6083.954170476583, 6099.969500152471, 6118.235220597426, 3993.660538854114, 4060.451839001697, 4147.232761939051, 4148.651688201407, 4155.812988415468, 5819.388964158702, 5823.854403639943, 5840.182374467663, 5867.266591676041, 5885.735141918538, 5730.426957304237, 5737.655740655574, 5737.799177028784, 5738.22533957927, 5744.626599271034, 5532.419095995024, 5626.96144082191, 5668.744906479301, 5672.7730890763905, 5692.857678558069, 5668.744906479136, 5677.943220567907, 5691.459311365414, 5707.286589176353, 5713.428657134254, 5562.0, 5716.142578613075, 5748.103125968504, 5765.7117144141785, 5777.768889244383, 5532.474414930736, 5619.325680918316, 5625.718714064362, 5646.71766411686, 5647.830565083054], "value": 4281.802583055129, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.3119224813944, 728.8724473217189, 742.6138408027829, 745.8732015557355, 760.619261710845, 14364.569062928103, 14948.701025979473, 15067.773983390258, 15135.848641513581, 15168.620784480394, 13297.534586289481, 13398.062135650509, 13423.328833558331, 13425.530106446251, 13473.595792126227, 804.0351578106281, 828.9875651865227, 832.1803024021334, 832.2509741232878, 833.5123952487771, 795.2047952047952, 815.7389635316702, 820.1552401026952, 830.8919840420767, 831.8710599857002, 859.9269062129727, 871.020102384817, 874.1215078845751, 874.2525141004445, 879.7140929198036, 871.7471933139382, 872.3849685971375, 873.724776695339, 874.1127755328347, 876.4565969099135, 636.1856823266227, 638.5051585021599, 638.8850006998738, 642.3672682407824, 642.5470043619238, 15069.321880515294, 15156.924215378964, 15189.164595947219, 15208.239588020666, 15215.847841521554, 14664.266786660732, 14768.852311476856, 14932.50674932509, 15202.239888005555, 15236.847631523653, 10295.124914382286, 10473.633422830164, 10505.31715438494, 10577.0, 10731.195160363004, 3646.5441819772527, 3716.5005098555703, 3762.0, 3896.1623251000888, 3903.941440878389, 80404.0, 80662.59668701678, 81809.0, 82084.0, 82723.0, 11279.830802537968, 11304.717382065513, 11386.601468948547, 11411.315321080761, 11422.086233101332, 21693.34919952404, 21693.457663558536, 21771.891140544514, 21837.45406364822, 21890.562188756136, 7995.320397766255, 8096.230858068474, 8269.669213231404, 8324.876141720912, 8572.91427085721, 4562.384078149474, 4590.793414296365, 4670.95329046712, 4710.528947105262, 4913.70517768935, 3299.0, 3379.850850710721, 3386.9661303387143, 3397.8810741623925, 3432.828358582061, 568.4912003756615, 582.3322952197357, 583.6556431705229, 598.9401059893976, 602.5571205164201, 583.1981026089128, 590.7784580782206, 606.8379054111416, 618.6195489773756, 647.4334956912701, 8344.165583441607, 8776.210141087333, 8940.955295223483, 9076.137766912132, 9149.954250228839, 503.59209040677166, 515.4510446374599, 544.599719206383, 616.722474886303, 635.7838334966134, 4043.251998380309, 4227.97886010568, 4304.569543045733, 4335.6965012449455, 4377.365282034151, 66224.66887665531, 99616.5019174914, 101024.0, 104102.47948760208, 106039.0, 54364.18453723197, 75193.62403187949, 75395.24604753882, 86533.56733216293, 88012.55993720118, 24706.752932470805, 26364.340891477867, 36188.0, 74574.25425745781, 75088.0, 9296.116868897443, 9675.225981921289, 9891.9570208104, 9896.406215627085, 10068.647597334058, 44737.776311118236, 46094.76952615215, 47986.56208287721, 48118.75940620274, 49948.50051499438, 62137.0, 64051.0, 69574.65212673905, 70977.29022709707, 72625.63687181531, 11315.773684526428, 11486.19596628228, 11689.707757305796, 11711.531538738696, 11785.705357365792, 13485.730285394433, 13504.257265850472, 13646.385912634154, 13745.24401157906, 14368.928155359155, 11992.160548761503, 12251.142420030512, 12277.570285040338, 12341.197822141532, 12421.93789031049, 13141.408636611566, 13561.45754169822, 13774.65563360884, 14044.859551404355, 14216.360263788361, 12442.875571244173, 12686.936565317113, 12973.351332433152, 13010.869891301345, 13026.28355440422, 10159.0, 10505.00202480763, 10892.945535272273, 10936.945315273373, 11304.886951130713, 9758.316917815968, 9981.278256885997, 11070.446477675923, 11567.595134170264, 11655.125865559947], "value": 7069.746949173812, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 119.0, 111.0, 111.0, 112.0, 111.0, 111.0, 112.0, 111.0, 110.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 125.0, 165.0, 125.0, 125.0, 124.0, 125.0, 157.0, 130.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 163.0, 166.0, 176.0, 163.0, 162.0, 163.0, 163.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 103.0, 77.0, 76.0, 76.0, 75.0, 102.0, 74.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 112.0, 85.0, 83.0, 83.0, 105.0, 83.0, 83.0, 128.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 119.0, 118.0, 119.0, 119.0, 117.0, 120.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 149.0, 148.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 86.0, 86.0, 87.0, 86.0, 85.0, 86.0, 85.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 58.0, 60.0, 56.0, 55.0, 55.0, 60.0, 57.0, 55.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 61.0, 61.0, 60.0, 61.0, 60.0, 60.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 86.0, 79.0, 81.0, 85.0, 81.0, 80.0, 88.0, 81.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 140.0, 140.0, 143.0, 145.0, 142.0, 134.0, 150.0, 182.0, 136.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 168.0, 173.0, 167.0, 173.0, 174.0, 176.0, 166.0, 168.0, 168.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 68.0, 67.0, 69.0, 67.0, 67.0, 68.0, 71.0], "value": 68.6, "unit": "score"}]}]} 19:49:19 INFO - Return code: 0 19:49:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:49:19 ERROR - # TBPL SUCCESS # 19:49:19 INFO - Running post-action listener: _resource_record_post_action 19:49:19 INFO - [mozharness: 2016-10-21 02:49:19.410401Z] Finished run-tests step (success) 19:49:19 INFO - Running post-run listener: _resource_record_post_run 19:49:19 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 391843840; Read time: 36; Write time: 361980 19:49:19 INFO - TinderboxPrint: CPU usage
13.4% 19:49:19 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 36 19:49:19 INFO - TinderboxPrint: I/O write bytes / time
391,843,840 / 361,980 19:49:19 INFO - TinderboxPrint: CPU idle
8,264.5 (86.6%) 19:49:19 INFO - TinderboxPrint: CPU user
1,216.2 (12.7%) 19:49:19 INFO - TinderboxPrint: Swap in / out
0 / 0 19:49:19 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 102830080; Read time: 0; Write time: 88252 19:49:19 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287744000; Read time: 28; Write time: 273556 19:49:20 INFO - Running post-run listener: _upload_blobber_files 19:49:20 INFO - Blob upload gear active. 19:49:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:49:20 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 19:49:20 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'] 19:49:20 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 19:49:20 INFO - (blobuploader) - INFO - Open directory for files ... 19:49:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:49:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:49:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:49:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:49:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:49:21 INFO - (blobuploader) - INFO - Done attempting. 19:49:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:49:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:49:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:49:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:49:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:49:24 INFO - (blobuploader) - INFO - Done attempting. 19:49:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:49:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:49:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:49:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:49:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:49:25 INFO - (blobuploader) - INFO - Done attempting. 19:49:25 INFO - (blobuploader) - INFO - Iteration through files over. 19:49:25 INFO - Return code: 0 19:49:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:49:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:49:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eafb9bb28f1ac74c948040d6dc8dfeed26ec889462f6f5fe4adc014ffac3a5d715264233c5e88e0792baac24ba82b859dd1a2bdc3d43066bd6a1ff8f8c31e0af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/975e04b0ddc128353e326807ddbd19282d25ec35cb5681f005ea0673b1c24ed26b5f33dadcbc89d523f33b21e2f09b82c84a323a9f24b979661dd859c71a7485", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/26236e5d439ee0808e491a539cdf6a557501fb995c7a6e873c97716cc2d0ff95ef93450dd9a3e6712be20953b539849fd711dbd8b1d7ab160aa866c8655d4d93"} 19:49:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:49:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:49:25 INFO - Contents: 19:49:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eafb9bb28f1ac74c948040d6dc8dfeed26ec889462f6f5fe4adc014ffac3a5d715264233c5e88e0792baac24ba82b859dd1a2bdc3d43066bd6a1ff8f8c31e0af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/975e04b0ddc128353e326807ddbd19282d25ec35cb5681f005ea0673b1c24ed26b5f33dadcbc89d523f33b21e2f09b82c84a323a9f24b979661dd859c71a7485", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/26236e5d439ee0808e491a539cdf6a557501fb995c7a6e873c97716cc2d0ff95ef93450dd9a3e6712be20953b539849fd711dbd8b1d7ab160aa866c8655d4d93"} 19:49:25 INFO - Running post-run listener: copy_logs_to_upload_dir 19:49:25 INFO - Copying logs to upload dir... 19:49:25 INFO - mkdir: /builds/slave/test/build/upload/logs 19:49:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.238193 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-20 19:49:25.212595) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 19:49:25.216654) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eafb9bb28f1ac74c948040d6dc8dfeed26ec889462f6f5fe4adc014ffac3a5d715264233c5e88e0792baac24ba82b859dd1a2bdc3d43066bd6a1ff8f8c31e0af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/975e04b0ddc128353e326807ddbd19282d25ec35cb5681f005ea0673b1c24ed26b5f33dadcbc89d523f33b21e2f09b82c84a323a9f24b979661dd859c71a7485", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/26236e5d439ee0808e491a539cdf6a557501fb995c7a6e873c97716cc2d0ff95ef93450dd9a3e6712be20953b539849fd711dbd8b1d7ab160aa866c8655d4d93"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477002865/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eafb9bb28f1ac74c948040d6dc8dfeed26ec889462f6f5fe4adc014ffac3a5d715264233c5e88e0792baac24ba82b859dd1a2bdc3d43066bd6a1ff8f8c31e0af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/975e04b0ddc128353e326807ddbd19282d25ec35cb5681f005ea0673b1c24ed26b5f33dadcbc89d523f33b21e2f09b82c84a323a9f24b979661dd859c71a7485", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/26236e5d439ee0808e491a539cdf6a557501fb995c7a6e873c97716cc2d0ff95ef93450dd9a3e6712be20953b539849fd711dbd8b1d7ab160aa866c8655d4d93"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 19:49:25.243301) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 19:49:25.243656) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1477016926.519723-730192908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004396 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 19:49:25.329517) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 19:49:25.329866) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 19:49:25.330217) ========= ========= Total master_lag: 0.17 =========