builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1477069524.29 results: success (0) buildid: 20161021100238 builduid: 58b40e8ec71e440c80f99d7e22c33342 revision: d3de60b2f63081c33db27c86c56ee7de2b6bec08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-21 10:05:24.292426) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-21 10:05:24.293173) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-21 10:05:24.293637) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-21 10:05:24.309793) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 10:05:24.310181) ========= 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=17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-21 10:05:24-- 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% 224M=0s 2016-10-21 10:05:24 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099938 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 10:05:24.424031) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 10:05:24.424403) ========= 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=17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017446 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 10:05:24.473850) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-21 10:05:24.474207) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d3de60b2f63081c33db27c86c56ee7de2b6bec08 --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 d3de60b2f63081c33db27c86c56ee7de2b6bec08 --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=17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-21 10:05:24,846 truncating revision to first 12 chars 2016-10-21 10:05:24,846 Setting DEBUG logging. 2016-10-21 10:05:24,846 attempt 1/10 2016-10-21 10:05:24,846 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d3de60b2f630?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-21 10:05:25,771 unpacking tar archive at: mozilla-inbound-d3de60b2f630/testing/mozharness/ program finished with exit code 0 elapsedTime=1.256383 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-21 10:05:25.743812) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-21 10:05:25.744145) ========= script_repo_revision: d3de60b2f63081c33db27c86c56ee7de2b6bec08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-21 10:05:25.744527) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-21 10:05:25.744787) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-21 10:05:25.754485) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-21 10:05:25.754852) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:05:26 INFO - MultiFileLogger online at 20161021 10:05:26 in /builds/slave/test 10:05:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 10:05:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:05:26 INFO - {'append_to_log': False, 10:05:26 INFO - 'base_work_dir': '/builds/slave/test', 10:05:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:05:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:05:26 INFO - 'branch': 'Mozilla-Inbound', 10:05:26 INFO - 'buildbot_json_path': 'buildprops.json', 10:05:26 INFO - 'config_files': ('talos/linux_config.py',), 10:05:26 INFO - 'default_actions': ('clobber', 10:05:26 INFO - 'read-buildbot-config', 10:05:26 INFO - 'download-and-extract', 10:05:26 INFO - 'populate-webroot', 10:05:26 INFO - 'create-virtualenv', 10:05:26 INFO - 'install', 10:05:26 INFO - 'run-tests'), 10:05:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:05:26 INFO - 'download_minidump_stackwalk': True, 10:05:26 INFO - 'download_symbols': 'ondemand', 10:05:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:05:26 INFO - 'tooltool.py': '/tools/tooltool.py', 10:05:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:05:26 INFO - '/tools/misc-python/virtualenv.py')}, 10:05:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:05:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:05:26 INFO - 'installer_path': 'installer.exe', 10:05:26 INFO - 'log_level': 'info', 10:05:26 INFO - 'log_name': 'talos', 10:05:26 INFO - 'log_to_console': True, 10:05:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:05:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:05:26 INFO - 'opt_config_files': (), 10:05:26 INFO - 'pip_index': False, 10:05:26 INFO - 'sps_profile': False, 10:05:26 INFO - 'sps_profile_interval': 0, 10:05:26 INFO - 'suite': 'dromaeojs', 10:05:26 INFO - 'system_bits': '32', 10:05:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:05:26 INFO - 'title': 'talos-linux64-ix-009', 10:05:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:05:26 INFO - 'use_talos_json': True, 10:05:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:05:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:05:26 INFO - 'work_dir': 'build'} 10:05:26 INFO - [mozharness: 2016-10-21 17:05:26.229018Z] Running clobber step. 10:05:26 INFO - Running pre-action listener: _resource_record_pre_action 10:05:26 INFO - Running main action method: clobber 10:05:26 INFO - rmtree: /builds/slave/test/build 10:05:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:05:27 INFO - Running post-action listener: _resource_record_post_action 10:05:27 INFO - [mozharness: 2016-10-21 17:05:27.215504Z] Finished clobber step (success) 10:05:27 INFO - [mozharness: 2016-10-21 17:05:27.215602Z] Running read-buildbot-config step. 10:05:27 INFO - Running pre-action listener: _resource_record_pre_action 10:05:27 INFO - Running main action method: read_buildbot_config 10:05:27 INFO - Using buildbot properties: 10:05:27 INFO - { 10:05:27 INFO - "project": "", 10:05:27 INFO - "product": "firefox", 10:05:27 INFO - "script_repo_revision": "production", 10:05:27 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 10:05:27 INFO - "repository": "", 10:05:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 10:05:27 INFO - "buildid": "20161021100238", 10:05:27 INFO - "stage_platform": "linux64-pgo", 10:05:27 INFO - "basedir": "/builds/slave/test", 10:05:27 INFO - "buildnumber": 2615, 10:05:27 INFO - "platform": "ubuntu64_hw", 10:05:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:05:27 INFO - "slavebuilddir": "test", 10:05:27 INFO - "branch": "mozilla-inbound", 10:05:27 INFO - "revision": "d3de60b2f63081c33db27c86c56ee7de2b6bec08", 10:05:27 INFO - "slavename": "talos-linux64-ix-009", 10:05:27 INFO - "builduid": "58b40e8ec71e440c80f99d7e22c33342", 10:05:27 INFO - "repo_path": "integration/mozilla-inbound" 10:05:27 INFO - } 10:05:27 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:05:27 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 10:05:27 INFO - Running post-action listener: _resource_record_post_action 10:05:27 INFO - [mozharness: 2016-10-21 17:05:27.217957Z] Finished read-buildbot-config step (success) 10:05:27 INFO - [mozharness: 2016-10-21 17:05:27.218045Z] Running download-and-extract step. 10:05:27 INFO - Running pre-action listener: _resource_record_pre_action 10:05:27 INFO - Running main action method: download_and_extract 10:05:27 INFO - mkdir: /builds/slave/test/build/tests 10:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:27 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:05:27 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/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 10:05:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/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 10:05:27 INFO - Downloaded 1361 bytes. 10:05:27 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:05:27 INFO - Using the following test package requirements: 10:05:27 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:27 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:05:27 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:05:27 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:27 INFO - u'jsshell-linux-x86_64.zip'], 10:05:27 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:05:27 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:27 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:05:27 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:05:27 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:05:27 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:05:27 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:05:27 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/1477062241/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:05:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:05:27 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:05:27 INFO - Http code: 200 10:05:27 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 10:05:27 INFO - x-amz-cf-id: cg5OztkjKFt19oFtOIaVxxRRFc_XHTKJ0XhhOzVvhgW5TX6dUPKFbQ== 10:05:27 INFO - x-amz-replication-status: COMPLETED 10:05:27 INFO - x-amz-version-id: KgUXjbME5y5CghyAT64wZY1ON7Yk2sX. 10:05:27 INFO - Expected file size: 22120409 10:05:27 INFO - Obtained file size: 22120409 10:05:31 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 10:05:31 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/1477062241/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:05:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:05:31 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:05:31 INFO - Http code: 200 10:05:31 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 10:05:31 INFO - x-amz-cf-id: AMcvDxcSE2Yd3HmjPsI9yPWXFJNjwt4Pbbz33GQwmHnzfQ7SqYiOmw== 10:05:31 INFO - x-amz-replication-status: COMPLETED 10:05:31 INFO - x-amz-version-id: KgUXjbME5y5CghyAT64wZY1ON7Yk2sX. 10:05:32 INFO - Expected file size: 22120409 10:05:32 INFO - Obtained file size: 22120409 10:05:36 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/1477062241/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:05:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:05:36 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:05:36 INFO - Http code: 200 10:05:36 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 10:05:36 INFO - x-amz-cf-id: kIE_NILeUc4WBRXo90Vmav82cw6o_PLbChD_7-HUU84UXODqbqFMBA== 10:05:36 INFO - x-amz-replication-status: COMPLETED 10:05:36 INFO - x-amz-version-id: MVQ6PylNiGVH5HwtcqYLg6MBSQEY0toD 10:05:36 INFO - Expected file size: 14409028 10:05:36 INFO - Obtained file size: 14409028 10:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:37 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:05:37 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/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 10:05:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/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 10:05:37 INFO - Downloaded 59469316 bytes. 10:05:37 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:05:37 INFO - mkdir: /builds/slave/test/properties 10:05:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:05:37 INFO - Writing to file /builds/slave/test/properties/build_url 10:05:37 INFO - Contents: 10:05:37 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:05:38 INFO - Running post-action listener: _resource_record_post_action 10:05:38 INFO - Running post-action listener: set_extra_try_arguments 10:05:38 INFO - [mozharness: 2016-10-21 17:05:38.153320Z] Finished download-and-extract step (success) 10:05:38 INFO - [mozharness: 2016-10-21 17:05:38.153582Z] Running populate-webroot step. 10:05:38 INFO - Running pre-action listener: _resource_record_pre_action 10:05:38 INFO - Running main action method: populate_webroot 10:05:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:05:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:05:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:05:38 INFO - '--tppagecycles', 10:05:38 INFO - '7'], 10:05:38 INFO - 'tests': ['tsvgm']}}, 10:05:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:05:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:05:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:05:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:05:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:05:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:05:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:38 INFO - 'talos_options': ['--disable-e10s'], 10:05:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:38 INFO - 'talos_options': ['--disable-e10s'], 10:05:38 INFO - 'tests': ['damp', 'tps']}, 10:05:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:38 INFO - 'tests': ['damp', 'tps']}, 10:05:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:05:38 INFO - 'tests': ['dromaeo_dom']}, 10:05:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:05:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:05:38 INFO - 'tests': ['basic_compositor_video']}, 10:05:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:05:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:05:38 INFO - 'tests': ['a11yr', 10:05:38 INFO - 'ts_paint', 10:05:38 INFO - 'tpaint', 10:05:38 INFO - 'sessionrestore', 10:05:38 INFO - 'sessionrestore_no_auto_restore', 10:05:38 INFO - 'tabpaint']}, 10:05:38 INFO - 'other-e10s': {'tests': ['a11yr', 10:05:38 INFO - 'ts_paint', 10:05:38 INFO - 'tpaint', 10:05:38 INFO - 'sessionrestore', 10:05:38 INFO - 'sessionrestore_no_auto_restore', 10:05:38 INFO - 'tabpaint']}, 10:05:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:05:38 INFO - 'ts_paint', 10:05:38 INFO - 'tpaint', 10:05:38 INFO - 'sessionrestore', 10:05:38 INFO - 'sessionrestore_no_auto_restore', 10:05:38 INFO - 'tabpaint']}, 10:05:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:05:38 INFO - 'ts_paint', 10:05:38 INFO - 'tpaint', 10:05:38 INFO - 'sessionrestore', 10:05:38 INFO - 'sessionrestore_no_auto_restore', 10:05:38 INFO - 'tabpaint']}, 10:05:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:05:38 INFO - 'tests': ['a11yr', 10:05:38 INFO - 'ts_paint', 10:05:38 INFO - 'tpaint', 10:05:38 INFO - 'sessionrestore', 10:05:38 INFO - 'sessionrestore_no_auto_restore', 10:05:38 INFO - 'tabpaint']}, 10:05:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:05:38 INFO - 'tests': ['a11yr', 10:05:38 INFO - 'ts_paint', 10:05:38 INFO - 'tpaint', 10:05:38 INFO - 'sessionrestore', 10:05:38 INFO - 'sessionrestore_no_auto_restore', 10:05:38 INFO - 'tabpaint']}, 10:05:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:05:38 INFO - 'tests': ['tsvgx', 10:05:38 INFO - 'tsvgr_opacity', 10:05:38 INFO - 'tart', 10:05:38 INFO - 'tscrollx', 10:05:38 INFO - 'cart']}, 10:05:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:05:38 INFO - 'tsvgr_opacity', 10:05:38 INFO - 'tart', 10:05:38 INFO - 'tscrollx', 10:05:38 INFO - 'cart']}, 10:05:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:38 INFO - 'talos_options': ['--disable-e10s'], 10:05:38 INFO - 'tests': ['tp5o']}, 10:05:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:38 INFO - 'tests': ['tp5o']}, 10:05:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:38 INFO - 'talos_options': ['--disable-e10s', 10:05:38 INFO - '--xperf_path', 10:05:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:38 INFO - 'tests': ['tp5n']}, 10:05:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:38 INFO - 'talos_options': ['--xperf_path', 10:05:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:38 INFO - 'tests': ['tp5n']}}, 10:05:38 INFO - 'talos.zip': {'path': '', 10:05:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:05:38 INFO - Running post-action listener: _resource_record_post_action 10:05:38 INFO - [mozharness: 2016-10-21 17:05:38.174781Z] Finished populate-webroot step (success) 10:05:38 INFO - [mozharness: 2016-10-21 17:05:38.174869Z] Running create-virtualenv step. 10:05:38 INFO - Running pre-action listener: _resource_record_pre_action 10:05:38 INFO - Running main action method: create_virtualenv 10:05:38 INFO - Creating virtualenv /builds/slave/test/build/venv 10:05:38 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 10:05:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:05:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:05:38 INFO - Using real prefix '/usr' 10:05:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:05:38 INFO - Installing distribute.............................................................................................................................................................................................done. 10:05:40 INFO - Installing pip.................done. 10:05:40 INFO - Return code: 0 10:05:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:05:40 INFO - Reading from file tmpfile_stdout 10:05:40 INFO - Output received: 10:05:40 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) 10:05:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f10ac0b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1351ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134ef60>, '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 0x134fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13501d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', '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 10:05:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:05:40 INFO - Using env: {'DISPLAY': ':0', 10:05:40 INFO - 'HOME': '/home/cltbld', 10:05:40 INFO - 'LANG': 'en_US.UTF-8', 10:05:40 INFO - 'LANGUAGE': 'en_US:en', 10:05:40 INFO - 'LOGNAME': 'cltbld', 10:05:40 INFO - 'MAIL': '/var/mail/cltbld', 10:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:40 INFO - 'MOZ_NO_REMOTE': '1', 10:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:40 INFO - 'NO_EM_RESTART': '1', 10:05:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:40 INFO - 'PWD': '/builds/slave/test', 10:05:40 INFO - 'SHELL': '/bin/bash', 10:05:40 INFO - 'SHLVL': '1', 10:05:40 INFO - 'TERM': 'linux', 10:05:40 INFO - 'TMOUT': '86400', 10:05:40 INFO - 'USER': 'cltbld', 10:05:40 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', 10:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:40 INFO - '_': '/tools/buildbot/bin/python'} 10:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:41 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 10:05:41 INFO - Cleaning up... 10:05:41 INFO - Return code: 0 10:05:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:41 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 0x7f10ac0b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1351ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134ef60>, '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 0x134fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13501d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', '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 10:05:41 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 10:05:41 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 10:05:41 INFO - Using env: {'DISPLAY': ':0', 10:05:41 INFO - 'HOME': '/home/cltbld', 10:05:41 INFO - 'LANG': 'en_US.UTF-8', 10:05:41 INFO - 'LANGUAGE': 'en_US:en', 10:05:41 INFO - 'LOGNAME': 'cltbld', 10:05:41 INFO - 'MAIL': '/var/mail/cltbld', 10:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:41 INFO - 'MOZ_NO_REMOTE': '1', 10:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:41 INFO - 'NO_EM_RESTART': '1', 10:05:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:41 INFO - 'PWD': '/builds/slave/test', 10:05:41 INFO - 'SHELL': '/bin/bash', 10:05:41 INFO - 'SHLVL': '1', 10:05:41 INFO - 'TERM': 'linux', 10:05:41 INFO - 'TMOUT': '86400', 10:05:41 INFO - 'USER': 'cltbld', 10:05:41 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', 10:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:41 INFO - '_': '/tools/buildbot/bin/python'} 10:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:41 INFO - Downloading/unpacking psutil>=3.1.1 10:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:05:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:43 INFO - Installing collected packages: psutil 10:05:43 INFO - Running setup.py install for psutil 10:05:43 INFO - building 'psutil._psutil_linux' extension 10:05:43 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 10:05:43 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 10:05:43 INFO - building 'psutil._psutil_posix' extension 10:05:43 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 10:05:43 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 10:05:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:44 INFO - Successfully installed psutil 10:05:44 INFO - Cleaning up... 10:05:44 INFO - Return code: 0 10:05:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:44 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 0x7f10ac0b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1351ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134ef60>, '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 0x134fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13501d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', '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 10:05:44 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 10:05:44 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 10:05:44 INFO - Using env: {'DISPLAY': ':0', 10:05:44 INFO - 'HOME': '/home/cltbld', 10:05:44 INFO - 'LANG': 'en_US.UTF-8', 10:05:44 INFO - 'LANGUAGE': 'en_US:en', 10:05:44 INFO - 'LOGNAME': 'cltbld', 10:05:44 INFO - 'MAIL': '/var/mail/cltbld', 10:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:44 INFO - 'MOZ_NO_REMOTE': '1', 10:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:44 INFO - 'NO_EM_RESTART': '1', 10:05:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:44 INFO - 'PWD': '/builds/slave/test', 10:05:44 INFO - 'SHELL': '/bin/bash', 10:05:44 INFO - 'SHLVL': '1', 10:05:44 INFO - 'TERM': 'linux', 10:05:44 INFO - 'TMOUT': '86400', 10:05:44 INFO - 'USER': 'cltbld', 10:05:44 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', 10:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:44 INFO - '_': '/tools/buildbot/bin/python'} 10:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:05:44 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 10:05:44 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 10:05:44 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 10:05:44 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 10:05:44 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 10:05:44 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 10:05:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:05:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:05:46 INFO - Installing collected packages: mozsystemmonitor 10:05:46 INFO - Running setup.py install for mozsystemmonitor 10:05:46 INFO - Successfully installed mozsystemmonitor 10:05:46 INFO - Cleaning up... 10:05:46 INFO - Return code: 0 10:05:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f10ac0b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1351ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134ef60>, '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 0x134fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13501d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', '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 10:05:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:05:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:05:46 INFO - Using env: {'DISPLAY': ':0', 10:05:46 INFO - 'HOME': '/home/cltbld', 10:05:46 INFO - 'LANG': 'en_US.UTF-8', 10:05:46 INFO - 'LANGUAGE': 'en_US:en', 10:05:46 INFO - 'LOGNAME': 'cltbld', 10:05:46 INFO - 'MAIL': '/var/mail/cltbld', 10:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:46 INFO - 'MOZ_NO_REMOTE': '1', 10:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:46 INFO - 'NO_EM_RESTART': '1', 10:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:46 INFO - 'PWD': '/builds/slave/test', 10:05:46 INFO - 'SHELL': '/bin/bash', 10:05:46 INFO - 'SHLVL': '1', 10:05:46 INFO - 'TERM': 'linux', 10:05:46 INFO - 'TMOUT': '86400', 10:05:46 INFO - 'USER': 'cltbld', 10:05:46 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', 10:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:46 INFO - '_': '/tools/buildbot/bin/python'} 10:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:46 INFO - Downloading/unpacking jsonschema==2.5.1 10:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:05:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:48 INFO - Downloading functools32-3.2.3-2.tar.gz 10:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:05:48 INFO - warning: no files found matching '*.txt' 10:05:48 INFO - no previously-included directories found matching 'build' 10:05:48 INFO - no previously-included directories found matching 'dist' 10:05:48 INFO - no previously-included directories found matching '.git*' 10:05:48 INFO - Installing collected packages: jsonschema, functools32 10:05:48 INFO - Running setup.py install for functools32 10:05:48 INFO - warning: no files found matching '*.txt' 10:05:48 INFO - no previously-included directories found matching 'build' 10:05:48 INFO - no previously-included directories found matching 'dist' 10:05:48 INFO - no previously-included directories found matching '.git*' 10:05:48 INFO - Successfully installed jsonschema functools32 10:05:48 INFO - Cleaning up... 10:05:49 INFO - Return code: 0 10:05:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:49 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 0x7f10ac0b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1351ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134ef60>, '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 0x134fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13501d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', '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 10:05:49 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 10:05:49 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 10:05:49 INFO - Using env: {'DISPLAY': ':0', 10:05:49 INFO - 'HOME': '/home/cltbld', 10:05:49 INFO - 'LANG': 'en_US.UTF-8', 10:05:49 INFO - 'LANGUAGE': 'en_US:en', 10:05:49 INFO - 'LOGNAME': 'cltbld', 10:05:49 INFO - 'MAIL': '/var/mail/cltbld', 10:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:49 INFO - 'MOZ_NO_REMOTE': '1', 10:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:49 INFO - 'NO_EM_RESTART': '1', 10:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:49 INFO - 'PWD': '/builds/slave/test', 10:05:49 INFO - 'SHELL': '/bin/bash', 10:05:49 INFO - 'SHLVL': '1', 10:05:49 INFO - 'TERM': 'linux', 10:05:49 INFO - 'TMOUT': '86400', 10:05:49 INFO - 'USER': 'cltbld', 10:05:49 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', 10:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:49 INFO - '_': '/tools/buildbot/bin/python'} 10:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:05:49 INFO - Cleaning up... 10:05:49 INFO - Return code: 0 10:05:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:49 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 0x7f10ac0b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1351ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134ef60>, '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 0x134fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13501d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', '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 10:05:49 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 10:05:49 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 10:05:49 INFO - Using env: {'DISPLAY': ':0', 10:05:49 INFO - 'HOME': '/home/cltbld', 10:05:49 INFO - 'LANG': 'en_US.UTF-8', 10:05:49 INFO - 'LANGUAGE': 'en_US:en', 10:05:49 INFO - 'LOGNAME': 'cltbld', 10:05:49 INFO - 'MAIL': '/var/mail/cltbld', 10:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:49 INFO - 'MOZ_NO_REMOTE': '1', 10:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:49 INFO - 'NO_EM_RESTART': '1', 10:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:49 INFO - 'PWD': '/builds/slave/test', 10:05:49 INFO - 'SHELL': '/bin/bash', 10:05:49 INFO - 'SHLVL': '1', 10:05:49 INFO - 'TERM': 'linux', 10:05:49 INFO - 'TMOUT': '86400', 10:05:49 INFO - 'USER': 'cltbld', 10:05:49 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', 10:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:49 INFO - '_': '/tools/buildbot/bin/python'} 10:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:49 INFO - Downloading/unpacking blobuploader==1.2.4 10:05:49 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 10:05:49 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 10:05:49 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 10:05:49 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 10:05:49 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 10:05:49 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 10:05:51 INFO - Downloading blobuploader-1.2.4.tar.gz 10:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:05:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:05:51 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 10:05:51 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 10:05:51 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 10:05:51 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 10:05:51 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 10:05:51 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 10:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:05:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:05:51 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 10:05:51 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 10:05:51 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 10:05:51 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 10:05:51 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 10:05:51 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 10:05:52 INFO - Downloading docopt-0.6.1.tar.gz 10:05:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:05:52 INFO - Installing collected packages: blobuploader, requests, docopt 10:05:52 INFO - Running setup.py install for blobuploader 10:05:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:05:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:05:52 INFO - Running setup.py install for requests 10:05:52 INFO - Running setup.py install for docopt 10:05:52 INFO - Successfully installed blobuploader requests docopt 10:05:52 INFO - Cleaning up... 10:05:52 INFO - Return code: 0 10:05:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:52 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 0x7f10ac0b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1351ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134ef60>, '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 0x134fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13501d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', '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 10:05:52 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 10:05:52 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 10:05:52 INFO - Using env: {'DISPLAY': ':0', 10:05:52 INFO - 'HOME': '/home/cltbld', 10:05:52 INFO - 'LANG': 'en_US.UTF-8', 10:05:52 INFO - 'LANGUAGE': 'en_US:en', 10:05:52 INFO - 'LOGNAME': 'cltbld', 10:05:52 INFO - 'MAIL': '/var/mail/cltbld', 10:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:52 INFO - 'MOZ_NO_REMOTE': '1', 10:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:52 INFO - 'NO_EM_RESTART': '1', 10:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:52 INFO - 'PWD': '/builds/slave/test', 10:05:52 INFO - 'SHELL': '/bin/bash', 10:05:52 INFO - 'SHLVL': '1', 10:05:52 INFO - 'TERM': 'linux', 10:05:52 INFO - 'TMOUT': '86400', 10:05:52 INFO - 'USER': 'cltbld', 10:05:52 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', 10:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:52 INFO - '_': '/tools/buildbot/bin/python'} 10:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:52 INFO - Running setup.py (path:/tmp/pip-unjZxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:53 INFO - Running setup.py (path:/tmp/pip-gYCjTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:53 INFO - Running setup.py (path:/tmp/pip-C7uz5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:53 INFO - Running setup.py (path:/tmp/pip-5dzARv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:53 INFO - Running setup.py (path:/tmp/pip-YrOken-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:53 INFO - Running setup.py (path:/tmp/pip-bzwnwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:53 INFO - Running setup.py (path:/tmp/pip-NxUTqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:53 INFO - Running setup.py (path:/tmp/pip-hd7a6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:53 INFO - Running setup.py (path:/tmp/pip-8rEjsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:53 INFO - Running setup.py (path:/tmp/pip-38KS9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:53 INFO - Running setup.py (path:/tmp/pip-bxRN40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:53 INFO - Running setup.py (path:/tmp/pip-LXRwj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:53 INFO - Running setup.py (path:/tmp/pip-B1t2J1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:53 INFO - Running setup.py (path:/tmp/pip-6B6z5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:54 INFO - Running setup.py (path:/tmp/pip-Rp1eZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:54 INFO - Running setup.py (path:/tmp/pip-YYRhmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:54 INFO - Running setup.py (path:/tmp/pip-smqnlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:05:54 INFO - Running setup.py install for manifestparser 10:05:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:05:54 INFO - Running setup.py install for mozcrash 10:05:54 INFO - Running setup.py install for mozdebug 10:05:54 INFO - Running setup.py install for mozdevice 10:05:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:05:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:05:54 INFO - Running setup.py install for mozfile 10:05:54 INFO - Running setup.py install for mozhttpd 10:05:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:05:54 INFO - Running setup.py install for mozinfo 10:05:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:05:54 INFO - Running setup.py install for mozInstall 10:05:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Running setup.py install for mozleak 10:05:55 INFO - Running setup.py install for mozlog 10:05:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Running setup.py install for moznetwork 10:05:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Running setup.py install for mozprocess 10:05:55 INFO - Running setup.py install for mozprofile 10:05:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Running setup.py install for mozrunner 10:05:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Running setup.py install for mozscreenshot 10:05:55 INFO - Running setup.py install for moztest 10:05:55 INFO - Running setup.py install for mozversion 10:05:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:05:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:05:56 INFO - Cleaning up... 10:05:56 INFO - Return code: 0 10:05:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:56 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 0x7f10ac0b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1351ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134ef60>, '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 0x134fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13501d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', '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 10:05:56 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 10:05:56 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 10:05:56 INFO - Using env: {'DISPLAY': ':0', 10:05:56 INFO - 'HOME': '/home/cltbld', 10:05:56 INFO - 'LANG': 'en_US.UTF-8', 10:05:56 INFO - 'LANGUAGE': 'en_US:en', 10:05:56 INFO - 'LOGNAME': 'cltbld', 10:05:56 INFO - 'MAIL': '/var/mail/cltbld', 10:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:56 INFO - 'MOZ_NO_REMOTE': '1', 10:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:56 INFO - 'NO_EM_RESTART': '1', 10:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:56 INFO - 'PWD': '/builds/slave/test', 10:05:56 INFO - 'SHELL': '/bin/bash', 10:05:56 INFO - 'SHLVL': '1', 10:05:56 INFO - 'TERM': 'linux', 10:05:56 INFO - 'TMOUT': '86400', 10:05:56 INFO - 'USER': 'cltbld', 10:05:56 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', 10:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:56 INFO - '_': '/tools/buildbot/bin/python'} 10:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:56 INFO - Running setup.py (path:/tmp/pip-PrPg6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:56 INFO - Running setup.py (path:/tmp/pip-wlsyRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:56 INFO - Running setup.py (path:/tmp/pip-eMM61g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:56 INFO - Running setup.py (path:/tmp/pip-XuGQ8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:56 INFO - Running setup.py (path:/tmp/pip-51FcbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:56 INFO - Running setup.py (path:/tmp/pip-axdQAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:56 INFO - Running setup.py (path:/tmp/pip-2Q2yAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:56 INFO - Running setup.py (path:/tmp/pip-rbZXXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:56 INFO - Running setup.py (path:/tmp/pip-iDZ56C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:56 INFO - Running setup.py (path:/tmp/pip-gk_YMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:56 INFO - Running setup.py (path:/tmp/pip-AH8uFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:57 INFO - Running setup.py (path:/tmp/pip-QUGzh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:57 INFO - Running setup.py (path:/tmp/pip-Kd066_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:57 INFO - Running setup.py (path:/tmp/pip-1Etrc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:57 INFO - Running setup.py (path:/tmp/pip-B63Aji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:57 INFO - Running setup.py (path:/tmp/pip-SobbG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:57 INFO - Running setup.py (path:/tmp/pip-QpUckP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:57 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)) 10:05:57 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)) 10:05:57 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)) 10:05:57 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)) 10:05:57 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)) 10:05:57 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)) 10:05:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:05:57 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 10:05:57 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 10:05:57 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 10:05:57 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 10:05:57 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 10:05:57 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 10:05:59 INFO - Downloading blessings-1.6.tar.gz 10:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:05:59 INFO - Installing collected packages: blessings 10:05:59 INFO - Running setup.py install for blessings 10:05:59 INFO - Successfully installed blessings 10:05:59 INFO - Cleaning up... 10:05:59 INFO - Return code: 0 10:05:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:05:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:59 INFO - Reading from file tmpfile_stdout 10:05:59 INFO - Current package versions: 10:05:59 INFO - argparse == 1.2.1 10:05:59 INFO - blessings == 1.6 10:05:59 INFO - blobuploader == 1.2.4 10:05:59 INFO - docopt == 0.6.1 10:05:59 INFO - functools32 == 3.2.3-2 10:05:59 INFO - jsonschema == 2.5.1 10:05:59 INFO - manifestparser == 1.1 10:05:59 INFO - mozInstall == 1.12 10:05:59 INFO - mozcrash == 0.17 10:05:59 INFO - mozdebug == 0.1 10:05:59 INFO - mozdevice == 0.48 10:05:59 INFO - mozfile == 1.2 10:05:59 INFO - mozhttpd == 0.7 10:05:59 INFO - mozinfo == 0.9 10:05:59 INFO - mozleak == 0.1 10:05:59 INFO - mozlog == 3.4 10:05:59 INFO - moznetwork == 0.27 10:05:59 INFO - mozprocess == 0.23 10:05:59 INFO - mozprofile == 0.28 10:05:59 INFO - mozrunner == 6.12 10:05:59 INFO - mozscreenshot == 0.1 10:05:59 INFO - mozsystemmonitor == 0.3 10:05:59 INFO - moztest == 0.7 10:05:59 INFO - mozversion == 1.4 10:05:59 INFO - psutil == 3.1.1 10:05:59 INFO - requests == 1.2.3 10:05:59 INFO - wsgiref == 0.1.2 10:05:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:59 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')]} 10:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:59 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')]} 10:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:59 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 0x7f10ac0b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1351ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134ef60>, '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 0x134fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13501d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', '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 10:05:59 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 10:05:59 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 10:05:59 INFO - Using env: {'DISPLAY': ':0', 10:05:59 INFO - 'HOME': '/home/cltbld', 10:05:59 INFO - 'LANG': 'en_US.UTF-8', 10:05:59 INFO - 'LANGUAGE': 'en_US:en', 10:05:59 INFO - 'LOGNAME': 'cltbld', 10:05:59 INFO - 'MAIL': '/var/mail/cltbld', 10:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:59 INFO - 'MOZ_NO_REMOTE': '1', 10:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:59 INFO - 'NO_EM_RESTART': '1', 10:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:59 INFO - 'PWD': '/builds/slave/test', 10:05:59 INFO - 'SHELL': '/bin/bash', 10:05:59 INFO - 'SHLVL': '1', 10:05:59 INFO - 'TERM': 'linux', 10:05:59 INFO - 'TMOUT': '86400', 10:05:59 INFO - 'USER': 'cltbld', 10:05:59 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', 10:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:59 INFO - '_': '/tools/buildbot/bin/python'} 10:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:00 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)) 10:06:00 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)) 10:06:00 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)) 10:06:00 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)) 10:06:00 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)) 10:06:00 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)) 10:06:00 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)) 10:06:00 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)) 10:06:00 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)) 10:06:00 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)) 10:06:00 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)) 10:06:00 INFO - Cleaning up... 10:06:00 INFO - Return code: 0 10:06:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:06:00 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')]} 10:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:00 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')]} 10:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:00 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 0x7f10ac0b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1351ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134ef60>, '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 0x134fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13501d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', '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 10:06:00 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 10:06:00 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 10:06:00 INFO - Using env: {'DISPLAY': ':0', 10:06:00 INFO - 'HOME': '/home/cltbld', 10:06:00 INFO - 'LANG': 'en_US.UTF-8', 10:06:00 INFO - 'LANGUAGE': 'en_US:en', 10:06:00 INFO - 'LOGNAME': 'cltbld', 10:06:00 INFO - 'MAIL': '/var/mail/cltbld', 10:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:00 INFO - 'MOZ_NO_REMOTE': '1', 10:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:00 INFO - 'NO_EM_RESTART': '1', 10:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:00 INFO - 'PWD': '/builds/slave/test', 10:06:00 INFO - 'SHELL': '/bin/bash', 10:06:00 INFO - 'SHLVL': '1', 10:06:00 INFO - 'TERM': 'linux', 10:06:00 INFO - 'TMOUT': '86400', 10:06:00 INFO - 'USER': 'cltbld', 10:06:00 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', 10:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:00 INFO - '_': '/tools/buildbot/bin/python'} 10:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:06:00 INFO - Cleaning up... 10:06:00 INFO - Return code: 0 10:06:00 INFO - Running post-action listener: _resource_record_post_action 10:06:00 INFO - Running post-action listener: _start_resource_monitoring 10:06:00 INFO - Starting resource monitoring. 10:06:00 INFO - [mozharness: 2016-10-21 17:06:00.393351Z] Finished create-virtualenv step (success) 10:06:00 INFO - [mozharness: 2016-10-21 17:06:00.393848Z] Running install step. 10:06:00 INFO - Running pre-action listener: _resource_record_pre_action 10:06:00 INFO - Running main action method: install 10:06:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:00 INFO - Reading from file tmpfile_stdout 10:06:00 INFO - Detecting whether we're running mozinstall >=1.0... 10:06:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:06:00 INFO - Reading from file tmpfile_stdout 10:06:00 INFO - Output received: 10:06:00 INFO - Usage: mozinstall [options] installer 10:06:00 INFO - Options: 10:06:00 INFO - -h, --help show this help message and exit 10:06:00 INFO - -d DEST, --destination=DEST 10:06:00 INFO - Directory to install application into. [default: 10:06:00 INFO - "/builds/slave/test"] 10:06:00 INFO - --app=APP Application being installed. [default: firefox] 10:06:00 INFO - mkdir: /builds/slave/test/build/application 10:06:00 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'] 10:06:00 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 10:06:17 INFO - Reading from file tmpfile_stdout 10:06:17 INFO - Output received: 10:06:17 INFO - /builds/slave/test/build/application/firefox/firefox 10:06:17 INFO - Running post-action listener: _resource_record_post_action 10:06:17 INFO - [mozharness: 2016-10-21 17:06:17.622117Z] Finished install step (success) 10:06:17 INFO - [mozharness: 2016-10-21 17:06:17.622390Z] Running run-tests step. 10:06:17 INFO - Running pre-action listener: _resource_record_pre_action 10:06:17 INFO - Running main action method: run_tests 10:06:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:06:17 INFO - Python 2.7.3 10:06:17 INFO - Return code: 0 10:06:17 INFO - grabbing minidump binary from tooltool 10:06: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')]} 10:06:17 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 0x134ef60>, '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 0x134fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13501d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:06:17 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 10:06:17 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 10:06:17 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 10:06:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:06:17 INFO - Return code: 0 10:06:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:06:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:06:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:06:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:06:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:06:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:06:17 INFO - Using env: {'DISPLAY': ':0', 10:06:17 INFO - 'HOME': '/home/cltbld', 10:06:17 INFO - 'LANG': 'en_US.UTF-8', 10:06:17 INFO - 'LANGUAGE': 'en_US:en', 10:06:17 INFO - 'LOGNAME': 'cltbld', 10:06:17 INFO - 'MAIL': '/var/mail/cltbld', 10:06:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:06:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:17 INFO - 'MOZ_NO_REMOTE': '1', 10:06:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:06:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:17 INFO - 'NO_EM_RESTART': '1', 10:06:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:17 INFO - 'PWD': '/builds/slave/test', 10:06:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:06:17 INFO - 'SHELL': '/bin/bash', 10:06:17 INFO - 'SHLVL': '1', 10:06:17 INFO - 'TERM': 'linux', 10:06:17 INFO - 'TMOUT': '86400', 10:06:17 INFO - 'USER': 'cltbld', 10:06:17 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812', 10:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:17 INFO - '_': '/tools/buildbot/bin/python'} 10:06:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:06:17 INFO - mozversion application_buildid: 20161021080401 10:06:17 INFO - mozversion application_changeset: d3de60b2f63081c33db27c86c56ee7de2b6bec08 10:06:17 INFO - mozversion application_display_name: Nightly 10:06:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:06:17 INFO - mozversion application_name: Firefox 10:06:17 INFO - mozversion application_remotingname: firefox 10:06:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:06:17 INFO - mozversion application_vendor: Mozilla 10:06:17 INFO - mozversion application_version: 52.0a1 10:06:17 INFO - mozversion platform_buildid: 20161021080401 10:06:17 INFO - mozversion platform_changeset: d3de60b2f63081c33db27c86c56ee7de2b6bec08 10:06:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:06:17 INFO - mozversion platform_version: 52.0a1 10:06:17 INFO - using testdate: 1477069577 10:06:17 INFO - actual date: 1477069577 10:06:17 INFO - starting webserver on 'localhost:45617' 10:06:17 INFO - SUITE-START | Running 2 tests 10:06:17 INFO - TEST-START | dromaeo_css 10:06:17 INFO - operating with platform_type : linux_ 10:06:17 INFO - Initialising browser for dromaeo_css test... 10:06:17 INFO - TEST-INFO | started process 4122 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoXS6y2/profile http://localhost:45617/getInfo.html) 10:06:22 INFO - PROCESS | 4122 | __metrics Screen width/height:1600/1200 10:06:22 INFO - PROCESS | 4122 | colorDepth:24 10:06:22 INFO - PROCESS | 4122 | Browser inner width/height: 1024/697 10:06:22 INFO - PROCESS | 4122 | __metrics 10:06:22 INFO - PROCESS | 4122 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:06:22 INFO - PROCESS | 4122 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:06:23 INFO - PROCESS | 4122 | console.error: PushService: 10:06:23 INFO - PROCESS | 4122 | stateChangeProcessEnqueue: Error transitioning state 10:06:23 INFO - PROCESS | 4122 | UnknownError 10:06:23 INFO - TEST-INFO | 4122: exit 0 10:06:23 INFO - Browser initialized. 10:06:23 INFO - Running cycle 1/1 for dromaeo_css test... 10:06:23 INFO - TEST-INFO | started process 4205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoXS6y2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:36 INFO - PROCESS | 4205 | RSS: Main: 172113920 10:06:36 INFO - PROCESS | 4205 | 10:07:27 INFO - PROCESS | 4205 | 1477069647589 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] 10:09:38 INFO - PROCESS | 4205 | Cycle 1(1): loaded http://localhost:45617/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45617/tests/dromaeo/cssquery-ext.html) 10:09:40 INFO - PROCESS | 4205 | RSS: Main: 319569920 10:09:40 INFO - PROCESS | 4205 | 10:12:42 INFO - PROCESS | 4205 | Cycle 1(1): loaded http://localhost:45617/tests/dromaeo/cssquery-ext.html (next: http://localhost:45617/tests/dromaeo/cssquery-jquery.html) 10:12:43 INFO - PROCESS | 4205 | RSS: Main: 275062784 10:12:43 INFO - PROCESS | 4205 | 10:15:45 INFO - PROCESS | 4205 | Cycle 1(1): loaded http://localhost:45617/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45617/tests/dromaeo/cssquery-mootools.html) 10:15:45 INFO - PROCESS | 4205 | RSS: Main: 253747200 10:15:45 INFO - PROCESS | 4205 | 10:18:47 INFO - PROCESS | 4205 | Cycle 1(1): loaded http://localhost:45617/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45617/tests/dromaeo/cssquery-prototype.html) 10:18:48 INFO - PROCESS | 4205 | RSS: Main: 243138560 10:18:48 INFO - PROCESS | 4205 | 10:21:51 INFO - PROCESS | 4205 | Cycle 1(1): loaded http://localhost:45617/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45617/tests/dromaeo/cssquery-yui.html) 10:21:51 INFO - PROCESS | 4205 | RSS: Main: 216322048 10:21:51 INFO - PROCESS | 4205 | 10:24:54 INFO - PROCESS | 4205 | Cycle 1(1): loaded http://localhost:45617/tests/dromaeo/cssquery-yui.html (next: http://localhost:45617/tests/dromaeo/cssquery-dojo.html) 10:24:55 INFO - PROCESS | 4205 | RSS: Main: 308842496 10:24:55 INFO - PROCESS | 4205 | 10:24:55 INFO - PROCESS | 4205 | __start_tp_report 10:24:55 INFO - PROCESS | 4205 | _x_x_mozilla_page_load 10:24:55 INFO - PROCESS | 4205 | _x_x_mozilla_page_load_details 10:24:55 INFO - PROCESS | 4205 | |i|pagename|runs| 10:24:55 INFO - PROCESS | 4205 | |0;dojo.html;3087.089308653947;3098.1015505503397;3098.6436559795616;3131.170239886432;3152.416802891465;5266.289050978116;5303.7082960437165;5313.68117912925;5325.600579956499;5410.756515956781;5286.788528458857;5336.8132115375965;5403.648762830413;5444.373897001846;5476.288082549273;4887.706737595738;4894.3392641993405;4911.705297682132;4962.702237865739;4967.652264341497;4947.802087916497;4950.678205916622;5028.597712183035;5032.924506132411;5051.772670229849;4990.476000019982;5024;5042.520960508746;5046.293518907338;5112.386513618352;4733.715977041388;4775.379200703921;4781.976090119527;4805.351277577517;4909.68087074339;4822.758862056883;4832.540908613676;4843.539863712942;4910.7299098549565;4911.705297682151;5247.10799164143;5335.439778823245;5341.839744807662;5345.251664766897;5403.729813509348;5546.223528705985;5577.9163312550345;5701.77192912283;5708.942910570882;5713.885722285572;5792.073268277056;5844.795432159854;5861.706914654293;5871.677057761822;5918.970405147989;5457.918131228034;5467.480589344046;5467.726613669301;5470.316210473691;5470.753816078286;5593.74828132735;5972.820815375546;5973.074173503114;5973.731182096816;5990.850228744316;5377.838664840061;5589.049861523551;5621.7189140542805;5639.210510528529;5704.11586204139;5635.267415236075;5672.546196304368;5678.4037676044245;5683.090705487102;5689.9146512802345;5702.144678298288;5708;5708.543316534668;5714.771409143587;5719.742611582489;5611.438856114356;5611.523020543218;5671.177679236487;5689.288838895138;5721.914171287434;4310.52584215736;4318.201132790444;4324.718893271927;4347.5652434756275;4354.608085272341;3916.6279203475624;3922.8626998054933;3922.941155882664;3925.6270654287796;3936.291467535871;5317.361916570037;5323.494268044529;5329.893402132013;5330.866728331823;5331.680099194061;5661.943380566224;5721.685307308138;5722.7424765885635;5723.198752174699;5728.369879313273;5381.273528073738;5411.64824286428;5414.864628384322;5415.48552887475;5419.241306217133;4955.975220123876;4986.476419975923;4992.575631071327;5006.048850718352;5053.8736531587;5976.5218782497295;6050.062240352752;6052.727627256784;6056.878862422727;6057.909131363033;5716.571257155647;5753.712314384347;5776.711164441677;5896.675682837314;5898.616589921641;5770.163326317745;5812.331581868139;5830.300363956352;5894.056950887837;5896.145058966512;5560.360558535658;5561.416051314553;5576.386597474356;5623.100303951348;5633.845061762411;5631.915521267266;5647.576431767716;5648.5763567731765;5657.8019769307875;5714.542836572981;5351.5451186648015;5496.395396506301;5509.531689806411;5576.553875689854;5588.524975377139;5427.511523962862;5510.834674959758;5550.888982220414;5601.607887448003;5618.129189975561;5508.228847961369;5527.751251193626;5530.336359636869;5537.529310008695;5538.280023596906;5451.37309209446;5539.806106786243;5557.166425036277;5557.416471270459;5617.606767526398;5407.026735187546;5468.56251499887;5468.589855760754;5474.069408200536;5494.862628434321 10:24:55 INFO - PROCESS | 4205 | |1;ext.html;555.1255441561449;592.8014115271385;609.6981993913013;626.1484381241511;638.0524920493064;33097.17257068572;44516.77741611291;45164.774176129074;45182.774086129604;45319;44771.77614111933;45391.54608453914;45418;45425.54574454254;45427;8085.47444416114;8285.54429506377;8847.734567962956;8995.370324077317;8997.595108220146;10579;10874.347539147637;10878.129749620051;11181.552737890475;11191.160662950271;11037.3377597344;11108.277961932448;11108.444577771119;11133.498992545356;11151.498182581763;10974.561017559288;10979.1765617579;11020.118390528738;11057.06014988727;11059.401040755496;10789.082927951134;10832.050230958424;10857.402842843641;10862.72843178919;10868.565257389695;42169;42555;42575.7871210645;42635.78682106601;42695;3083.460394430988;3102.8758849645988;3202.8078315300922;3628.6371362863765;4070.206309769596;31887;32086.518702219484;32366.838165809255;33267.833660831784;34098.65901340979;3499.8950031499094;3613.295407395559;3658.6524280193607;3684.207895302523;3789.3558095123894;316057;317054.4147279272;317105;317371;317873;59312;59725;60094.39905600888;60178.69910650419;60285.69857150686;35171.4724279136;63003.6849815748;63031;63065.369346305946;63158;15084.86863485243;15672.608184795243;15708.371665133267;15716.68566628661;15749;10353.378797272037;10473.423961682029;11348.14888883337;11752.706182345339;11897.226680265756;18289.7256541152;18925.905370473058;18945.81054189468;18980.240790368505;19014.334498292494;5566.832995010156;6914.896276555855;6925.286638523138;6930;6943.756968506078;870.1776820904312;956.1012648110892;963.9469829159324;1011.6560369474414;1036.9585216591402;30641.41209639938;32706.67293327084;32759;33065.50401743976;33458.49812252818;1036.083066486165;1049.9580016799243;1069.2515239332342;1099.6426161497545;1131.8132508136066;16705.164741762863;17168.31326746941;17229.3969711062;17280.567985800455;17385.56536086608;469282;473727;476081;476237;476362;56909.14636280459;57222.42777572171;57231.71384143052;57264.713676432184;57379.56551086173;1206.740550781586;1206.9155159138777;1276.1194775604617;1299;1326.4893016188644;28988.7101128986;32806.50790238196;32825.34349313048;33019.33961320808;33343;49927.500724992286;50545.74727126341;50690.239646404596;50745.74627126841;50774;296931;299935;301219;301357;301582;26819.86590067037;27585;27642.723572764015;28987.420251594427;29305;46349;46897.296540552605;47324.7633761829;47587.52412475831;48625.513744862095;40191.56456055639;40424.595754042086;40537.351185289655;41636.375454367604;42391.57608423876;40617;40889.59110408858;41429;42466.57533424626;42539.68253968254;41358.586414135476;41623.58376416197;42207.577924220364;42323;42458.57541424546;32700.182495436853;36101;36191;36813.81593092017;36986.81506592558;27594.586081208396;28291.151265462067;28315.575266370608;28330.291742705773;28336.85831570829 10:24:55 INFO - PROCESS | 4205 | |2;jquery.html;366.17610376652533;384.26221654423506;392.3722044728434;392.55641125528155;417.6220520429011;13408.887622988099;14507;16398.098104604258;19563.315283965065;19726.408207753753;17870.693921624475;18342.44972650819;18560.81439185611;18888.1500332485;19164.808351916476;5219.191025391052;5393.056215162331;5416.781224224557;5417.59368047398;5418.322709661293;4916.475892473345;5229.581633469333;5345.037893179227;5405.648632838873;5410.431904650014;5399.460053994589;5402.297701298845;5402.8919421611545;5407.432219616942;5409.783608655649;5171.5862730981435;5207.9479205207845;5283.445238250005;5292.682439053669;5293.179557168626;5097.23541468779;5131.050755610224;5132.615053870937;5139.563137133348;5141.717205553693;20793;21607.567848643095;21824;22527.662085068736;22727.204547840745;2124.0866427436194;2163.372621939636;2184.0936011555186;2295.4031951692514;2860.0561814601133;9829.164521015722;10253;10338.328008679488;10349.223808214414;14002.509912153026;1765.920533575992;1823.361823361826;1879.7875370386162;1884.7549818523642;1897.1462841721282;74369.62815185943;80966.19033809645;81804;84146.15853841383;84296;10621.681349559525;10720.839187412195;10905.236633435583;10910;10929.56281748721;15372.538823835303;15377.154256515776;15392;15395.769063464057;15413;7365.968764372992;7629.2370762923265;7738.6473574498705;7858.960705196438;7872.527648341118;6903.102596662502;6952.687129079203;7052.576845389191;7147.428205743528;7364.0426744522865;4587.977060114678;4680.321353403738;4723.527647235249;4735.573798358164;4836.7339796310835;1906.7044608085769;1949.8440124789984;1972.9839132846596;1981.4451953453056;1997.610465959124;848.855694531931;945.182417209123;1000.2433561293561;1009.878814542245;1051.8369652703843;18831.811681883006;19187.136578853984;19466.513337166685;19479.31822386238;19549.804501954797;893.4862454088925;925.0656836595087;946.1153821177221;956.7416797464646;984.3798407003542;10074.899251007397;10488.68533943983;10548.578056877639;10696.946515267375;10707.89292107069;383464;385018;405844;407875;408386;86798.56600716956;87020.5648971751;88769.55615222012;90109.54945225232;90420;899.7075950316173;925.8842644669417;947.3605316411395;951.4006176109007;951.4053716427233;16361.34554617802;16568.254428550503;17161.31354745846;17196.656066878342;17351.566210844325;38476.2304753909;39002.41496377614;39204.41193382045;39575.40636890391;41730.58269417267;52572.73713631407;52863.47136528739;54084.45915540952;54546.727266363414;54679;7974.920250797418;8012.83974320522;8122.83754324922;8328.541930193898;8419.242268195892;9105.27157827359;11587.130965177477;11803.704907377385;11901.880981190077;12388.256704597392;10748.4088375137;10812.729681758019;10858;11191.552337906392;11613.593524226611;10811.189160812813;10852.565897364017;10867.945660271964;10875.347479151276;11122.499487522919;10513.316634418738;10736.785264294827;10940.234183607072;11285.322880627189;11577.363245021605;7876.488028278143;8085.231902969209;8137.552434616153;8202.441536108121;8279.930017495626;9103.681371151977;11289.37908415045;11392.829107563228;11554.884451155382;11745.17783755129 10:24:55 INFO - PROCESS | 4205 | |3;mootools.html;1278.8401449818773;1396.8742813146819;1437.5184313255058;1563.8123425188971;1778.5109094998875;7566.962165189173;8650.524221167832;8957.507337096456;8977.506237156946;9248.815023699522;9058.230050445703;9141.040190779971;9148.085191480848;9155.725328240147;9155.954220228907;2308.1690591387087;2314.9884250578725;2340.5552944940405;2343.1330407749156;2346.2843832631042;2258.2660635293514;2334.1480359668685;2339.157903154863;2342.3090188394463;2343.2735851885886;2227.6881236626887;2244.786745259206;2250.966235506469;2322.9767702323015;2325.430269583946;2236.709227800384;2239.1267405711624;2240.2383189715492;2241.0699559682876;2242.035924552442;2219.578280126787;2226.2875879718495;2229.3312006398014;2231.955360892773;2238.597052530544;8997.730068097968;9037.864432033524;9045.276377889819;9140.040295768982;9173.266138708887;5316.973415132899;5448.400675925645;5460.31746031746;5464.781408743645;5468.972655136698;3350.5979282486014;3359.8320083995704;3394.7623666343366;3405.4891766235014;3429.5884493860895;984.3945973226414;990.0594435286507;992.6724181020246;1016.3495362967707;1016.8068067067234;12094.395280235953;12159.270443773403;12191.878081219164;12271.325077120755;12304.26174429537;4381.5618438155925;4500.617447516997;4581.977090114528;4604.102200070954;4697.882552936136;9802.901970980342;9836.557354919047;9846.753831154278;9850.852237216448;9856.704298871045;5284.365876094893;5315.73421328932;5317.787288508416;5320.441353657888;5328.147496400557;4319.611234988866;4468.553144685506;4824.300476430898;4918.508149185053;4933.728644924492;3729.4592284118653;3757.1546402059316;3797.468354430382;3851.1912498375095;3873.0898238913833;1131.2703306367348;1135.6138912769698;1137.8008848451489;1157.5543415784814;1162.8662703789003;845.6828689241535;850.6809946270149;863.2921004776149;887.7793034577456;896.1934259166802;5478.561715062785;5494.80768173112;5604.8038318658655;5712.65724056558;5828.154917536934;432.5220631202539;446.7900086959124;447.83653966302063;448.5985043386151;451.37709960255296;3720.3861362874823;3889.105505733697;3901.49280593521;3924.4113382992778;4045.8583949561626;11098.167637427065;11416.771664566662;11485.827712584318;11494.942525287488;11497.885021149848;11124.610638627772;11223.607173749044;11444.313341199388;11458.656240312805;11461.197716159788;7900.960495197487;8014.799630009296;8078.55567943757;8180.263776260165;8181.100078991306;5845.269341332333;5932.8813423732145;6003.8198854034445;6092.329843717276;6145.938540614537;10259.025392587691;10341.534630941474;10498.737531561772;10536.157107431234;10546.419946902994;10001.099901008944;10511.789764204826;10528.842067369149;10575.894241057491;10858;7057.400120989773;7216.530925489827;7633.236676332544;8241.381896357678;8430.283425908621;8563.486190828571;8878.822423551623;8878.955605221932;8890.644374225218;8897.644094236159;7474.514156579805;7746.883796742941;7752.5348479091435;7824.765257042298;7960.084590272193;7511.211322811245;7625.1231108421025;7639.312461878458;7710.922890771245;7765.107012693613;6739.966300168468;6799.218089919723;6841.589504629738;6846.212685541226;6847.828804279933;4795.808167673394;4883.169861123546;5000.599952003904;5056.696598204119;5116.718580478109;5107.821226257063;5112.539871411591;5221.060209162387;5256.211568264791;5280.709560974184 10:24:55 INFO - PROCESS | 4205 | |4;prototype.html;308.97064778846016;320.5784393522518;324.15880789351627;325.6173995555222;327.4237342277591;5150.793968241275;5276.604254680895;5287.298890776462;5294.41761406245;5341.893162136755;5115.207142892848;5222.686638801674;5227.849873027937;5230.5031022052935;5249.448807875176;4122.340425531916;4136.607022332881;4143.212789569972;4144.70987030908;4168.145530166309;4043.130726893717;4139.4204811326435;4170.603792639709;4175.707700460969;4192.4759405074365;4080.571539988303;4088.7342322749073;4098.4057311689785;4112.568180341066;4115.938260926088;4037.7173597848164;4060.167665628539;4065.5527891931865;4080.5919408059253;4085.9795701021453;3567.8751243706347;3604.2070744436182;3607.152319204985;3617.330793803155;3619.7828130312;5033.005361809717;5186.766595503173;5199.168133098686;5199.66202196856;5200.219967004941;4655.7439340836245;4659.394278743742;4668.36977008103;4681.625469962395;4687.695299805536;5484.506394424481;5492.368377636583;5514.6139770216105;5521.944780552223;5535.861603459905;3775.716821238418;3923.9607603923882;3944.1322908959983;3944.1520073184115;3949.960500395017;5787.913181302284;5807.82576522705;5821.53427725781;5843.211166492469;5874.443272532782;4088.7342322748927;4090.9181816363507;4093.63157315843;4095.058136628592;4102.097538541516;3927.8428862845167;4046.5113954917515;4068.3287257602756;4089.5297040840683;4147.398627199039;4692.967547139624;4698.553637404441;4699;4707.129181101439;4722.740249286254;5547.362053363834;5631.549476041907;5647.435256474319;5661.490465858093;5665.348484924287;1304.8629893861007;1338.6854089289009;1382.585224432666;1390.6801435669852;1405.838328592225;925.7454200095028;959.3428501476511;961.0437614573544;961.403929563675;964.8070385922844;5211.270422140903;5228.215767634885;5232.215167724796;5261.710880834144;5270.789168433296;5625.409332020079;5646.20953066571;5651.971740141273;5655.406182350876;5658.66138978005;5166.649174625536;5321.414644389114;5322.110650719016;5325.254464374991;5391.73041347931;3023.9848800756295;3058.8317642529873;3061.892833750808;3064;3068.21760451088;5873.706314684334;5916.408359164049;5920.911186332209;5930.627748900474;5931.73307201177;5627.296587926509;5815.854603634943;5831.154482599999;5857.677827719516;5858.355580886099;5862.267216597926;5866.6186697864505;5872.647641141545;5874.206982057368;5880.147378630075;5512.862178445411;5677.914831277617;5681.602287839812;5683.829485115453;5716.742746576331;5675.829725108253;5682.460166284196;5682.829515114553;5687.516561092188;5709.25779648643;5899.4985426239255;5905;5910.231669882888;5925.733341999707;5936.5844390892225;4044.8988775279677;4146.688998325078;4188.4555007848785;4192.182524407834;4203.62167404935;5492.286002819608;5683.630564013326;5721.771129154788;5729.9713501432225;5747.712614369349;5480.616356854982;5543.778248870161;5591.888162236651;5599.664020158803;5624.184493248375;5589.462897703164;5595.412481689526;5595.972020139873;5615.354234262949;5628.409017053151;5378.354597448331;5584.301962254718;5584.581156413366;5594.972025140011;5631.521320687787;5646.520045795989;5648.661080335193;5650.491455769001;5680.2615659965595;5692.260006199168;5444.482774136451;5534.446555344433;5543.362513311021;5595.440455954372;5606.579506536945 10:24:55 INFO - PROCESS | 4205 | |5;yui.html;618.4403115180762;677.2516369411803;680.6698751105713;696.6029363262942;701.0500771454678;13906;14855.480058197965;14918.25408729562;14991.325390357446;15011.249437528135;12801.807972880391;12907.096503244777;13253.668658283548;13375.732485350287;13393.531226407078;791.8376732769768;816.8693009118542;820.2248874813304;820.5897051474263;820.827626198499;670.5540815357781;687.6252442418894;786.6342150899831;801.8516574433719;803.9437239393245;852.4629483425433;862.8878245828033;863.080818927843;863.1497974495118;863.2489733931488;851.812601227732;853.4793775796759;854;855.8031652719909;858.9914100858974;503.9823606173766;521.0594876248371;598.796409220867;617.3271134463456;619.0744836469462;13446.462141514328;14083.507077252247;14097.506587269396;14103.647408814759;14115.647108822259;13480.5281815136;14094.577162685136;14305.213213273266;14335.85664143366;14431.392151962009;10610.946945265225;11223.66329010131;12537.561185358469;12544.121911466202;13088.738225235536;3405.4675396071866;3441.8795342163153;3532.540769699948;3554.893353199382;3660.084978755311;73934.63032684856;74060.62969685171;76568;77866;77972.61013694895;11013.449327533592;11070.833937490945;11112.666620001413;11120.332780033224;11225.101991840633;22125.114995400003;22141.225057122923;22149.66775498369;22192.55614887693;22209.333719988426;7789.649465774054;7825;8078.919210807817;8091.919080809234;8243.670253189925;3932.7640341579595;4082.7346222495444;4167.604077612622;4201.34879093741;4251.5748425157235;3349.866005359807;3502.5796904371637;3508.9824550877083;3510;3512.034190597606;616.0912653835646;629.4618101523223;642.5116911147561;645.380434782614;656.7405874679475;655.9606423614598;680.2381332907175;699.1191099214924;699.923008469068;725.8294300839299;8983.865242021375;8986.100849420156;9224;9247.200311131866;9531.47576883278;548.8765027868777;629.9685015749194;687.71116131225;688.8587839492892;692.4045321023915;3920.1571662092215;4138.91722165555;4222.577742225814;4242.830286788556;4262.488501379854;109687;114150;115384;117084.41457792657;118813;102341;102607.4869625662;104537;104965.47517262364;106897.46551267194;83459;84904.57547712221;88222.11777882268;88532.5573372129;88606;7350.632468376667;7351;7764;8156.225158609923;8292.543910085004;48530;48587.75706121588;49609.255861162834;50274.497255028444;50614.746926266605;44671.55328446804;45039.324410134526;62118.68940655268;70826.29173708196;71331;10943.124550035818;11077.612283570037;11332.773344533229;11491.253068550517;11684.474198660911;11939.880601194225;12070.396480176132;12086;12207.87792122103;12217.877821221675;11013.339199648046;11057.944710276397;11550.422478875855;11672.88327116718;11836.467358968695;11779.646610601696;11958.521659133537;12286.692832679255;12569.49722011146;12858.515505593336;11738.70653233676;11981.341026243641;12197.75604487923;12600.243985360908;12729.045321600732;9576.808463830825;9608.13526782593;9877.703668889944;10136.248982104802;10459.738506537093;9905.801883962424;10419;10498.895011049792;10621.362718236931;10752.51613677402 10:24:55 INFO - PROCESS | 4205 | __end_tp_report 10:24:55 INFO - PROCESS | 4205 | __start_cc_report 10:24:55 INFO - PROCESS | 4205 | _x_x_mozilla_cycle_collect,1335 10:24:55 INFO - PROCESS | 4205 | __end_cc_report 10:24:55 INFO - PROCESS | 4205 | __startTimestamp1477070695233__endTimestamp 10:24:55 INFO - PROCESS | 4205 | 10:24:55 INFO - PROCESS | 4205 | ------- Summary: start ------- 10:24:55 INFO - PROCESS | 4205 | Number of tests: 6 10:24:55 INFO - PROCESS | 4205 | 10:24:55 INFO - PROCESS | 4205 | [#0] dojo.html Cycles:165 Average:5318.95 Median:5476.29 stddev:594.70 (10.9%) stddev-sans-first:570.16 10:24:55 INFO - PROCESS | 4205 | Values: 3087.1 3098.1 3098.6 3131.2 3152.4 5266.3 5303.7 5313.7 5325.6 5410.8 5286.8 5336.8 5403.6 5444.4 5476.3 4887.7 4894.3 4911.7 4962.7 4967.7 4947.8 4950.7 5028.6 5032.9 5051.8 4990.5 5024.0 5042.5 5046.3 5112.4 4733.7 4775.4 4782.0 4805.4 4909.7 4822.8 4832.5 4843.5 4910.7 4911.7 5247.1 5335.4 5341.8 5345.3 5403.7 5546.2 5577.9 5701.8 5708.9 5713.9 5792.1 5844.8 5861.7 5871.7 5919.0 5457.9 5467.5 5467.7 5470.3 5470.8 5593.7 5972.8 5973.1 5973.7 5990.9 5377.8 5589.0 5621.7 5639.2 5704.1 5635.3 5672.5 5678.4 5683.1 5689.9 5702.1 5708.0 5708.5 5714.8 5719.7 5611.4 5611.5 5671.2 5689.3 5721.9 4310.5 4318.2 4324.7 4347.6 4354.6 3916.6 3922.9 3922.9 3925.6 3936.3 5317.4 5323.5 5329.9 5330.9 5331.7 5661.9 5721.7 5722.7 5723.2 5728.4 5381.3 5411.6 5414.9 5415.5 5419.2 4956.0 4986.5 4992.6 5006.0 5053.9 5976.5 6050.1 6052.7 6056.9 6057.9 5716.6 5753.7 5776.7 5896.7 5898.6 5770.2 5812.3 5830.3 5894.1 5896.1 5560.4 5561.4 5576.4 5623.1 5633.8 5631.9 5647.6 5648.6 5657.8 5714.5 5351.5 5496.4 5509.5 5576.6 5588.5 5427.5 5510.8 5550.9 5601.6 5618.1 5508.2 5527.8 5530.3 5537.5 5538.3 5451.4 5539.8 5557.2 5557.4 5617.6 5407.0 5468.6 5468.6 5474.1 5494.9 10:24:55 INFO - PROCESS | 4205 | 10:24:55 INFO - PROCESS | 4205 | [#1] ext.html Cycles:180 Average:53933.60 Median:33778.58 stddev:98112.21 (290.5%) stddev-sans-first:98305.59 10:24:55 INFO - PROCESS | 4205 | Values: 555.1 592.8 609.7 626.1 638.1 33097.2 44516.8 45164.8 45182.8 45319.0 44771.8 45391.5 45418.0 45425.5 45427.0 8085.5 8285.5 8847.7 8995.4 8997.6 10579.0 10874.3 10878.1 11181.6 11191.2 11037.3 11108.3 11108.4 11133.5 11151.5 10974.6 10979.2 11020.1 11057.1 11059.4 10789.1 10832.1 10857.4 10862.7 10868.6 42169.0 42555.0 42575.8 42635.8 42695.0 3083.5 3102.9 3202.8 3628.6 4070.2 31887.0 32086.5 32366.8 33267.8 34098.7 3499.9 3613.3 3658.7 3684.2 3789.4 316057.0 317054.4 317105.0 317371.0 317873.0 59312.0 59725.0 60094.4 60178.7 60285.7 35171.5 63003.7 63031.0 63065.4 63158.0 15084.9 15672.6 15708.4 15716.7 15749.0 10353.4 10473.4 11348.1 11752.7 11897.2 18289.7 18925.9 18945.8 18980.2 19014.3 5566.8 6914.9 6925.3 6930.0 6943.8 870.2 956.1 963.9 1011.7 1037.0 30641.4 32706.7 32759.0 33065.5 33458.5 1036.1 1050.0 1069.3 1099.6 1131.8 16705.2 17168.3 17229.4 17280.6 17385.6 469282.0 473727.0 476081.0 476237.0 476362.0 56909.1 57222.4 57231.7 57264.7 57379.6 1206.7 1206.9 1276.1 1299.0 1326.5 28988.7 32806.5 32825.3 33019.3 33343.0 49927.5 50545.7 50690.2 50745.7 50774.0 296931.0 299935.0 301219.0 301357.0 301582.0 26819.9 27585.0 27642.7 28987.4 29305.0 46349.0 46897.3 47324.8 47587.5 48625.5 40191.6 40424.6 40537.4 41636.4 42391.6 40617.0 40889.6 41429.0 42466.6 42539.7 41358.6 41623.6 42207.6 42323.0 42458.6 32700.2 36101.0 36191.0 36813.8 36986.8 27594.6 28291.2 28315.6 28330.3 28336.9 10:24:55 INFO - PROCESS | 4205 | 10:24:55 INFO - PROCESS | 4205 | [#2] jquery.html Cycles:180 Average:25810.80 Median:19697.39 stddev:66211.04 (336.1%) stddev-sans-first:66369.22 10:24:55 INFO - PROCESS | 4205 | Values: 366.2 384.3 392.4 392.6 417.6 13408.9 14507.0 16398.1 19563.3 19726.4 17870.7 18342.4 18560.8 18888.2 19164.8 5219.2 5393.1 5416.8 5417.6 5418.3 4916.5 5229.6 5345.0 5405.6 5410.4 5399.5 5402.3 5402.9 5407.4 5409.8 5171.6 5207.9 5283.4 5292.7 5293.2 5097.2 5131.1 5132.6 5139.6 5141.7 20793.0 21607.6 21824.0 22527.7 22727.2 2124.1 2163.4 2184.1 2295.4 2860.1 9829.2 10253.0 10338.3 10349.2 14002.5 1765.9 1823.4 1879.8 1884.8 1897.1 74369.6 80966.2 81804.0 84146.2 84296.0 10621.7 10720.8 10905.2 10910.0 10929.6 15372.5 15377.2 15392.0 15395.8 15413.0 7366.0 7629.2 7738.6 7859.0 7872.5 6903.1 6952.7 7052.6 7147.4 7364.0 4588.0 4680.3 4723.5 4735.6 4836.7 1906.7 1949.8 1973.0 1981.4 1997.6 848.9 945.2 1000.2 1009.9 1051.8 18831.8 19187.1 19466.5 19479.3 19549.8 893.5 925.1 946.1 956.7 984.4 10074.9 10488.7 10548.6 10696.9 10707.9 383464.0 385018.0 405844.0 407875.0 408386.0 86798.6 87020.6 88769.6 90109.5 90420.0 899.7 925.9 947.4 951.4 951.4 16361.3 16568.3 17161.3 17196.7 17351.6 38476.2 39002.4 39204.4 39575.4 41730.6 52572.7 52863.5 54084.5 54546.7 54679.0 7974.9 8012.8 8122.8 8328.5 8419.2 9105.3 11587.1 11803.7 11901.9 12388.3 10748.4 10812.7 10858.0 11191.6 11613.6 10811.2 10852.6 10867.9 10875.3 11122.5 10513.3 10736.8 10940.2 11285.3 11577.4 7876.5 8085.2 8137.6 8202.4 8279.9 9103.7 11289.4 11392.8 11554.9 11745.2 10:24:55 INFO - PROCESS | 4205 | 10:24:55 INFO - PROCESS | 4205 | [#3] mootools.html Cycles:180 Average:5795.88 Median:4853.74 stddev:3409.97 (70.3%) stddev-sans-first:3402.64 10:24:55 INFO - PROCESS | 4205 | Values: 1278.8 1396.9 1437.5 1563.8 1778.5 7567.0 8650.5 8957.5 8977.5 9248.8 9058.2 9141.0 9148.1 9155.7 9156.0 2308.2 2315.0 2340.6 2343.1 2346.3 2258.3 2334.1 2339.2 2342.3 2343.3 2227.7 2244.8 2251.0 2323.0 2325.4 2236.7 2239.1 2240.2 2241.1 2242.0 2219.6 2226.3 2229.3 2232.0 2238.6 8997.7 9037.9 9045.3 9140.0 9173.3 5317.0 5448.4 5460.3 5464.8 5469.0 3350.6 3359.8 3394.8 3405.5 3429.6 984.4 990.1 992.7 1016.3 1016.8 12094.4 12159.3 12191.9 12271.3 12304.3 4381.6 4500.6 4582.0 4604.1 4697.9 9802.9 9836.6 9846.8 9850.9 9856.7 5284.4 5315.7 5317.8 5320.4 5328.1 4319.6 4468.6 4824.3 4918.5 4933.7 3729.5 3757.2 3797.5 3851.2 3873.1 1131.3 1135.6 1137.8 1157.6 1162.9 845.7 850.7 863.3 887.8 896.2 5478.6 5494.8 5604.8 5712.7 5828.2 432.5 446.8 447.8 448.6 451.4 3720.4 3889.1 3901.5 3924.4 4045.9 11098.2 11416.8 11485.8 11494.9 11497.9 11124.6 11223.6 11444.3 11458.7 11461.2 7901.0 8014.8 8078.6 8180.3 8181.1 5845.3 5932.9 6003.8 6092.3 6145.9 10259.0 10341.5 10498.7 10536.2 10546.4 10001.1 10511.8 10528.8 10575.9 10858.0 7057.4 7216.5 7633.2 8241.4 8430.3 8563.5 8878.8 8879.0 8890.6 8897.6 7474.5 7746.9 7752.5 7824.8 7960.1 7511.2 7625.1 7639.3 7710.9 7765.1 6740.0 6799.2 6841.6 6846.2 6847.8 4795.8 4883.2 5000.6 5056.7 5116.7 5107.8 5112.5 5221.1 5256.2 5280.7 10:24:55 INFO - PROCESS | 4205 | 10:24:55 INFO - PROCESS | 4205 | [#4] prototype.html Cycles:180 Average:4683.22 Median:5321.76 stddev:1386.80 (26.1%) stddev-sans-first:1351.27 10:24:55 INFO - PROCESS | 4205 | Values: 309.0 320.6 324.2 325.6 327.4 5150.8 5276.6 5287.3 5294.4 5341.9 5115.2 5222.7 5227.8 5230.5 5249.4 4122.3 4136.6 4143.2 4144.7 4168.1 4043.1 4139.4 4170.6 4175.7 4192.5 4080.6 4088.7 4098.4 4112.6 4115.9 4037.7 4060.2 4065.6 4080.6 4086.0 3567.9 3604.2 3607.2 3617.3 3619.8 5033.0 5186.8 5199.2 5199.7 5200.2 4655.7 4659.4 4668.4 4681.6 4687.7 5484.5 5492.4 5514.6 5521.9 5535.9 3775.7 3924.0 3944.1 3944.2 3950.0 5787.9 5807.8 5821.5 5843.2 5874.4 4088.7 4090.9 4093.6 4095.1 4102.1 3927.8 4046.5 4068.3 4089.5 4147.4 4693.0 4698.6 4699.0 4707.1 4722.7 5547.4 5631.5 5647.4 5661.5 5665.3 1304.9 1338.7 1382.6 1390.7 1405.8 925.7 959.3 961.0 961.4 964.8 5211.3 5228.2 5232.2 5261.7 5270.8 5625.4 5646.2 5652.0 5655.4 5658.7 5166.6 5321.4 5322.1 5325.3 5391.7 3024.0 3058.8 3061.9 3064.0 3068.2 5873.7 5916.4 5920.9 5930.6 5931.7 5627.3 5815.9 5831.2 5857.7 5858.4 5862.3 5866.6 5872.6 5874.2 5880.1 5512.9 5677.9 5681.6 5683.8 5716.7 5675.8 5682.5 5682.8 5687.5 5709.3 5899.5 5905.0 5910.2 5925.7 5936.6 4044.9 4146.7 4188.5 4192.2 4203.6 5492.3 5683.6 5721.8 5730.0 5747.7 5480.6 5543.8 5591.9 5599.7 5624.2 5589.5 5595.4 5596.0 5615.4 5628.4 5378.4 5584.3 5584.6 5595.0 5631.5 5646.5 5648.7 5650.5 5680.3 5692.3 5444.5 5534.4 5543.4 5595.4 5606.6 10:24:55 INFO - PROCESS | 4205 | 10:24:55 INFO - PROCESS | 4205 | [#5] yui.html Cycles:180 Average:19950.33 Median:4184.48 stddev:29845.92 (713.3%) stddev-sans-first:29894.35 10:24:55 INFO - PROCESS | 4205 | Values: 618.4 677.3 680.7 696.6 701.1 13906.0 14855.5 14918.3 14991.3 15011.2 12801.8 12907.1 13253.7 13375.7 13393.5 791.8 816.9 820.2 820.6 820.8 670.6 687.6 786.6 801.9 803.9 852.5 862.9 863.1 863.1 863.2 851.8 853.5 854.0 855.8 859.0 504.0 521.1 598.8 617.3 619.1 13446.5 14083.5 14097.5 14103.6 14115.6 13480.5 14094.6 14305.2 14335.9 14431.4 10610.9 11223.7 12537.6 12544.1 13088.7 3405.5 3441.9 3532.5 3554.9 3660.1 73934.6 74060.6 76568.0 77866.0 77972.6 11013.4 11070.8 11112.7 11120.3 11225.1 22125.1 22141.2 22149.7 22192.6 22209.3 7789.6 7825.0 8078.9 8091.9 8243.7 3932.8 4082.7 4167.6 4201.3 4251.6 3349.9 3502.6 3509.0 3510.0 3512.0 616.1 629.5 642.5 645.4 656.7 656.0 680.2 699.1 699.9 725.8 8983.9 8986.1 9224.0 9247.2 9531.5 548.9 630.0 687.7 688.9 692.4 3920.2 4138.9 4222.6 4242.8 4262.5 109687.0 114150.0 115384.0 117084.4 118813.0 102341.0 102607.5 104537.0 104965.5 106897.5 83459.0 84904.6 88222.1 88532.6 88606.0 7350.6 7351.0 7764.0 8156.2 8292.5 48530.0 48587.8 49609.3 50274.5 50614.7 44671.6 45039.3 62118.7 70826.3 71331.0 10943.1 11077.6 11332.8 11491.3 11684.5 11939.9 12070.4 12086.0 12207.9 12217.9 11013.3 11057.9 11550.4 11672.9 11836.5 11779.6 11958.5 12286.7 12569.5 12858.5 11738.7 11981.3 12197.8 12600.2 12729.0 9576.8 9608.1 9877.7 10136.2 10459.7 9905.8 10419.0 10498.9 10621.4 10752.5 10:24:55 INFO - PROCESS | 4205 | -------- Summary: end -------- 10:24:55 INFO - PROCESS | 4205 | 10:24:56 INFO - TEST-INFO | 4205: exit 0 10:24:56 INFO - TEST-OK | dromaeo_css | took 1118316ms 10:24:56 INFO - TEST-START | kraken 10:24:56 INFO - operating with platform_type : linux_ 10:24:56 INFO - Initialising browser for kraken test... 10:24:56 INFO - TEST-INFO | started process 4526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkZGyDa/profile http://localhost:45617/getInfo.html) 10:25:00 INFO - PROCESS | 4526 | __metrics Screen width/height:1600/1200 10:25:00 INFO - PROCESS | 4526 | colorDepth:24 10:25:00 INFO - PROCESS | 4526 | Browser inner width/height: 1024/697 10:25:00 INFO - PROCESS | 4526 | __metrics 10:25:00 INFO - PROCESS | 4526 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:25:00 INFO - PROCESS | 4526 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:25:01 INFO - PROCESS | 4526 | console.error: PushService: 10:25:01 INFO - PROCESS | 4526 | stateChangeProcessEnqueue: Error transitioning state 10:25:01 INFO - PROCESS | 4526 | UnknownError 10:25:02 INFO - TEST-INFO | 4526: exit 0 10:25:02 INFO - Browser initialized. 10:25:02 INFO - Running cycle 1/1 for kraken test... 10:25:02 INFO - TEST-INFO | started process 4606 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkZGyDa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:14 INFO - PROCESS | 4606 | RSS: Main: 172097536 10:25:14 INFO - PROCESS | 4606 | 10:25:16 INFO - PROCESS | 4606 | Cycle 1(1): loaded http://localhost:45617/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45617/tests/kraken/driver.html?testName=audio-beat-detection) 10:25:17 INFO - PROCESS | 4606 | RSS: Main: 228765696 10:25:17 INFO - PROCESS | 4606 | 10:25:20 INFO - PROCESS | 4606 | Cycle 1(1): loaded http://localhost:45617/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45617/tests/kraken/driver.html?testName=audio-dft) 10:25:20 INFO - PROCESS | 4606 | RSS: Main: 215060480 10:25:20 INFO - PROCESS | 4606 | 10:25:24 INFO - PROCESS | 4606 | Cycle 1(1): loaded http://localhost:45617/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45617/tests/kraken/driver.html?testName=audio-fft) 10:25:24 INFO - PROCESS | 4606 | RSS: Main: 297005056 10:25:24 INFO - PROCESS | 4606 | 10:25:26 INFO - PROCESS | 4606 | Cycle 1(1): loaded http://localhost:45617/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45617/tests/kraken/driver.html?testName=audio-oscillator) 10:25:27 INFO - PROCESS | 4606 | RSS: Main: 206073856 10:25:27 INFO - PROCESS | 4606 | 10:25:29 INFO - PROCESS | 4606 | Cycle 1(1): loaded http://localhost:45617/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45617/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:25:30 INFO - PROCESS | 4606 | RSS: Main: 210817024 10:25:30 INFO - PROCESS | 4606 | 10:25:33 INFO - PROCESS | 4606 | Cycle 1(1): loaded http://localhost:45617/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45617/tests/kraken/driver.html?testName=imaging-darkroom) 10:25:33 INFO - PROCESS | 4606 | RSS: Main: 247500800 10:25:33 INFO - PROCESS | 4606 | 10:25:36 INFO - PROCESS | 4606 | Cycle 1(1): loaded http://localhost:45617/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45617/tests/kraken/driver.html?testName=imaging-desaturate) 10:25:37 INFO - PROCESS | 4606 | RSS: Main: 246136832 10:25:37 INFO - PROCESS | 4606 | 10:25:40 INFO - PROCESS | 4606 | Cycle 1(1): loaded http://localhost:45617/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45617/tests/kraken/driver.html?testName=json-parse-financial) 10:25:40 INFO - PROCESS | 4606 | RSS: Main: 246030336 10:25:40 INFO - PROCESS | 4606 | 10:25:42 INFO - PROCESS | 4606 | Cycle 1(1): loaded http://localhost:45617/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45617/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:25:42 INFO - PROCESS | 4606 | RSS: Main: 208375808 10:25:42 INFO - PROCESS | 4606 | 10:25:44 INFO - PROCESS | 4606 | Cycle 1(1): loaded http://localhost:45617/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45617/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:25:45 INFO - PROCESS | 4606 | RSS: Main: 215609344 10:25:45 INFO - PROCESS | 4606 | 10:25:47 INFO - PROCESS | 4606 | Cycle 1(1): loaded http://localhost:45617/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45617/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:25:47 INFO - PROCESS | 4606 | RSS: Main: 225288192 10:25:47 INFO - PROCESS | 4606 | 10:25:50 INFO - PROCESS | 4606 | Cycle 1(1): loaded http://localhost:45617/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45617/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:25:51 INFO - PROCESS | 4606 | RSS: Main: 233730048 10:25:51 INFO - PROCESS | 4606 | 10:25:54 INFO - PROCESS | 4606 | Cycle 1(1): loaded http://localhost:45617/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45617/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:25:54 INFO - PROCESS | 4606 | RSS: Main: 230985728 10:25:54 INFO - PROCESS | 4606 | 10:25:56 INFO - PROCESS | 4606 | Cycle 1(1): loaded http://localhost:45617/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45617/tests/kraken/driver.html?testName=ai-astar) 10:25:56 INFO - PROCESS | 4606 | RSS: Main: 282812416 10:25:56 INFO - PROCESS | 4606 | 10:25:56 INFO - PROCESS | 4606 | __start_tp_report 10:25:56 INFO - PROCESS | 4606 | _x_x_mozilla_page_load 10:25:56 INFO - PROCESS | 4606 | _x_x_mozilla_page_load_details 10:25:56 INFO - PROCESS | 4606 | |i|pagename|runs| 10:25:56 INFO - PROCESS | 4606 | |0;ai-astar;105;110;110;113;111;110;111;111;110;111 10:25:56 INFO - PROCESS | 4606 | |1;audio-beat-detection;156;123;127;156;126;123;129;123;169;126 10:25:56 INFO - PROCESS | 4606 | |2;audio-dft;163;160;162;161;160;159;161;162;161;162 10:25:56 INFO - PROCESS | 4606 | |3;audio-fft;77;76;75;115;75;76;76;77;103;75 10:25:56 INFO - PROCESS | 4606 | |4;audio-oscillator;82;82;117;81;82;82;112;82;82;114 10:25:56 INFO - PROCESS | 4606 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;118;117;117 10:25:56 INFO - PROCESS | 4606 | |6;imaging-darkroom;147;147;146;146;146;148;148;147;148;148 10:25:56 INFO - PROCESS | 4606 | |7;imaging-desaturate;85;84;84;85;84;84;85;85;84;84 10:25:56 INFO - PROCESS | 4606 | |8;json-parse-financial;54;53;53;52;53;54;54;53;54;54 10:25:56 INFO - PROCESS | 4606 | |9;json-stringify-tinderbox;59;59;59;59;60;59;60;60;64;60 10:25:56 INFO - PROCESS | 4606 | |10;stanford-crypto-aes;81;87;80;82;80;80;80;79;79;80 10:25:56 INFO - PROCESS | 4606 | |11;stanford-crypto-ccm;134;131;133;135;131;130;142;131;169;130 10:25:56 INFO - PROCESS | 4606 | |12;stanford-crypto-pbkdf2;170;166;165;162;165;165;164;162;167;169 10:25:56 INFO - PROCESS | 4606 | |13;stanford-crypto-sha256-iterative;65;64;65;66;72;64;66;64;75;71 10:25:56 INFO - PROCESS | 4606 | __end_tp_report 10:25:56 INFO - PROCESS | 4606 | __start_cc_report 10:25:56 INFO - PROCESS | 4606 | _x_x_mozilla_cycle_collect,1671 10:25:56 INFO - PROCESS | 4606 | __end_cc_report 10:25:56 INFO - PROCESS | 4606 | __startTimestamp1477070756568__endTimestamp 10:25:56 INFO - PROCESS | 4606 | 10:25:56 INFO - PROCESS | 4606 | ------- Summary: start ------- 10:25:56 INFO - PROCESS | 4606 | Number of tests: 14 10:25:56 INFO - PROCESS | 4606 | 10:25:56 INFO - PROCESS | 4606 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.04 (1.8%) stddev-sans-first:0.97 10:25:56 INFO - PROCESS | 4606 | Values: 105.0 110.0 110.0 113.0 111.0 110.0 111.0 111.0 110.0 111.0 10:25:56 INFO - PROCESS | 4606 | 10:25:56 INFO - PROCESS | 4606 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:128.00 stddev:17.40 (13.6%) stddev-sans-first:16.85 10:25:56 INFO - PROCESS | 4606 | Values: 156.0 123.0 127.0 156.0 126.0 123.0 129.0 123.0 169.0 126.0 10:25:56 INFO - PROCESS | 4606 | 10:25:56 INFO - PROCESS | 4606 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.20 (0.7%) stddev-sans-first:1.05 10:25:56 INFO - PROCESS | 4606 | Values: 163.0 160.0 162.0 161.0 160.0 159.0 161.0 162.0 161.0 162.0 10:25:56 INFO - PROCESS | 4606 | 10:25:56 INFO - PROCESS | 4606 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.00 stddev:14.27 (18.8%) stddev-sans-first:15.00 10:25:56 INFO - PROCESS | 4606 | Values: 77.0 76.0 75.0 115.0 75.0 76.0 76.0 77.0 103.0 75.0 10:25:56 INFO - PROCESS | 4606 | 10:25:56 INFO - PROCESS | 4606 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:82.00 stddev:15.74 (19.2%) stddev-sans-first:16.30 10:25:56 INFO - PROCESS | 4606 | Values: 82.0 82.0 117.0 81.0 82.0 82.0 112.0 82.0 82.0 114.0 10:25:56 INFO - PROCESS | 4606 | 10:25:56 INFO - PROCESS | 4606 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 10:25:56 INFO - PROCESS | 4606 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 117.0 10:25:56 INFO - PROCESS | 4606 | 10:25:56 INFO - PROCESS | 4606 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:0.88 (0.6%) stddev-sans-first:0.93 10:25:56 INFO - PROCESS | 4606 | Values: 147.0 147.0 146.0 146.0 146.0 148.0 148.0 147.0 148.0 148.0 10:25:56 INFO - PROCESS | 4606 | 10:25:56 INFO - PROCESS | 4606 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 10:25:56 INFO - PROCESS | 4606 | Values: 85.0 84.0 84.0 85.0 84.0 84.0 85.0 85.0 84.0 84.0 10:25:56 INFO - PROCESS | 4606 | 10:25:56 INFO - PROCESS | 4606 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:54.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 10:25:56 INFO - PROCESS | 4606 | Values: 54.0 53.0 53.0 52.0 53.0 54.0 54.0 53.0 54.0 54.0 10:25:56 INFO - PROCESS | 4606 | 10:25:56 INFO - PROCESS | 4606 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:1.52 (2.5%) stddev-sans-first:1.58 10:25:56 INFO - PROCESS | 4606 | Values: 59.0 59.0 59.0 59.0 60.0 59.0 60.0 60.0 64.0 60.0 10:25:56 INFO - PROCESS | 4606 | 10:25:56 INFO - PROCESS | 4606 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.00 stddev:2.35 (2.9%) stddev-sans-first:2.49 10:25:56 INFO - PROCESS | 4606 | Values: 81.0 87.0 80.0 82.0 80.0 80.0 80.0 79.0 79.0 80.0 10:25:56 INFO - PROCESS | 4606 | 10:25:56 INFO - PROCESS | 4606 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:133.50 stddev:11.94 (8.9%) stddev-sans-first:12.62 10:25:56 INFO - PROCESS | 4606 | Values: 134.0 131.0 133.0 135.0 131.0 130.0 142.0 131.0 169.0 130.0 10:25:56 INFO - PROCESS | 4606 | 10:25:56 INFO - PROCESS | 4606 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.50 Median:165.50 stddev:2.64 (1.6%) stddev-sans-first:2.24 10:25:56 INFO - PROCESS | 4606 | Values: 170.0 166.0 165.0 162.0 165.0 165.0 164.0 162.0 167.0 169.0 10:25:56 INFO - PROCESS | 4606 | 10:25:56 INFO - PROCESS | 4606 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:66.00 stddev:3.97 (6.0%) stddev-sans-first:4.13 10:25:56 INFO - PROCESS | 4606 | Values: 65.0 64.0 65.0 66.0 72.0 64.0 66.0 64.0 75.0 71.0 10:25:56 INFO - PROCESS | 4606 | -------- Summary: end -------- 10:25:56 INFO - PROCESS | 4606 | 10:25:57 INFO - TEST-INFO | 4606: exit 0 10:25:57 INFO - TEST-OK | kraken | took 61644ms 10:25:57 INFO - SUITE-END | took 1179s 10:25:58 INFO - Completed test suite (00:19:40) 10:25:58 INFO - javascript benchmark 10:25:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3087.089308653947, 3098.1015505503397, 3098.6436559795616, 3131.170239886432, 3152.416802891465, 5266.289050978116, 5303.7082960437165, 5313.68117912925, 5325.600579956499, 5410.756515956781, 5286.788528458857, 5336.8132115375965, 5403.648762830413, 5444.373897001846, 5476.288082549273, 4887.706737595738, 4894.3392641993405, 4911.705297682132, 4962.702237865739, 4967.652264341497, 4947.802087916497, 4950.678205916622, 5028.597712183035, 5032.924506132411, 5051.772670229849, 4990.476000019982, 5024.0, 5042.520960508746, 5046.293518907338, 5112.386513618352, 4733.715977041388, 4775.379200703921, 4781.976090119527, 4805.351277577517, 4909.68087074339, 4822.758862056883, 4832.540908613676, 4843.539863712942, 4910.7299098549565, 4911.705297682151, 5247.10799164143, 5335.439778823245, 5341.839744807662, 5345.251664766897, 5403.729813509348, 5546.223528705985, 5577.9163312550345, 5701.77192912283, 5708.942910570882, 5713.885722285572, 5792.073268277056, 5844.795432159854, 5861.706914654293, 5871.677057761822, 5918.970405147989, 5457.918131228034, 5467.480589344046, 5467.726613669301, 5470.316210473691, 5470.753816078286, 5593.74828132735, 5972.820815375546, 5973.074173503114, 5973.731182096816, 5990.850228744316, 5377.838664840061, 5589.049861523551, 5621.7189140542805, 5639.210510528529, 5704.11586204139, 5635.267415236075, 5672.546196304368, 5678.4037676044245, 5683.090705487102, 5689.9146512802345, 5702.144678298288, 5708.0, 5708.543316534668, 5714.771409143587, 5719.742611582489, 5611.438856114356, 5611.523020543218, 5671.177679236487, 5689.288838895138, 5721.914171287434, 4310.52584215736, 4318.201132790444, 4324.718893271927, 4347.5652434756275, 4354.608085272341, 3916.6279203475624, 3922.8626998054933, 3922.941155882664, 3925.6270654287796, 3936.291467535871, 5317.361916570037, 5323.494268044529, 5329.893402132013, 5330.866728331823, 5331.680099194061, 5661.943380566224, 5721.685307308138, 5722.7424765885635, 5723.198752174699, 5728.369879313273, 5381.273528073738, 5411.64824286428, 5414.864628384322, 5415.48552887475, 5419.241306217133, 4955.975220123876, 4986.476419975923, 4992.575631071327, 5006.048850718352, 5053.8736531587, 5976.5218782497295, 6050.062240352752, 6052.727627256784, 6056.878862422727, 6057.909131363033, 5716.571257155647, 5753.712314384347, 5776.711164441677, 5896.675682837314, 5898.616589921641, 5770.163326317745, 5812.331581868139, 5830.300363956352, 5894.056950887837, 5896.145058966512, 5560.360558535658, 5561.416051314553, 5576.386597474356, 5623.100303951348, 5633.845061762411, 5631.915521267266, 5647.576431767716, 5648.5763567731765, 5657.8019769307875, 5714.542836572981, 5351.5451186648015, 5496.395396506301, 5509.531689806411, 5576.553875689854, 5588.524975377139, 5427.511523962862, 5510.834674959758, 5550.888982220414, 5601.607887448003, 5618.129189975561, 5508.228847961369, 5527.751251193626, 5530.336359636869, 5537.529310008695, 5538.280023596906, 5451.37309209446, 5539.806106786243, 5557.166425036277, 5557.416471270459, 5617.606767526398, 5407.026735187546, 5468.56251499887, 5468.589855760754, 5474.069408200536, 5494.862628434321], "value": 5279.400447870481, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.1255441561449, 592.8014115271385, 609.6981993913013, 626.1484381241511, 638.0524920493064, 33097.17257068572, 44516.77741611291, 45164.774176129074, 45182.774086129604, 45319.0, 44771.77614111933, 45391.54608453914, 45418.0, 45425.54574454254, 45427.0, 8085.47444416114, 8285.54429506377, 8847.734567962956, 8995.370324077317, 8997.595108220146, 10579.0, 10874.347539147637, 10878.129749620051, 11181.552737890475, 11191.160662950271, 11037.3377597344, 11108.277961932448, 11108.444577771119, 11133.498992545356, 11151.498182581763, 10974.561017559288, 10979.1765617579, 11020.118390528738, 11057.06014988727, 11059.401040755496, 10789.082927951134, 10832.050230958424, 10857.402842843641, 10862.72843178919, 10868.565257389695, 42169.0, 42555.0, 42575.7871210645, 42635.78682106601, 42695.0, 3083.460394430988, 3102.8758849645988, 3202.8078315300922, 3628.6371362863765, 4070.206309769596, 31887.0, 32086.518702219484, 32366.838165809255, 33267.833660831784, 34098.65901340979, 3499.8950031499094, 3613.295407395559, 3658.6524280193607, 3684.207895302523, 3789.3558095123894, 316057.0, 317054.4147279272, 317105.0, 317371.0, 317873.0, 59312.0, 59725.0, 60094.39905600888, 60178.69910650419, 60285.69857150686, 35171.4724279136, 63003.6849815748, 63031.0, 63065.369346305946, 63158.0, 15084.86863485243, 15672.608184795243, 15708.371665133267, 15716.68566628661, 15749.0, 10353.378797272037, 10473.423961682029, 11348.14888883337, 11752.706182345339, 11897.226680265756, 18289.7256541152, 18925.905370473058, 18945.81054189468, 18980.240790368505, 19014.334498292494, 5566.832995010156, 6914.896276555855, 6925.286638523138, 6930.0, 6943.756968506078, 870.1776820904312, 956.1012648110892, 963.9469829159324, 1011.6560369474414, 1036.9585216591402, 30641.41209639938, 32706.67293327084, 32759.0, 33065.50401743976, 33458.49812252818, 1036.083066486165, 1049.9580016799243, 1069.2515239332342, 1099.6426161497545, 1131.8132508136066, 16705.164741762863, 17168.31326746941, 17229.3969711062, 17280.567985800455, 17385.56536086608, 469282.0, 473727.0, 476081.0, 476237.0, 476362.0, 56909.14636280459, 57222.42777572171, 57231.71384143052, 57264.713676432184, 57379.56551086173, 1206.740550781586, 1206.9155159138777, 1276.1194775604617, 1299.0, 1326.4893016188644, 28988.7101128986, 32806.50790238196, 32825.34349313048, 33019.33961320808, 33343.0, 49927.500724992286, 50545.74727126341, 50690.239646404596, 50745.74627126841, 50774.0, 296931.0, 299935.0, 301219.0, 301357.0, 301582.0, 26819.86590067037, 27585.0, 27642.723572764015, 28987.420251594427, 29305.0, 46349.0, 46897.296540552605, 47324.7633761829, 47587.52412475831, 48625.513744862095, 40191.56456055639, 40424.595754042086, 40537.351185289655, 41636.375454367604, 42391.57608423876, 40617.0, 40889.59110408858, 41429.0, 42466.57533424626, 42539.68253968254, 41358.586414135476, 41623.58376416197, 42207.577924220364, 42323.0, 42458.57541424546, 32700.182495436853, 36101.0, 36191.0, 36813.81593092017, 36986.81506592558, 27594.586081208396, 28291.151265462067, 28315.575266370608, 28330.291742705773, 28336.85831570829], "value": 19895.301637150355, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.17610376652533, 384.26221654423506, 392.3722044728434, 392.55641125528155, 417.6220520429011, 13408.887622988099, 14507.0, 16398.098104604258, 19563.315283965065, 19726.408207753753, 17870.693921624475, 18342.44972650819, 18560.81439185611, 18888.1500332485, 19164.808351916476, 5219.191025391052, 5393.056215162331, 5416.781224224557, 5417.59368047398, 5418.322709661293, 4916.475892473345, 5229.581633469333, 5345.037893179227, 5405.648632838873, 5410.431904650014, 5399.460053994589, 5402.297701298845, 5402.8919421611545, 5407.432219616942, 5409.783608655649, 5171.5862730981435, 5207.9479205207845, 5283.445238250005, 5292.682439053669, 5293.179557168626, 5097.23541468779, 5131.050755610224, 5132.615053870937, 5139.563137133348, 5141.717205553693, 20793.0, 21607.567848643095, 21824.0, 22527.662085068736, 22727.204547840745, 2124.0866427436194, 2163.372621939636, 2184.0936011555186, 2295.4031951692514, 2860.0561814601133, 9829.164521015722, 10253.0, 10338.328008679488, 10349.223808214414, 14002.509912153026, 1765.920533575992, 1823.361823361826, 1879.7875370386162, 1884.7549818523642, 1897.1462841721282, 74369.62815185943, 80966.19033809645, 81804.0, 84146.15853841383, 84296.0, 10621.681349559525, 10720.839187412195, 10905.236633435583, 10910.0, 10929.56281748721, 15372.538823835303, 15377.154256515776, 15392.0, 15395.769063464057, 15413.0, 7365.968764372992, 7629.2370762923265, 7738.6473574498705, 7858.960705196438, 7872.527648341118, 6903.102596662502, 6952.687129079203, 7052.576845389191, 7147.428205743528, 7364.0426744522865, 4587.977060114678, 4680.321353403738, 4723.527647235249, 4735.573798358164, 4836.7339796310835, 1906.7044608085769, 1949.8440124789984, 1972.9839132846596, 1981.4451953453056, 1997.610465959124, 848.855694531931, 945.182417209123, 1000.2433561293561, 1009.878814542245, 1051.8369652703843, 18831.811681883006, 19187.136578853984, 19466.513337166685, 19479.31822386238, 19549.804501954797, 893.4862454088925, 925.0656836595087, 946.1153821177221, 956.7416797464646, 984.3798407003542, 10074.899251007397, 10488.68533943983, 10548.578056877639, 10696.946515267375, 10707.89292107069, 383464.0, 385018.0, 405844.0, 407875.0, 408386.0, 86798.56600716956, 87020.5648971751, 88769.55615222012, 90109.54945225232, 90420.0, 899.7075950316173, 925.8842644669417, 947.3605316411395, 951.4006176109007, 951.4053716427233, 16361.34554617802, 16568.254428550503, 17161.31354745846, 17196.656066878342, 17351.566210844325, 38476.2304753909, 39002.41496377614, 39204.41193382045, 39575.40636890391, 41730.58269417267, 52572.73713631407, 52863.47136528739, 54084.45915540952, 54546.727266363414, 54679.0, 7974.920250797418, 8012.83974320522, 8122.83754324922, 8328.541930193898, 8419.242268195892, 9105.27157827359, 11587.130965177477, 11803.704907377385, 11901.880981190077, 12388.256704597392, 10748.4088375137, 10812.729681758019, 10858.0, 11191.552337906392, 11613.593524226611, 10811.189160812813, 10852.565897364017, 10867.945660271964, 10875.347479151276, 11122.499487522919, 10513.316634418738, 10736.785264294827, 10940.234183607072, 11285.322880627189, 11577.363245021605, 7876.488028278143, 8085.231902969209, 8137.552434616153, 8202.441536108121, 8279.930017495626, 9103.681371151977, 11289.37908415045, 11392.829107563228, 11554.884451155382, 11745.17783755129], "value": 8760.779576559462, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.8401449818773, 1396.8742813146819, 1437.5184313255058, 1563.8123425188971, 1778.5109094998875, 7566.962165189173, 8650.524221167832, 8957.507337096456, 8977.506237156946, 9248.815023699522, 9058.230050445703, 9141.040190779971, 9148.085191480848, 9155.725328240147, 9155.954220228907, 2308.1690591387087, 2314.9884250578725, 2340.5552944940405, 2343.1330407749156, 2346.2843832631042, 2258.2660635293514, 2334.1480359668685, 2339.157903154863, 2342.3090188394463, 2343.2735851885886, 2227.6881236626887, 2244.786745259206, 2250.966235506469, 2322.9767702323015, 2325.430269583946, 2236.709227800384, 2239.1267405711624, 2240.2383189715492, 2241.0699559682876, 2242.035924552442, 2219.578280126787, 2226.2875879718495, 2229.3312006398014, 2231.955360892773, 2238.597052530544, 8997.730068097968, 9037.864432033524, 9045.276377889819, 9140.040295768982, 9173.266138708887, 5316.973415132899, 5448.400675925645, 5460.31746031746, 5464.781408743645, 5468.972655136698, 3350.5979282486014, 3359.8320083995704, 3394.7623666343366, 3405.4891766235014, 3429.5884493860895, 984.3945973226414, 990.0594435286507, 992.6724181020246, 1016.3495362967707, 1016.8068067067234, 12094.395280235953, 12159.270443773403, 12191.878081219164, 12271.325077120755, 12304.26174429537, 4381.5618438155925, 4500.617447516997, 4581.977090114528, 4604.102200070954, 4697.882552936136, 9802.901970980342, 9836.557354919047, 9846.753831154278, 9850.852237216448, 9856.704298871045, 5284.365876094893, 5315.73421328932, 5317.787288508416, 5320.441353657888, 5328.147496400557, 4319.611234988866, 4468.553144685506, 4824.300476430898, 4918.508149185053, 4933.728644924492, 3729.4592284118653, 3757.1546402059316, 3797.468354430382, 3851.1912498375095, 3873.0898238913833, 1131.2703306367348, 1135.6138912769698, 1137.8008848451489, 1157.5543415784814, 1162.8662703789003, 845.6828689241535, 850.6809946270149, 863.2921004776149, 887.7793034577456, 896.1934259166802, 5478.561715062785, 5494.80768173112, 5604.8038318658655, 5712.65724056558, 5828.154917536934, 432.5220631202539, 446.7900086959124, 447.83653966302063, 448.5985043386151, 451.37709960255296, 3720.3861362874823, 3889.105505733697, 3901.49280593521, 3924.4113382992778, 4045.8583949561626, 11098.167637427065, 11416.771664566662, 11485.827712584318, 11494.942525287488, 11497.885021149848, 11124.610638627772, 11223.607173749044, 11444.313341199388, 11458.656240312805, 11461.197716159788, 7900.960495197487, 8014.799630009296, 8078.55567943757, 8180.263776260165, 8181.100078991306, 5845.269341332333, 5932.8813423732145, 6003.8198854034445, 6092.329843717276, 6145.938540614537, 10259.025392587691, 10341.534630941474, 10498.737531561772, 10536.157107431234, 10546.419946902994, 10001.099901008944, 10511.789764204826, 10528.842067369149, 10575.894241057491, 10858.0, 7057.400120989773, 7216.530925489827, 7633.236676332544, 8241.381896357678, 8430.283425908621, 8563.486190828571, 8878.822423551623, 8878.955605221932, 8890.644374225218, 8897.644094236159, 7474.514156579805, 7746.883796742941, 7752.5348479091435, 7824.765257042298, 7960.084590272193, 7511.211322811245, 7625.1231108421025, 7639.312461878458, 7710.922890771245, 7765.107012693613, 6739.966300168468, 6799.218089919723, 6841.589504629738, 6846.212685541226, 6847.828804279933, 4795.808167673394, 4883.169861123546, 5000.599952003904, 5056.696598204119, 5116.718580478109, 5107.821226257063, 5112.539871411591, 5221.060209162387, 5256.211568264791, 5280.709560974184], "value": 4488.568592002248, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.97064778846016, 320.5784393522518, 324.15880789351627, 325.6173995555222, 327.4237342277591, 5150.793968241275, 5276.604254680895, 5287.298890776462, 5294.41761406245, 5341.893162136755, 5115.207142892848, 5222.686638801674, 5227.849873027937, 5230.5031022052935, 5249.448807875176, 4122.340425531916, 4136.607022332881, 4143.212789569972, 4144.70987030908, 4168.145530166309, 4043.130726893717, 4139.4204811326435, 4170.603792639709, 4175.707700460969, 4192.4759405074365, 4080.571539988303, 4088.7342322749073, 4098.4057311689785, 4112.568180341066, 4115.938260926088, 4037.7173597848164, 4060.167665628539, 4065.5527891931865, 4080.5919408059253, 4085.9795701021453, 3567.8751243706347, 3604.2070744436182, 3607.152319204985, 3617.330793803155, 3619.7828130312, 5033.005361809717, 5186.766595503173, 5199.168133098686, 5199.66202196856, 5200.219967004941, 4655.7439340836245, 4659.394278743742, 4668.36977008103, 4681.625469962395, 4687.695299805536, 5484.506394424481, 5492.368377636583, 5514.6139770216105, 5521.944780552223, 5535.861603459905, 3775.716821238418, 3923.9607603923882, 3944.1322908959983, 3944.1520073184115, 3949.960500395017, 5787.913181302284, 5807.82576522705, 5821.53427725781, 5843.211166492469, 5874.443272532782, 4088.7342322748927, 4090.9181816363507, 4093.63157315843, 4095.058136628592, 4102.097538541516, 3927.8428862845167, 4046.5113954917515, 4068.3287257602756, 4089.5297040840683, 4147.398627199039, 4692.967547139624, 4698.553637404441, 4699.0, 4707.129181101439, 4722.740249286254, 5547.362053363834, 5631.549476041907, 5647.435256474319, 5661.490465858093, 5665.348484924287, 1304.8629893861007, 1338.6854089289009, 1382.585224432666, 1390.6801435669852, 1405.838328592225, 925.7454200095028, 959.3428501476511, 961.0437614573544, 961.403929563675, 964.8070385922844, 5211.270422140903, 5228.215767634885, 5232.215167724796, 5261.710880834144, 5270.789168433296, 5625.409332020079, 5646.20953066571, 5651.971740141273, 5655.406182350876, 5658.66138978005, 5166.649174625536, 5321.414644389114, 5322.110650719016, 5325.254464374991, 5391.73041347931, 3023.9848800756295, 3058.8317642529873, 3061.892833750808, 3064.0, 3068.21760451088, 5873.706314684334, 5916.408359164049, 5920.911186332209, 5930.627748900474, 5931.73307201177, 5627.296587926509, 5815.854603634943, 5831.154482599999, 5857.677827719516, 5858.355580886099, 5862.267216597926, 5866.6186697864505, 5872.647641141545, 5874.206982057368, 5880.147378630075, 5512.862178445411, 5677.914831277617, 5681.602287839812, 5683.829485115453, 5716.742746576331, 5675.829725108253, 5682.460166284196, 5682.829515114553, 5687.516561092188, 5709.25779648643, 5899.4985426239255, 5905.0, 5910.231669882888, 5925.733341999707, 5936.5844390892225, 4044.8988775279677, 4146.688998325078, 4188.4555007848785, 4192.182524407834, 4203.62167404935, 5492.286002819608, 5683.630564013326, 5721.771129154788, 5729.9713501432225, 5747.712614369349, 5480.616356854982, 5543.778248870161, 5591.888162236651, 5599.664020158803, 5624.184493248375, 5589.462897703164, 5595.412481689526, 5595.972020139873, 5615.354234262949, 5628.409017053151, 5378.354597448331, 5584.301962254718, 5584.581156413366, 5594.972025140011, 5631.521320687787, 5646.520045795989, 5648.661080335193, 5650.491455769001, 5680.2615659965595, 5692.260006199168, 5444.482774136451, 5534.446555344433, 5543.362513311021, 5595.440455954372, 5606.579506536945], "value": 4236.4033522077725, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.4403115180762, 677.2516369411803, 680.6698751105713, 696.6029363262942, 701.0500771454678, 13906.0, 14855.480058197965, 14918.25408729562, 14991.325390357446, 15011.249437528135, 12801.807972880391, 12907.096503244777, 13253.668658283548, 13375.732485350287, 13393.531226407078, 791.8376732769768, 816.8693009118542, 820.2248874813304, 820.5897051474263, 820.827626198499, 670.5540815357781, 687.6252442418894, 786.6342150899831, 801.8516574433719, 803.9437239393245, 852.4629483425433, 862.8878245828033, 863.080818927843, 863.1497974495118, 863.2489733931488, 851.812601227732, 853.4793775796759, 854.0, 855.8031652719909, 858.9914100858974, 503.9823606173766, 521.0594876248371, 598.796409220867, 617.3271134463456, 619.0744836469462, 13446.462141514328, 14083.507077252247, 14097.506587269396, 14103.647408814759, 14115.647108822259, 13480.5281815136, 14094.577162685136, 14305.213213273266, 14335.85664143366, 14431.392151962009, 10610.946945265225, 11223.66329010131, 12537.561185358469, 12544.121911466202, 13088.738225235536, 3405.4675396071866, 3441.8795342163153, 3532.540769699948, 3554.893353199382, 3660.084978755311, 73934.63032684856, 74060.62969685171, 76568.0, 77866.0, 77972.61013694895, 11013.449327533592, 11070.833937490945, 11112.666620001413, 11120.332780033224, 11225.101991840633, 22125.114995400003, 22141.225057122923, 22149.66775498369, 22192.55614887693, 22209.333719988426, 7789.649465774054, 7825.0, 8078.919210807817, 8091.919080809234, 8243.670253189925, 3932.7640341579595, 4082.7346222495444, 4167.604077612622, 4201.34879093741, 4251.5748425157235, 3349.866005359807, 3502.5796904371637, 3508.9824550877083, 3510.0, 3512.034190597606, 616.0912653835646, 629.4618101523223, 642.5116911147561, 645.380434782614, 656.7405874679475, 655.9606423614598, 680.2381332907175, 699.1191099214924, 699.923008469068, 725.8294300839299, 8983.865242021375, 8986.100849420156, 9224.0, 9247.200311131866, 9531.47576883278, 548.8765027868777, 629.9685015749194, 687.71116131225, 688.8587839492892, 692.4045321023915, 3920.1571662092215, 4138.91722165555, 4222.577742225814, 4242.830286788556, 4262.488501379854, 109687.0, 114150.0, 115384.0, 117084.41457792657, 118813.0, 102341.0, 102607.4869625662, 104537.0, 104965.47517262364, 106897.46551267194, 83459.0, 84904.57547712221, 88222.11777882268, 88532.5573372129, 88606.0, 7350.632468376667, 7351.0, 7764.0, 8156.225158609923, 8292.543910085004, 48530.0, 48587.75706121588, 49609.255861162834, 50274.497255028444, 50614.746926266605, 44671.55328446804, 45039.324410134526, 62118.68940655268, 70826.29173708196, 71331.0, 10943.124550035818, 11077.612283570037, 11332.773344533229, 11491.253068550517, 11684.474198660911, 11939.880601194225, 12070.396480176132, 12086.0, 12207.87792122103, 12217.877821221675, 11013.339199648046, 11057.944710276397, 11550.422478875855, 11672.88327116718, 11836.467358968695, 11779.646610601696, 11958.521659133537, 12286.692832679255, 12569.49722011146, 12858.515505593336, 11738.70653233676, 11981.341026243641, 12197.75604487923, 12600.243985360908, 12729.045321600732, 9576.808463830825, 9608.13526782593, 9877.703668889944, 10136.248982104802, 10459.738506537093, 9905.801883962424, 10419.0, 10498.895011049792, 10621.362718236931, 10752.51613677402], "value": 7072.541834766776, "unit": "score"}], "name": "dromaeo_css", "value": 7059.391992315355, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 110.0, 110.0, 113.0, 111.0, 110.0, 111.0, 111.0, 110.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 123.0, 127.0, 156.0, 126.0, 123.0, 129.0, 123.0, 169.0, 126.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 162.0, 161.0, 160.0, 159.0, 161.0, 162.0, 161.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 115.0, 75.0, 76.0, 76.0, 77.0, 103.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 117.0, 81.0, 82.0, 82.0, 112.0, 82.0, 82.0, 114.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 148.0, 148.0, 147.0, 148.0, 148.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 52.0, 53.0, 54.0, 54.0, 53.0, 54.0, 54.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 60.0, 60.0, 64.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 87.0, 80.0, 82.0, 80.0, 80.0, 80.0, 79.0, 79.0, 80.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 131.0, 133.0, 135.0, 131.0, 130.0, 142.0, 131.0, 169.0, 130.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 165.0, 162.0, 165.0, 165.0, 164.0, 162.0, 167.0, 169.0], "value": 165.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 66.0, 72.0, 64.0, 66.0, 64.0, 75.0, 71.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1493.1, "alertThreshold": 2.0}]} 10:25:58 INFO - Return code: 0 10:25:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:25:58 INFO - # TBPL SUCCESS # 10:25:58 INFO - Running post-action listener: _resource_record_post_action 10:25:58 INFO - [mozharness: 2016-10-21 17:25:58.366345Z] Finished run-tests step (success) 10:25:58 INFO - Running post-run listener: _resource_record_post_run 10:25:58 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393764864; Read time: 12; Write time: 338580 10:25:58 INFO - TinderboxPrint: CPU usage
13.0% 10:25:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:25:58 INFO - TinderboxPrint: I/O write bytes / time
393,764,864 / 338,580 10:25:58 INFO - TinderboxPrint: CPU idle
8,304.2 (86.9%) 10:25:58 INFO - TinderboxPrint: CPU user
1,197.8 (12.5%) 10:25:58 INFO - TinderboxPrint: Swap in / out
0 / 0 10:25:58 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103669760; Read time: 0; Write time: 118692 10:25:58 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 290095104; Read time: 0; Write time: 219888 10:25:59 INFO - Running post-run listener: _upload_blobber_files 10:25:59 INFO - Blob upload gear active. 10:25:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:25:59 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 10:25:59 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'] 10:25:59 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 10:25:59 INFO - (blobuploader) - INFO - Open directory for files ... 10:25:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:25:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:26:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:00 INFO - (blobuploader) - INFO - Done attempting. 10:26:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:26:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:26:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:00 INFO - (blobuploader) - INFO - Done attempting. 10:26:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:26:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:26:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:04 INFO - (blobuploader) - INFO - Done attempting. 10:26:04 INFO - (blobuploader) - INFO - Iteration through files over. 10:26:04 INFO - Return code: 0 10:26:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:26:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:26:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2852a93faa6c344102e621e2a3cb51b55ddda729b046c523ee0bc9d7a7a9db98321054ff7791dca22d252175ce1d7d4f1547fe8b25e4c883e0881a40a66704e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92ccb7ba5abc1247cb1e47b3d34f782f66a3d6cdbf386dcf1dd6f7bfc3b14589dd14832e37f86e97d39f11e86a3f68b24da714482bf625ee61985e7872212c06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bca312c9eba5ca44b452b8b1163c2834519676beecf4cbb73b1f063ac2a0d3df6ae78339f0d9674e2d7ae12180de2a239334f55a654f13ab5f8fa878869bb481"} 10:26:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:26:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:26:04 INFO - Contents: 10:26:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2852a93faa6c344102e621e2a3cb51b55ddda729b046c523ee0bc9d7a7a9db98321054ff7791dca22d252175ce1d7d4f1547fe8b25e4c883e0881a40a66704e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92ccb7ba5abc1247cb1e47b3d34f782f66a3d6cdbf386dcf1dd6f7bfc3b14589dd14832e37f86e97d39f11e86a3f68b24da714482bf625ee61985e7872212c06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bca312c9eba5ca44b452b8b1163c2834519676beecf4cbb73b1f063ac2a0d3df6ae78339f0d9674e2d7ae12180de2a239334f55a654f13ab5f8fa878869bb481"} 10:26:04 INFO - Running post-run listener: copy_logs_to_upload_dir 10:26:04 INFO - Copying logs to upload dir... 10:26:04 INFO - mkdir: /builds/slave/test/build/upload/logs 10:26:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.360449 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-21 10:26:04.128431) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-21 10:26:04.132370) ========= 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=17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2852a93faa6c344102e621e2a3cb51b55ddda729b046c523ee0bc9d7a7a9db98321054ff7791dca22d252175ce1d7d4f1547fe8b25e4c883e0881a40a66704e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92ccb7ba5abc1247cb1e47b3d34f782f66a3d6cdbf386dcf1dd6f7bfc3b14589dd14832e37f86e97d39f11e86a3f68b24da714482bf625ee61985e7872212c06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bca312c9eba5ca44b452b8b1163c2834519676beecf4cbb73b1f063ac2a0d3df6ae78339f0d9674e2d7ae12180de2a239334f55a654f13ab5f8fa878869bb481"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011420 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062241/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2852a93faa6c344102e621e2a3cb51b55ddda729b046c523ee0bc9d7a7a9db98321054ff7791dca22d252175ce1d7d4f1547fe8b25e4c883e0881a40a66704e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92ccb7ba5abc1247cb1e47b3d34f782f66a3d6cdbf386dcf1dd6f7bfc3b14589dd14832e37f86e97d39f11e86a3f68b24da714482bf625ee61985e7872212c06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bca312c9eba5ca44b452b8b1163c2834519676beecf4cbb73b1f063ac2a0d3df6ae78339f0d9674e2d7ae12180de2a239334f55a654f13ab5f8fa878869bb481"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-21 10:26:04.157618) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 10:26:04.157916) ========= 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=17051fcd5208b27b50bedfeb000001dd-1477069523.968218-1243387812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 10:26:04.240791) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-21 10:26:04.241110) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-21 10:26:04.241390) ========= ========= Total master_lag: 0.16 =========