builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1476493886.7 results: success (0) buildid: 20161014181124 builduid: 691830c5c83648b8b92eb7610be4cdea revision: df356e7c537e64562a719abe377a5c8871c5f863 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 18:11:26.695402) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 18:11:26.695775) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 18:11:26.696040) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 18:11:26.973786) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 18:11:26.974042) ========= 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=8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 18:11:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.0M=0s 2016-10-14 18:11:27 (35.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103318 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 18:11:27.090615) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 18:11:27.090925) ========= 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=8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021009 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 18:11:27.140312) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-14 18:11:27.140779) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev df356e7c537e64562a719abe377a5c8871c5f863 --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 df356e7c537e64562a719abe377a5c8871c5f863 --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=8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 18:11:27,495 truncating revision to first 12 chars 2016-10-14 18:11:27,496 Setting DEBUG logging. 2016-10-14 18:11:27,496 attempt 1/10 2016-10-14 18:11:27,496 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/df356e7c537e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 18:11:28,552 unpacking tar archive at: mozilla-inbound-df356e7c537e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.401921 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-14 18:11:28.556108) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 18:11:28.556406) ========= script_repo_revision: df356e7c537e64562a719abe377a5c8871c5f863 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 18:11:28.556880) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 18:11:28.557141) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 18:11:28.565987) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-14 18:11:28.566263) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:11:29 INFO - MultiFileLogger online at 20161014 18:11:29 in /builds/slave/test 18:11:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:11:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:11:29 INFO - {'append_to_log': False, 18:11:29 INFO - 'base_work_dir': '/builds/slave/test', 18:11:29 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:11:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:11:29 INFO - 'branch': 'Mozilla-Inbound', 18:11:29 INFO - 'buildbot_json_path': 'buildprops.json', 18:11:29 INFO - 'config_files': ('talos/linux_config.py',), 18:11:29 INFO - 'default_actions': ('clobber', 18:11:29 INFO - 'read-buildbot-config', 18:11:29 INFO - 'download-and-extract', 18:11:29 INFO - 'populate-webroot', 18:11:29 INFO - 'create-virtualenv', 18:11:29 INFO - 'install', 18:11:29 INFO - 'run-tests'), 18:11:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:11:29 INFO - 'download_minidump_stackwalk': True, 18:11:29 INFO - 'download_symbols': 'ondemand', 18:11:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:11:29 INFO - 'tooltool.py': '/tools/tooltool.py', 18:11:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:11:29 INFO - '/tools/misc-python/virtualenv.py')}, 18:11:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:11:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:11:29 INFO - 'installer_path': 'installer.exe', 18:11:29 INFO - 'log_level': 'info', 18:11:29 INFO - 'log_name': 'talos', 18:11:29 INFO - 'log_to_console': True, 18:11:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:11:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:11:29 INFO - 'opt_config_files': (), 18:11:29 INFO - 'pip_index': False, 18:11:29 INFO - 'sps_profile': False, 18:11:29 INFO - 'sps_profile_interval': 0, 18:11:29 INFO - 'suite': 'dromaeojs-e10s', 18:11:29 INFO - 'system_bits': '32', 18:11:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:11:29 INFO - 'title': 'talos-linux64-ix-001', 18:11:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:11:29 INFO - 'use_talos_json': True, 18:11:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:11:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:11:29 INFO - 'work_dir': 'build'} 18:11:29 INFO - [mozharness: 2016-10-15 01:11:29.020787Z] Running clobber step. 18:11:29 INFO - Running pre-action listener: _resource_record_pre_action 18:11:29 INFO - Running main action method: clobber 18:11:29 INFO - rmtree: /builds/slave/test/build 18:11:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:11:30 INFO - Running post-action listener: _resource_record_post_action 18:11:30 INFO - [mozharness: 2016-10-15 01:11:30.015390Z] Finished clobber step (success) 18:11:30 INFO - [mozharness: 2016-10-15 01:11:30.015489Z] Running read-buildbot-config step. 18:11:30 INFO - Running pre-action listener: _resource_record_pre_action 18:11:30 INFO - Running main action method: read_buildbot_config 18:11:30 INFO - Using buildbot properties: 18:11:30 INFO - { 18:11:30 INFO - "project": "", 18:11:30 INFO - "product": "firefox", 18:11:30 INFO - "script_repo_revision": "production", 18:11:30 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 18:11:30 INFO - "repository": "", 18:11:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 18:11:30 INFO - "buildid": "20161014181124", 18:11:30 INFO - "stage_platform": "linux64-pgo", 18:11:30 INFO - "basedir": "/builds/slave/test", 18:11:30 INFO - "buildnumber": 1788, 18:11:30 INFO - "platform": "ubuntu64_hw", 18:11:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:11:30 INFO - "slavebuilddir": "test", 18:11:30 INFO - "branch": "mozilla-inbound", 18:11:30 INFO - "revision": "df356e7c537e64562a719abe377a5c8871c5f863", 18:11:30 INFO - "slavename": "talos-linux64-ix-001", 18:11:30 INFO - "builduid": "691830c5c83648b8b92eb7610be4cdea", 18:11:30 INFO - "repo_path": "integration/mozilla-inbound" 18:11:30 INFO - } 18:11:30 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476482062/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:11:30 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476482062/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 18:11:30 INFO - Running post-action listener: _resource_record_post_action 18:11:30 INFO - [mozharness: 2016-10-15 01:11:30.017866Z] Finished read-buildbot-config step (success) 18:11:30 INFO - [mozharness: 2016-10-15 01:11:30.017954Z] Running download-and-extract step. 18:11:30 INFO - Running pre-action listener: _resource_record_pre_action 18:11:30 INFO - Running main action method: download_and_extract 18:11:30 INFO - mkdir: /builds/slave/test/build/tests 18:11:30 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')]} 18:11:30 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476482062/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:11:30 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476482062/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 18:11:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476482062/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 18:11:30 INFO - Downloaded 1361 bytes. 18:11:30 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:11:30 INFO - Using the following test package requirements: 18:11:30 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:11:30 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:11:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:11:30 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:11:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:11:30 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:11:30 INFO - u'jsshell-linux-x86_64.zip'], 18:11:30 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:11:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:11:30 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:11:30 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:11:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:11:30 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:11:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:11:30 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:11:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:11:30 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:11:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:11:30 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:11:30 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/1476482062/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:11:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476482062/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:11:30 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476482062/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:11:30 INFO - Http code: 200 18:11:30 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 18:11:30 INFO - x-amz-cf-id: gaGWZW5nWyX7biJsFD9E2dUMaKkMaFq09Z4aJ3tmNbyJjIgRYz1B0Q== 18:11:30 INFO - x-amz-replication-status: COMPLETED 18:11:30 INFO - x-amz-version-id: Vk2fO7t7O5HTZyh0u7nAgPzGUIm8wqtk 18:11:32 INFO - Expected file size: 22117056 18:11:32 INFO - Obtained file size: 22117056 18:11:36 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 18:11: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/1476482062/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:11: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/1476482062/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:11:36 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476482062/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:11:36 INFO - Http code: 200 18:11:36 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 18:11:36 INFO - x-amz-cf-id: u_CrzWEnmKrIij2qiUQto1j1i44eahW34Fek6dYRYF0MH7-G5ddoCw== 18:11:36 INFO - x-amz-replication-status: COMPLETED 18:11:36 INFO - x-amz-version-id: Vk2fO7t7O5HTZyh0u7nAgPzGUIm8wqtk 18:11:37 INFO - Expected file size: 22117056 18:11:37 INFO - Obtained file size: 22117056 18:11:41 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/1476482062/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:11:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476482062/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:11:41 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476482062/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:11:42 INFO - Http code: 200 18:11:42 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 18:11:42 INFO - x-amz-cf-id: e6yDPxqCjcR4gV0OrBlpSSBLBYL3VGJ3y4A2u1MexRzU4LRaewZiag== 18:11:42 INFO - x-amz-replication-status: COMPLETED 18:11:42 INFO - x-amz-version-id: wg5bFbl0lDc.9rhCQFW1rHu6jMBO0uHl 18:11:44 INFO - Expected file size: 14409028 18:11:44 INFO - Obtained file size: 14409028 18:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:45 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476482062/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:11:45 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476482062/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 18:11:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476482062/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 18:11:49 INFO - Downloaded 59615476 bytes. 18:11:49 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476482062/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:11:49 INFO - mkdir: /builds/slave/test/properties 18:11:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:11:49 INFO - Writing to file /builds/slave/test/properties/build_url 18:11:49 INFO - Contents: 18:11:49 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476482062/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:11:50 INFO - Running post-action listener: _resource_record_post_action 18:11:50 INFO - Running post-action listener: set_extra_try_arguments 18:11:50 INFO - [mozharness: 2016-10-15 01:11:50.070593Z] Finished download-and-extract step (success) 18:11:50 INFO - [mozharness: 2016-10-15 01:11:50.070821Z] Running populate-webroot step. 18:11:50 INFO - Running pre-action listener: _resource_record_pre_action 18:11:50 INFO - Running main action method: populate_webroot 18:11:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:11:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:11:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:11:50 INFO - '--tppagecycles', 18:11:50 INFO - '7'], 18:11:50 INFO - 'tests': ['tsvgm']}}, 18:11:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:11:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:11:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:11:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:11:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:11:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:11:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:50 INFO - 'talos_options': ['--disable-e10s'], 18:11:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:11:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:11:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:50 INFO - 'talos_options': ['--disable-e10s'], 18:11:50 INFO - 'tests': ['damp', 'tps']}, 18:11:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:50 INFO - 'tests': ['damp', 'tps']}, 18:11:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:11:50 INFO - 'tests': ['dromaeo_dom']}, 18:11:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:11:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:11:50 INFO - 'tests': ['basic_compositor_video']}, 18:11:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:11:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:11:50 INFO - 'tests': ['a11yr', 18:11:50 INFO - 'ts_paint', 18:11:50 INFO - 'tpaint', 18:11:50 INFO - 'sessionrestore', 18:11:50 INFO - 'sessionrestore_no_auto_restore', 18:11:50 INFO - 'tabpaint']}, 18:11:50 INFO - 'other-e10s': {'tests': ['a11yr', 18:11:50 INFO - 'ts_paint', 18:11:50 INFO - 'tpaint', 18:11:50 INFO - 'sessionrestore', 18:11:50 INFO - 'sessionrestore_no_auto_restore', 18:11:50 INFO - 'tabpaint']}, 18:11:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:11:50 INFO - 'ts_paint', 18:11:50 INFO - 'tpaint', 18:11:50 INFO - 'sessionrestore', 18:11:50 INFO - 'sessionrestore_no_auto_restore', 18:11:50 INFO - 'tabpaint']}, 18:11:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:11:50 INFO - 'ts_paint', 18:11:50 INFO - 'tpaint', 18:11:50 INFO - 'sessionrestore', 18:11:50 INFO - 'sessionrestore_no_auto_restore', 18:11:50 INFO - 'tabpaint']}, 18:11:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:11:50 INFO - 'tests': ['a11yr', 18:11:50 INFO - 'ts_paint', 18:11:50 INFO - 'tpaint', 18:11:50 INFO - 'sessionrestore', 18:11:50 INFO - 'sessionrestore_no_auto_restore', 18:11:50 INFO - 'tabpaint']}, 18:11:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:11:50 INFO - 'tests': ['a11yr', 18:11:50 INFO - 'ts_paint', 18:11:50 INFO - 'tpaint', 18:11:50 INFO - 'sessionrestore', 18:11:50 INFO - 'sessionrestore_no_auto_restore', 18:11:50 INFO - 'tabpaint']}, 18:11:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:11:50 INFO - 'tests': ['tsvgx', 18:11:50 INFO - 'tsvgr_opacity', 18:11:50 INFO - 'tart', 18:11:50 INFO - 'tscrollx', 18:11:50 INFO - 'cart']}, 18:11:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:11:50 INFO - 'tsvgr_opacity', 18:11:50 INFO - 'tart', 18:11:50 INFO - 'tscrollx', 18:11:50 INFO - 'cart']}, 18:11:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:50 INFO - 'talos_options': ['--disable-e10s'], 18:11:50 INFO - 'tests': ['tp5o']}, 18:11:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:50 INFO - 'tests': ['tp5o']}, 18:11:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:50 INFO - 'talos_options': ['--disable-e10s', 18:11:50 INFO - '--xperf_path', 18:11:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:11:50 INFO - 'tests': ['tp5n']}, 18:11:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:50 INFO - 'talos_options': ['--xperf_path', 18:11:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:11:50 INFO - 'tests': ['tp5n']}}, 18:11:50 INFO - 'talos.zip': {'path': '', 18:11:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:11:50 INFO - Running post-action listener: _resource_record_post_action 18:11:50 INFO - [mozharness: 2016-10-15 01:11:50.090761Z] Finished populate-webroot step (success) 18:11:50 INFO - [mozharness: 2016-10-15 01:11:50.090849Z] Running create-virtualenv step. 18:11:50 INFO - Running pre-action listener: _resource_record_pre_action 18:11:50 INFO - Running main action method: create_virtualenv 18:11:50 INFO - Creating virtualenv /builds/slave/test/build/venv 18:11:50 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 18:11:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:11:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:11:50 INFO - Using real prefix '/usr' 18:11:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:11:50 INFO - Installing distribute.............................................................................................................................................................................................done. 18:11:52 INFO - Installing pip.................done. 18:11:52 INFO - Return code: 0 18:11:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:11:52 INFO - Reading from file tmpfile_stdout 18:11:52 INFO - Output received: 18:11:52 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) 18:11:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:11: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')]} 18:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11: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')]} 18:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:52 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 0x7fdf38241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ff60>, '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 0x1750d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17511d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', '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 18:11:52 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 18:11:52 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 18:11:52 INFO - Using env: {'DISPLAY': ':0', 18:11:52 INFO - 'HOME': '/home/cltbld', 18:11:52 INFO - 'LANG': 'en_US.UTF-8', 18:11:52 INFO - 'LANGUAGE': 'en_US:en', 18:11:52 INFO - 'LOGNAME': 'cltbld', 18:11:52 INFO - 'MAIL': '/var/mail/cltbld', 18:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:52 INFO - 'MOZ_NO_REMOTE': '1', 18:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:52 INFO - 'NO_EM_RESTART': '1', 18:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:52 INFO - 'PWD': '/builds/slave/test', 18:11:52 INFO - 'SHELL': '/bin/bash', 18:11:52 INFO - 'SHLVL': '1', 18:11:52 INFO - 'TERM': 'linux', 18:11:52 INFO - 'TMOUT': '86400', 18:11:52 INFO - 'USER': 'cltbld', 18:11:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', 18:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:52 INFO - '_': '/tools/buildbot/bin/python'} 18:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:53 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 18:11:53 INFO - Cleaning up... 18:11:53 INFO - Return code: 0 18:11:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:11:53 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')]} 18:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:53 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')]} 18:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:53 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 0x7fdf38241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ff60>, '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 0x1750d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17511d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', '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 18:11:53 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 18:11:53 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 18:11:53 INFO - Using env: {'DISPLAY': ':0', 18:11:53 INFO - 'HOME': '/home/cltbld', 18:11:53 INFO - 'LANG': 'en_US.UTF-8', 18:11:53 INFO - 'LANGUAGE': 'en_US:en', 18:11:53 INFO - 'LOGNAME': 'cltbld', 18:11:53 INFO - 'MAIL': '/var/mail/cltbld', 18:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:53 INFO - 'MOZ_NO_REMOTE': '1', 18:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:53 INFO - 'NO_EM_RESTART': '1', 18:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:53 INFO - 'PWD': '/builds/slave/test', 18:11:53 INFO - 'SHELL': '/bin/bash', 18:11:53 INFO - 'SHLVL': '1', 18:11:53 INFO - 'TERM': 'linux', 18:11:53 INFO - 'TMOUT': '86400', 18:11:53 INFO - 'USER': 'cltbld', 18:11:53 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', 18:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:53 INFO - '_': '/tools/buildbot/bin/python'} 18:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:53 INFO - Downloading/unpacking psutil>=3.1.1 18:11:53 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 18:11:53 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 18:11:53 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 18:11:53 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 18:11:53 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 18:11:53 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 18:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:11:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:11:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:11:55 INFO - Installing collected packages: psutil 18:11:55 INFO - Running setup.py install for psutil 18:11:55 INFO - building 'psutil._psutil_linux' extension 18:11:55 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 18:11:55 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 18:11:55 INFO - building 'psutil._psutil_posix' extension 18:11:55 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 18:11:55 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 18:11:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:11:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:11:55 INFO - Successfully installed psutil 18:11:55 INFO - Cleaning up... 18:11:55 INFO - Return code: 0 18:11:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:11:55 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')]} 18:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:55 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')]} 18:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:55 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 0x7fdf38241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ff60>, '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 0x1750d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17511d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', '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 18:11:55 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 18:11:55 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 18:11:55 INFO - Using env: {'DISPLAY': ':0', 18:11:55 INFO - 'HOME': '/home/cltbld', 18:11:55 INFO - 'LANG': 'en_US.UTF-8', 18:11:55 INFO - 'LANGUAGE': 'en_US:en', 18:11:55 INFO - 'LOGNAME': 'cltbld', 18:11:55 INFO - 'MAIL': '/var/mail/cltbld', 18:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:55 INFO - 'MOZ_NO_REMOTE': '1', 18:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:55 INFO - 'NO_EM_RESTART': '1', 18:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:55 INFO - 'PWD': '/builds/slave/test', 18:11:55 INFO - 'SHELL': '/bin/bash', 18:11:55 INFO - 'SHLVL': '1', 18:11:55 INFO - 'TERM': 'linux', 18:11:55 INFO - 'TMOUT': '86400', 18:11:55 INFO - 'USER': 'cltbld', 18:11:55 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', 18:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:55 INFO - '_': '/tools/buildbot/bin/python'} 18:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:11:56 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 18:11:56 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 18:11:56 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 18:11:56 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 18:11:56 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 18:11:56 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 18:11:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:11:58 INFO - Installing collected packages: mozsystemmonitor 18:11:58 INFO - Running setup.py install for mozsystemmonitor 18:11:58 INFO - Successfully installed mozsystemmonitor 18:11:58 INFO - Cleaning up... 18:11:58 INFO - Return code: 0 18:11:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:58 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 0x7fdf38241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ff60>, '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 0x1750d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17511d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', '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 18:11:58 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 18:11:58 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 18:11:58 INFO - Using env: {'DISPLAY': ':0', 18:11:58 INFO - 'HOME': '/home/cltbld', 18:11:58 INFO - 'LANG': 'en_US.UTF-8', 18:11:58 INFO - 'LANGUAGE': 'en_US:en', 18:11:58 INFO - 'LOGNAME': 'cltbld', 18:11:58 INFO - 'MAIL': '/var/mail/cltbld', 18:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:58 INFO - 'MOZ_NO_REMOTE': '1', 18:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:58 INFO - 'NO_EM_RESTART': '1', 18:11:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:58 INFO - 'PWD': '/builds/slave/test', 18:11:58 INFO - 'SHELL': '/bin/bash', 18:11:58 INFO - 'SHLVL': '1', 18:11:58 INFO - 'TERM': 'linux', 18:11:58 INFO - 'TMOUT': '86400', 18:11:58 INFO - 'USER': 'cltbld', 18:11:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', 18:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:58 INFO - '_': '/tools/buildbot/bin/python'} 18:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:58 INFO - Downloading/unpacking jsonschema==2.5.1 18:11:58 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 18:11:58 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 18:11:58 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 18:11:58 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 18:11:58 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 18:11:58 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 18:12:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:12:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:12:00 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 18:12:00 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 18:12:00 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 18:12:00 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 18:12:00 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 18:12:00 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 18:12:00 INFO - Downloading functools32-3.2.3-2.tar.gz 18:12:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:12:00 INFO - warning: no files found matching '*.txt' 18:12:00 INFO - no previously-included directories found matching 'build' 18:12:00 INFO - no previously-included directories found matching 'dist' 18:12:00 INFO - no previously-included directories found matching '.git*' 18:12:00 INFO - Installing collected packages: jsonschema, functools32 18:12:00 INFO - Running setup.py install for functools32 18:12:00 INFO - warning: no files found matching '*.txt' 18:12:00 INFO - no previously-included directories found matching 'build' 18:12:00 INFO - no previously-included directories found matching 'dist' 18:12:00 INFO - no previously-included directories found matching '.git*' 18:12:00 INFO - Successfully installed jsonschema functools32 18:12:00 INFO - Cleaning up... 18:12:00 INFO - Return code: 0 18:12:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:12: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')]} 18:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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')]} 18:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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', '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 0x7fdf38241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ff60>, '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 0x1750d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17511d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', '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 18:12: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:12: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 functools32==3.2.3-2 18:12:00 INFO - Using env: {'DISPLAY': ':0', 18:12:00 INFO - 'HOME': '/home/cltbld', 18:12:00 INFO - 'LANG': 'en_US.UTF-8', 18:12:00 INFO - 'LANGUAGE': 'en_US:en', 18:12:00 INFO - 'LOGNAME': 'cltbld', 18:12:00 INFO - 'MAIL': '/var/mail/cltbld', 18:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:00 INFO - 'MOZ_NO_REMOTE': '1', 18:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:00 INFO - 'NO_EM_RESTART': '1', 18:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:00 INFO - 'PWD': '/builds/slave/test', 18:12:00 INFO - 'SHELL': '/bin/bash', 18:12:00 INFO - 'SHLVL': '1', 18:12:00 INFO - 'TERM': 'linux', 18:12:00 INFO - 'TMOUT': '86400', 18:12:00 INFO - 'USER': 'cltbld', 18:12:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', 18:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:00 INFO - '_': '/tools/buildbot/bin/python'} 18:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:12:01 INFO - Cleaning up... 18:12:01 INFO - Return code: 0 18:12:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:12:01 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')]} 18:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:01 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')]} 18:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:01 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 0x7fdf38241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ff60>, '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 0x1750d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17511d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', '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 18:12:01 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 18:12:01 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 18:12:01 INFO - Using env: {'DISPLAY': ':0', 18:12:01 INFO - 'HOME': '/home/cltbld', 18:12:01 INFO - 'LANG': 'en_US.UTF-8', 18:12:01 INFO - 'LANGUAGE': 'en_US:en', 18:12:01 INFO - 'LOGNAME': 'cltbld', 18:12:01 INFO - 'MAIL': '/var/mail/cltbld', 18:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:01 INFO - 'MOZ_NO_REMOTE': '1', 18:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:01 INFO - 'NO_EM_RESTART': '1', 18:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:01 INFO - 'PWD': '/builds/slave/test', 18:12:01 INFO - 'SHELL': '/bin/bash', 18:12:01 INFO - 'SHLVL': '1', 18:12:01 INFO - 'TERM': 'linux', 18:12:01 INFO - 'TMOUT': '86400', 18:12:01 INFO - 'USER': 'cltbld', 18:12:01 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', 18:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:01 INFO - '_': '/tools/buildbot/bin/python'} 18:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:01 INFO - Downloading/unpacking blobuploader==1.2.4 18:12:01 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 18:12:01 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 18:12:01 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 18:12:01 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 18:12:01 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 18:12:01 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 18:12:03 INFO - Downloading blobuploader-1.2.4.tar.gz 18:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:12:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:12:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:03 INFO - Downloading docopt-0.6.1.tar.gz 18:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:12:04 INFO - Installing collected packages: blobuploader, requests, docopt 18:12:04 INFO - Running setup.py install for blobuploader 18:12:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:12:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:12:04 INFO - Running setup.py install for requests 18:12:04 INFO - Running setup.py install for docopt 18:12:04 INFO - Successfully installed blobuploader requests docopt 18:12:04 INFO - Cleaning up... 18:12:04 INFO - Return code: 0 18:12:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12:04 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')]} 18:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:04 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')]} 18:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:04 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 0x7fdf38241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ff60>, '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 0x1750d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17511d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', '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 18:12:04 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 18:12:04 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 18:12:04 INFO - Using env: {'DISPLAY': ':0', 18:12:04 INFO - 'HOME': '/home/cltbld', 18:12:04 INFO - 'LANG': 'en_US.UTF-8', 18:12:04 INFO - 'LANGUAGE': 'en_US:en', 18:12:04 INFO - 'LOGNAME': 'cltbld', 18:12:04 INFO - 'MAIL': '/var/mail/cltbld', 18:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:04 INFO - 'MOZ_NO_REMOTE': '1', 18:12:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:04 INFO - 'NO_EM_RESTART': '1', 18:12:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:04 INFO - 'PWD': '/builds/slave/test', 18:12:04 INFO - 'SHELL': '/bin/bash', 18:12:04 INFO - 'SHLVL': '1', 18:12:04 INFO - 'TERM': 'linux', 18:12:04 INFO - 'TMOUT': '86400', 18:12:04 INFO - 'USER': 'cltbld', 18:12:04 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', 18:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:04 INFO - '_': '/tools/buildbot/bin/python'} 18:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:04 INFO - Running setup.py (path:/tmp/pip-feemTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:04 INFO - Running setup.py (path:/tmp/pip-LafIWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:05 INFO - Running setup.py (path:/tmp/pip-sXJdPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:05 INFO - Running setup.py (path:/tmp/pip-E_fdqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:05 INFO - Running setup.py (path:/tmp/pip-UehSiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:05 INFO - Running setup.py (path:/tmp/pip-bYI14h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:05 INFO - Running setup.py (path:/tmp/pip-TpbYVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:05 INFO - Running setup.py (path:/tmp/pip-kwUbow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:05 INFO - Running setup.py (path:/tmp/pip-ystZLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:05 INFO - Running setup.py (path:/tmp/pip-3AwsbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:05 INFO - Running setup.py (path:/tmp/pip-TCJ3Em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:05 INFO - Running setup.py (path:/tmp/pip-JlpN3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:05 INFO - Running setup.py (path:/tmp/pip-dS1Jhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:05 INFO - Running setup.py (path:/tmp/pip-_4E5TB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:05 INFO - Running setup.py (path:/tmp/pip-A_yNrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:05 INFO - Running setup.py (path:/tmp/pip-ftHF0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:06 INFO - Running setup.py (path:/tmp/pip-ThgZdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:12:06 INFO - Running setup.py install for manifestparser 18:12:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:12:06 INFO - Running setup.py install for mozcrash 18:12:06 INFO - Running setup.py install for mozdebug 18:12:06 INFO - Running setup.py install for mozdevice 18:12:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:12:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:12:06 INFO - Running setup.py install for mozfile 18:12:06 INFO - Running setup.py install for mozhttpd 18:12:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:12:06 INFO - Running setup.py install for mozinfo 18:12:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:12:06 INFO - Running setup.py install for mozInstall 18:12:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:12:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:12:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:12:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:12:06 INFO - Running setup.py install for mozleak 18:12:07 INFO - Running setup.py install for mozlog 18:12:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:12:07 INFO - Running setup.py install for moznetwork 18:12:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:12:07 INFO - Running setup.py install for mozprocess 18:12:07 INFO - Running setup.py install for mozprofile 18:12:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:12:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:12:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:12:07 INFO - Running setup.py install for mozrunner 18:12:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:12:07 INFO - Running setup.py install for mozscreenshot 18:12:07 INFO - Running setup.py install for moztest 18:12:07 INFO - Running setup.py install for mozversion 18:12:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:12:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:12:07 INFO - Cleaning up... 18:12:07 INFO - Return code: 0 18:12:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12:07 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')]} 18:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:07 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')]} 18:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:08 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 0x7fdf38241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ff60>, '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 0x1750d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17511d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', '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 18:12:08 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 18:12:08 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 18:12:08 INFO - Using env: {'DISPLAY': ':0', 18:12:08 INFO - 'HOME': '/home/cltbld', 18:12:08 INFO - 'LANG': 'en_US.UTF-8', 18:12:08 INFO - 'LANGUAGE': 'en_US:en', 18:12:08 INFO - 'LOGNAME': 'cltbld', 18:12:08 INFO - 'MAIL': '/var/mail/cltbld', 18:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:08 INFO - 'MOZ_NO_REMOTE': '1', 18:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:08 INFO - 'NO_EM_RESTART': '1', 18:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:08 INFO - 'PWD': '/builds/slave/test', 18:12:08 INFO - 'SHELL': '/bin/bash', 18:12:08 INFO - 'SHLVL': '1', 18:12:08 INFO - 'TERM': 'linux', 18:12:08 INFO - 'TMOUT': '86400', 18:12:08 INFO - 'USER': 'cltbld', 18:12:08 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', 18:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:08 INFO - '_': '/tools/buildbot/bin/python'} 18:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:08 INFO - Running setup.py (path:/tmp/pip-CoNGNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:08 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)) 18:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:08 INFO - Running setup.py (path:/tmp/pip-T10CwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:08 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)) 18:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:08 INFO - Running setup.py (path:/tmp/pip-0OIMXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:08 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)) 18:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:08 INFO - Running setup.py (path:/tmp/pip-3t_9Uu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:08 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)) 18:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:08 INFO - Running setup.py (path:/tmp/pip-JMjMvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:08 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)) 18:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:08 INFO - Running setup.py (path:/tmp/pip-VmMO5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12:08 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)) 18:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:08 INFO - Running setup.py (path:/tmp/pip-qIJ6_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:08 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)) 18:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:08 INFO - Running setup.py (path:/tmp/pip-oNIkeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:08 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)) 18:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:08 INFO - Running setup.py (path:/tmp/pip-LwFmaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:08 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)) 18:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:08 INFO - Running setup.py (path:/tmp/pip-45uFpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:08 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)) 18:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:08 INFO - Running setup.py (path:/tmp/pip-RJSphI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:09 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)) 18:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:09 INFO - Running setup.py (path:/tmp/pip-CyGZV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:09 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)) 18:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:09 INFO - Running setup.py (path:/tmp/pip-BxZDFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:09 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)) 18:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:09 INFO - Running setup.py (path:/tmp/pip-SLytHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:09 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)) 18:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:09 INFO - Running setup.py (path:/tmp/pip-TQty3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:09 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)) 18:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:09 INFO - Running setup.py (path:/tmp/pip-nH1QKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:09 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)) 18:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:09 INFO - Running setup.py (path:/tmp/pip-Nw8rTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:09 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)) 18:12:09 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)) 18:12:09 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)) 18:12:09 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)) 18:12:09 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)) 18:12:09 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)) 18:12:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:12:09 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 18:12:09 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 18:12:09 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 18:12:09 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 18:12:09 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 18:12:09 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 18:12:11 INFO - Downloading blessings-1.6.tar.gz 18:12:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:12:11 INFO - Installing collected packages: blessings 18:12:11 INFO - Running setup.py install for blessings 18:12:11 INFO - Successfully installed blessings 18:12:11 INFO - Cleaning up... 18:12:11 INFO - Return code: 0 18:12:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:12:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:12:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:12:11 INFO - Reading from file tmpfile_stdout 18:12:11 INFO - Current package versions: 18:12:11 INFO - argparse == 1.2.1 18:12:11 INFO - blessings == 1.6 18:12:11 INFO - blobuploader == 1.2.4 18:12:11 INFO - docopt == 0.6.1 18:12:11 INFO - functools32 == 3.2.3-2 18:12:11 INFO - jsonschema == 2.5.1 18:12:11 INFO - manifestparser == 1.1 18:12:11 INFO - mozInstall == 1.12 18:12:11 INFO - mozcrash == 0.17 18:12:11 INFO - mozdebug == 0.1 18:12:11 INFO - mozdevice == 0.48 18:12:11 INFO - mozfile == 1.2 18:12:11 INFO - mozhttpd == 0.7 18:12:11 INFO - mozinfo == 0.9 18:12:11 INFO - mozleak == 0.1 18:12:11 INFO - mozlog == 3.4 18:12:11 INFO - moznetwork == 0.27 18:12:11 INFO - mozprocess == 0.23 18:12:11 INFO - mozprofile == 0.28 18:12:11 INFO - mozrunner == 6.12 18:12:11 INFO - mozscreenshot == 0.1 18:12:11 INFO - mozsystemmonitor == 0.3 18:12:11 INFO - moztest == 0.7 18:12:11 INFO - mozversion == 1.4 18:12:11 INFO - psutil == 3.1.1 18:12:11 INFO - requests == 1.2.3 18:12:11 INFO - wsgiref == 0.1.2 18:12:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:11 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 0x7fdf38241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ff60>, '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 0x1750d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17511d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', '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 18:12:11 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 18:12:11 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 18:12:11 INFO - Using env: {'DISPLAY': ':0', 18:12:11 INFO - 'HOME': '/home/cltbld', 18:12:11 INFO - 'LANG': 'en_US.UTF-8', 18:12:11 INFO - 'LANGUAGE': 'en_US:en', 18:12:11 INFO - 'LOGNAME': 'cltbld', 18:12:11 INFO - 'MAIL': '/var/mail/cltbld', 18:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:11 INFO - 'MOZ_NO_REMOTE': '1', 18:12:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:11 INFO - 'NO_EM_RESTART': '1', 18:12:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:11 INFO - 'PWD': '/builds/slave/test', 18:12:11 INFO - 'SHELL': '/bin/bash', 18:12:11 INFO - 'SHLVL': '1', 18:12:11 INFO - 'TERM': 'linux', 18:12:11 INFO - 'TMOUT': '86400', 18:12:11 INFO - 'USER': 'cltbld', 18:12:11 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', 18:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:11 INFO - '_': '/tools/buildbot/bin/python'} 18:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:12 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)) 18:12:12 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)) 18:12:12 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)) 18:12:12 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)) 18:12:12 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)) 18:12:12 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)) 18:12:12 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)) 18:12:12 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)) 18:12:12 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)) 18:12:12 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)) 18:12:12 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)) 18:12:12 INFO - Cleaning up... 18:12:12 INFO - Return code: 0 18:12:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:12 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 0x7fdf38241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ff60>, '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 0x1750d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17511d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', '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 18:12:12 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 18:12:12 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 18:12:12 INFO - Using env: {'DISPLAY': ':0', 18:12:12 INFO - 'HOME': '/home/cltbld', 18:12:12 INFO - 'LANG': 'en_US.UTF-8', 18:12:12 INFO - 'LANGUAGE': 'en_US:en', 18:12:12 INFO - 'LOGNAME': 'cltbld', 18:12:12 INFO - 'MAIL': '/var/mail/cltbld', 18:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:12 INFO - 'MOZ_NO_REMOTE': '1', 18:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:12 INFO - 'NO_EM_RESTART': '1', 18:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:12 INFO - 'PWD': '/builds/slave/test', 18:12:12 INFO - 'SHELL': '/bin/bash', 18:12:12 INFO - 'SHLVL': '1', 18:12:12 INFO - 'TERM': 'linux', 18:12:12 INFO - 'TMOUT': '86400', 18:12:12 INFO - 'USER': 'cltbld', 18:12:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', 18:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:12 INFO - '_': '/tools/buildbot/bin/python'} 18:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:12:12 INFO - Cleaning up... 18:12:12 INFO - Return code: 0 18:12:12 INFO - Running post-action listener: _resource_record_post_action 18:12:12 INFO - Running post-action listener: _start_resource_monitoring 18:12:12 INFO - Starting resource monitoring. 18:12:12 INFO - [mozharness: 2016-10-15 01:12:12.360779Z] Finished create-virtualenv step (success) 18:12:12 INFO - [mozharness: 2016-10-15 01:12:12.361339Z] Running install step. 18:12:12 INFO - Running pre-action listener: _resource_record_pre_action 18:12:12 INFO - Running main action method: install 18:12:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:12:12 INFO - Reading from file tmpfile_stdout 18:12:12 INFO - Detecting whether we're running mozinstall >=1.0... 18:12:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:12:12 INFO - Reading from file tmpfile_stdout 18:12:12 INFO - Output received: 18:12:12 INFO - Usage: mozinstall [options] installer 18:12:12 INFO - Options: 18:12:12 INFO - -h, --help show this help message and exit 18:12:12 INFO - -d DEST, --destination=DEST 18:12:12 INFO - Directory to install application into. [default: 18:12:12 INFO - "/builds/slave/test"] 18:12:12 INFO - --app=APP Application being installed. [default: firefox] 18:12:12 INFO - mkdir: /builds/slave/test/build/application 18:12:12 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'] 18:12:12 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 18:12:29 INFO - Reading from file tmpfile_stdout 18:12:29 INFO - Output received: 18:12:29 INFO - /builds/slave/test/build/application/firefox/firefox 18:12:29 INFO - Running post-action listener: _resource_record_post_action 18:12:29 INFO - [mozharness: 2016-10-15 01:12:29.647250Z] Finished install step (success) 18:12:29 INFO - [mozharness: 2016-10-15 01:12:29.647522Z] Running run-tests step. 18:12:29 INFO - Running pre-action listener: _resource_record_pre_action 18:12:29 INFO - Running main action method: run_tests 18:12:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:12:29 INFO - Python 2.7.3 18:12:29 INFO - Return code: 0 18:12:29 INFO - grabbing minidump binary from tooltool 18:12:29 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')]} 18:12:29 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 0x174ff60>, '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 0x1750d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17511d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:12:29 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 18:12:29 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 18:12:29 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 18:12:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:12:29 INFO - Return code: 0 18:12:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:12:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:12:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:12:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:12:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:12:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476482062/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476482062/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:12:29 INFO - Using env: {'DISPLAY': ':0', 18:12:29 INFO - 'HOME': '/home/cltbld', 18:12:29 INFO - 'LANG': 'en_US.UTF-8', 18:12:29 INFO - 'LANGUAGE': 'en_US:en', 18:12:29 INFO - 'LOGNAME': 'cltbld', 18:12:29 INFO - 'MAIL': '/var/mail/cltbld', 18:12:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:12:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:29 INFO - 'MOZ_NO_REMOTE': '1', 18:12:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:29 INFO - 'NO_EM_RESTART': '1', 18:12:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:29 INFO - 'PWD': '/builds/slave/test', 18:12:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:12:29 INFO - 'SHELL': '/bin/bash', 18:12:29 INFO - 'SHLVL': '1', 18:12:29 INFO - 'TERM': 'linux', 18:12:29 INFO - 'TMOUT': '86400', 18:12:29 INFO - 'USER': 'cltbld', 18:12:29 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632', 18:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:29 INFO - '_': '/tools/buildbot/bin/python'} 18:12:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476482062/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:12:29 INFO - mozversion application_buildid: 20161014145422 18:12:29 INFO - mozversion application_changeset: df356e7c537e64562a719abe377a5c8871c5f863 18:12:29 INFO - mozversion application_display_name: Nightly 18:12:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:12:29 INFO - mozversion application_name: Firefox 18:12:29 INFO - mozversion application_remotingname: firefox 18:12:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:12:29 INFO - mozversion application_vendor: Mozilla 18:12:29 INFO - mozversion application_version: 52.0a1 18:12:29 INFO - mozversion platform_buildid: 20161014145422 18:12:29 INFO - mozversion platform_changeset: df356e7c537e64562a719abe377a5c8871c5f863 18:12:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:12:29 INFO - mozversion platform_version: 52.0a1 18:12:29 INFO - using testdate: 1476493949 18:12:29 INFO - actual date: 1476493949 18:12:29 INFO - starting webserver on 'localhost:54998' 18:12:29 INFO - SUITE-START | Running 2 tests 18:12:29 INFO - TEST-START | dromaeo_css 18:12:29 INFO - operating with platform_type : linux_ 18:12:29 INFO - Initialising browser for dromaeo_css test... 18:12:29 INFO - TEST-INFO | started process 13806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgkagSI/profile http://localhost:54998/getInfo.html) 18:12:34 INFO - PROCESS | 13806 | __metrics Screen width/height:1600/1200 18:12:34 INFO - PROCESS | 13806 | colorDepth:24 18:12:34 INFO - PROCESS | 13806 | Browser inner width/height: 1024/697 18:12:34 INFO - PROCESS | 13806 | __metrics 18:12:35 ERROR - PROCESS | 13806 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 18:12:36 INFO - TEST-INFO | 13806: exit 0 18:12:36 INFO - Browser initialized. 18:12:36 INFO - Running cycle 1/1 for dromaeo_css test... 18:12:36 INFO - TEST-INFO | started process 13930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgkagSI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:12:48 INFO - PROCESS | 13930 | RSS: Main: 182419456 18:12:48 INFO - PROCESS | 13930 | 18:13:38 INFO - PROCESS | 13930 | 1476494018027 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] 18:15:50 INFO - PROCESS | 13930 | Cycle 1(1): loaded http://localhost:54998/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54998/tests/dromaeo/cssquery-ext.html) 18:15:51 INFO - PROCESS | 13930 | RSS: Main: 196091904 18:15:51 INFO - PROCESS | 13930 | 18:18:53 INFO - PROCESS | 13930 | Cycle 1(1): loaded http://localhost:54998/tests/dromaeo/cssquery-ext.html (next: http://localhost:54998/tests/dromaeo/cssquery-jquery.html) 18:18:54 INFO - PROCESS | 13930 | RSS: Main: 194502656 18:18:54 INFO - PROCESS | 13930 | 18:21:56 INFO - PROCESS | 13930 | Cycle 1(1): loaded http://localhost:54998/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54998/tests/dromaeo/cssquery-mootools.html) 18:21:56 INFO - PROCESS | 13930 | RSS: Main: 196886528 18:21:56 INFO - PROCESS | 13930 | 18:24:58 INFO - PROCESS | 13930 | Cycle 1(1): loaded http://localhost:54998/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54998/tests/dromaeo/cssquery-prototype.html) 18:24:59 INFO - PROCESS | 13930 | RSS: Main: 193228800 18:24:59 INFO - PROCESS | 13930 | 18:28:01 INFO - PROCESS | 13930 | Cycle 1(1): loaded http://localhost:54998/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54998/tests/dromaeo/cssquery-yui.html) 18:28:02 INFO - PROCESS | 13930 | RSS: Main: 196780032 18:28:02 INFO - PROCESS | 13930 | 18:31:05 INFO - PROCESS | 13930 | Cycle 1(1): loaded http://localhost:54998/tests/dromaeo/cssquery-yui.html (next: http://localhost:54998/tests/dromaeo/cssquery-dojo.html) 18:31:05 INFO - PROCESS | 13930 | RSS: Main: 196575232 18:31:05 INFO - PROCESS | 13930 | 18:31:05 INFO - PROCESS | 13930 | __start_tp_report 18:31:05 INFO - PROCESS | 13930 | _x_x_mozilla_page_load 18:31:05 INFO - PROCESS | 13930 | _x_x_mozilla_page_load_details 18:31:05 INFO - PROCESS | 13930 | |i|pagename|runs| 18:31:05 INFO - PROCESS | 13930 | |0;dojo.html;3038.4682680530905;3073;3076.7384772294354;3101.782875198737;3102.2709663229143;5168.689878607286;5248.816291429801;5253.763580638871;5322.201669749539;5328.147496400572;5228.843134705955;5282.339707536558;5362.6514276572;5370.838874833751;5424.213489044087;4948.208286674133;4954.628402869781;4998.10034193845;5023.572996295319;5062.645614806965;4967.726775027372;4977.576905962979;4992.800287988494;5057.089723849724;5101.030804147219;5027.824026159067;5040.899182016376;5092.949070509303;5093.363329583802;5154.355705536808;4821.54195351441;4854.199057155565;4856.660033797635;4887.608991280689;4902.411710594716;4813.566778989873;4822.879428014293;4841.419029716421;4848.636352273558;4896.804127834882;5340.279062326575;5433.809816656398;5463.672179669233;5467.316585426822;5482.91775623366;5717.48542631161;5794.985877471468;5862.38444963277;5907.054871220584;5916.645001299936;5934.465898069151;5950.375210602868;5976.8505787355225;5986.191864098335;5988.97005514974;5328.866778330573;5507.394186639466;5540.335159780771;5549.306336707911;5555.30558680165;5761.8559536011935;5803.274590676166;5814.941850581525;5879;5895.322037965603;5569.916451253234;5577.52591029767;5608.130739735348;5619.072852979294;5628.465295796893;5649.209110724501;5677.545796336283;5685.658860468385;5689.118186681071;5705.429457054344;5522.30971128609;5704.657720536781;5763.366029736726;5770.913436298459;5802.88394232113;5725.656460612377;5765.135229715576;5767.048437007847;5776.075827867521;5778.306603207642;4394.165108629414;4403.559644035635;4419.668524860648;4434.600885920218;4461.152381047591;3785.261873934556;3844.5386553613184;3865.381538953754;3891.474650922146;3955.7428767130045;5451.754671039813;5458.727063646802;5497.257870187554;5501.752421141058;5544.63959842609;5784.942150578525;5789.044807606698;5790.94209057904;5793.507551858139;5802.100674395476;5381.48875856793;5427.972860135753;5430.647007944471;5434.076207044812;5446.319210098738;4833.854984350475;4861.197902346144;4868.2210846264425;4872.78072486739;4880.145974454456;5922.940770592239;5932.940670593239;5935.347111817783;5936.495397891142;5937.70311484424;5711.714414279187;5759.164921086335;5764.308283006066;5774.82675519735;5779.942200577941;5931.406859314034;5940.970295148497;5951.345352011189;5954.225950626565;5962.672053036951;5725.484706376279;5750.568707347049;5753.309602847685;5755.280589926259;5769.653820770767;5610.887782244414;5661.858453538694;5696.971515142398;5737.282839645044;5862.912056319244;5562.833115006556;5637.041702910597;5647.632903861236;5648.209250704823;5651.519620832275;5467.07059799827;5538.307711536058;5577;5621.606487545996;5624.409437009219;5536.335639723259;5586.720663966867;5615.494605485363;5617.662940223436;5669.262995810518;5750.769969201185;5753.654780713171;5754.971225143848;5756.136579513107;5757.712114394348;5414.810481633124;5614.242077319673;5625.578081643975;5627.212190293444;5631.971840140773 18:31:05 INFO - PROCESS | 13930 | |1;ext.html;568.0513542384218;575.2062154227167;579.3308728418675;579.4090028171265;587.145703002132;43304.350434743465;44938.32592511115;45016.774916125374;48094.27858582124;48097.27854082191;46136.30795538061;46223;46419.53580464194;46458.53541464584;46543.76728116363;8693.30453563715;8846.115388461134;8855.645774169057;8858.468491890475;8882.067382924797;8660.610272537719;8763.816884720545;8778.561071946377;8810.163034511743;8877.245434138074;8856.070112638177;8884.555772211395;8918.420302680337;8942.284617230638;8943.150400711922;8792.384533082686;8834.646614135427;8863.157999989991;8894.332925030649;8921.107889211093;8700.390972631918;8778.64885404583;8791.428557143765;8810.339224558184;8841.204291613722;42289.36565951513;42294.78852605717;42399.57600423987;42465.57534424647;42525.78737106295;3440.55272814535;3481.56480439945;3497.702695270905;3619.9095022624647;3898.9805050974846;28994.13017609475;29025;29406.705932940826;29861.850690746625;30715.232119196975;4294.849680261207;4295.355696645497;4299.204647140258;4463.910721785546;4507.076049409863;320089;320813;321814;321845;322188.9999999977;57534;57827.81946992872;57872.421275786706;57880.13179802307;58012.70993645005;59010;59661.70169149213;60113.39886601078;60127;60743.39256607377;14897.106173629616;14984;15047.097174169585;15089.24553772307;15138.091714497166;11227.438628068563;11291.266067705574;11324.94337528307;11381.430928453545;11382.260153090023;15666.295016724047;16673.91663041677;16738.83261167397;16772.832271677125;16775.748363774554;3210.5665735125926;5542.334919809568;5605.411431799684;5890.4993075589055;5894.204282421818;915.3729695158837;1008.702432782331;1104.9060829829393;1110.8555887734542;1148.8449059377044;32556.837215814245;32680.83659581687;32877.83561082179;32957.17607059795;33525.83237083799;1069.7058308965097;1070.1652710885521;1070.9410982396043;1126.0259875207887;1131.2138064045573;15930.840691593168;17056.829431705773;17077.658446831243;17283.567910802078;17322.30710771555;517152.1423928788;519464;520214;523741;525658;58785;59755;60036.39963600395;60122;60171.69914150401;1267.4043199696127;1303.8109474126388;1318.8021796730568;1337.6455239361576;1337.9197248165142;30624.387512249185;31278.843605781825;32224;32266;32674.83662581672;52296.47703522916;52507.73746131245;52687.473125268254;52697;52961.735191323794;457954;459948.9043431346;460936;462083;462743;28240.717592824632;28345.574816378183;28687.42625147527;28787.424251515273;28964.7103528962;47126;47790.52209477861;47872;48008.27987580259;48663.27005094997;40725.59274407218;41140;44804;45259.54740452685;46041.30938035865;41699.58300416957;42156.78921605372;42193.36709949415;43277.35083973806;43940;41317.1736565273;41365.172696546506;42271.7886410566;42363.57636423596;42430;32222.516662250553;36918.07704807401;37858.81070594629;38181.80005185224;38537.03657408475;28681.569776452954;28945.710542894303;29136.56295155532;29213;29297.560536591543 18:31:05 INFO - PROCESS | 13930 | |2;jquery.html;377.36037416578904;378.28126559536895;389.441151946956;389.53645162256913;391.4441493079826;17362.30550777969;19821.008949552517;19866.304679336226;20069.197232110735;20328.390148295537;18271.26914923405;18333;18518.814811851877;18621.16204770785;18857.15142818573;5117.104506711329;5556.222128901947;5736.8852622947725;5794.130880367937;5803.129530570427;5652.547796176316;5727.42725727426;5782.277215348082;5785.797497087603;5800.129980502916;5568.387477377485;5603.60774745768;5646.632968857011;5746.109353050284;5778.335491418477;5626.099824028177;5626.859328516779;5629.493345598875;5631.4087020862835;5689.175069614904;5026.246063090529;5029.119904016782;5031.22016087507;5059.873503162414;5064.518870707314;22484.775152248432;22556;22632;22720.77279227203;22767.77232227673;2499.5875680512695;2499.787518060967;2525.305540976228;2539.5555777739005;2565.486902619465;14308.928455357656;14552.636184095376;14604.488842890449;14667.92666036663;14917.552473425814;1827.2782251010908;1881.388548721671;1932.3140285198692;1942.5435022769639;1991.4623051776084;76649.23350766477;77203.61398193029;78702;79401.20598793996;80245.96310553406;8964.551772411354;9033.36766426357;9109.863352049591;10478.580856765797;10802.783944321069;14707.632309192142;14721.26393680333;14742.705145897022;14743.189124598035;14789.556313310617;7381.298776616213;7561.281678240558;7571.3564347030015;7773.378129749606;7894.842103157905;7170.569765814068;7216.9278307216255;7448.329650331496;7474.739398542778;7487.438442116863;6215.751369945242;6343.809685709436;6432.646204458706;6449.3873082057125;6582.210134783857;1832.4227868221735;1917.947795858446;1951.7755458122215;1954.4722924810221;1979.0698371765536;907.2651152566442;943.8961714211431;982.3467394182932;1010.8483727440796;1046.576136664652;19261.22955081781;19620.117094730773;19631;19678.803211967985;19777.15459712351;979.588572799426;1001.759577701361;1018.9643362482277;1019.7246743379246;1067.1036329483115;10680.62617808373;11232.719182020515;11306.604268850551;11332.943335283271;11421.257618254787;217314;220425;220608;438536;441781;95200.52399737957;96685;99340.50329748305;99881;100606;938.7324612485545;940.1444685336311;977.1498796047484;984.1880448629909;990.8860481044773;16318.836811631732;16901.91549042247;17328.48014559565;17507.21217545188;17905.28378864883;38314.6168538311;39127.608723912395;41810.58189418189;42308.788456057526;43754.56245437632;55687;55850.16224756713;55993.16010259931;56758.86482270414;58097.4190258092;8186.935698359175;8421.536815475207;8608.741737747878;8612.224899759052;8781.912180878366;8640.611172497378;12992.350382481027;13025.283609401575;13072.281024543741;13117.540886068942;11200.551977920792;11388.658340249805;11563.826542601699;11573.132015098732;11740.41297935117;11388.886111139114;11455.140864435367;11479.885201147881;11517.481713322753;11695.415229238673;11426.428678565871;11522.53909843597;11745.47145378443;11825.704357391134;11962.102842287037;8026.1572534883;8162.632681529464;8362.958185209034;8386.412951093365;8627.137286271323;8883.689070882747;11557.537698491966;11560.595379161688;11664.125190610568;11986.880131198577 18:31:05 INFO - PROCESS | 13930 | |3;mootools.html;1468.654866106465;1498.176003198241;1652.743824707171;1743.5205318537407;1772.0696634267001;7674.386049116071;7943.960280198591;8264.214899584545;8835.690750823722;8911.777205569855;8251.91748082519;8484.66061357545;8536.530490823017;8653.437526560769;8707.608157632905;2172.152860384447;2228.4428892776805;2228.5320082782555;2231.7991380775725;2241.7870302321335;2194.1333173396497;2197;2228.3315005498366;2233.218373569246;2235.731712194539;2171.3703026122407;2182.5416662500893;2185.9344219673435;2186.365953873375;2223.4219103033165;2178.553396553703;2180.4003898927845;2186.267600353883;2187.595294870454;2192.8574642648177;2142.389419015573;2176.7714389988982;2178.3464960511783;2187.660912558556;2187.7812218778154;8651.610677519528;8669.523176225304;8670.783230419227;8726.38915275931;8727.781805454852;4717.127331443694;4879.048585525824;4882.218844984821;4887.633427492952;4901.975490122562;3090.1082730987555;3118.220444888778;3137.905862824119;3160.8893688720786;3175.237942893689;984.7242772023844;1034.0848349210928;1040.3965699894043;1052.7578656908954;1062.2511129653576;11198.272112312674;11237.943810280978;11238.550457981672;11267.04230140439;11301.999999999918;4202;4396.1867054595;4420.977895110504;4516.1419330327135;4572.748498832596;9353.39202951806;9430.717078487656;9444.055594440639;9450.621975121056;9458.33791634579;4989.376327959005;5005.049040682259;5013.974930125399;5017.949820501748;5029.597632189416;4484.932726009112;4563.657725670588;4606.539346065434;4719.716816990992;4720.055988802184;3517.3141237458963;3540.415831387844;3557.7331700122595;3559.60844307126;3613.638636136418;1040.69819752271;1048.1562342314357;1051.374432212832;1056.1972900595604;1068.5779117248644;874.2699845628844;947.4552132523827;964.3683387381277;983.5721461164417;996.038822536256;5552.639078459887;5594.608377413542;5869.618474799125;6074.271087469532;6079.544034197453;430.09465076015164;438.89027743064236;443.61848810023355;446.6359916667905;448.0255444408399;3761;3834.5206849143856;3876.6898648108086;4064.6545043671617;4107.623945978131;10241;10589;10630.734231644115;10656;10683.732906677395;10539.473026348653;10565.04914557678;10604.416757078281;10605.151587872951;10621.5220315086;7961.920380796234;7965.920340796518;7977;8027.919720802834;8117.431779775359;5722.370539240764;5746.597738158289;5806.303243610793;5867.706614669335;5884.676342801187;9068.954655226682;9510.809783804423;9654.469004204837;9659.806803863743;9764;9466.621335146518;9537.52312384392;9769.951150244204;9812.116909478182;9970.700878973643;6756.324367563205;6972.721091156297;7150.392216661642;7400.629968501661;7543.358814500829;7972.162922893012;8182.386321025828;8248.092709802037;8264.338852891635;8283.58582070906;7265.12818461788;7389.519681220703;7398.556086634819;7491.737789177353;7572.583507907118;7249.057622509251;7339.77980660581;7347.889781653173;7362.9631851840395;7459.179490255959;6343.55595108338;6473.287938326875;6477.4170324671;6479.1901012373455;6498.512611554058;5035.420926593342;5069.467705890828;5099.592032637454;5162.819301324435;5241.187615919539;5031.496850314939;5032;5071.771770270273;5184.429712731521;5237.3453318335205 18:31:05 INFO - PROCESS | 13930 | |4;prototype.html;300.20595524836796;310.4845955713513;321.43908879006136;324.51485029880325;330.6957599008912;5325.387580428252;5387.838364849061;5554.555635549156;5569.248151499546;5575.665460072399;5186.299849520314;5354.705491197982;5372.811951581695;5400.432954539776;5439.945600544003;4234.513031001428;4242.745435273893;4258.97870510647;4260.446142001551;4272.615464608185;4140.3168477201225;4195.433616461784;4224.683148763839;4233.428487154226;4235.9364609530885;4217.861177482078;4217.978910105445;4229.238737027334;4229.746215227081;4235.957640423602;4177.811998460076;4222.598853108965;4223.282042052859;4232.645553422906;4254.617084462382;3624.039629498185;3745.793981331026;3747.6439738224826;3749.362608356586;3753.1367785409507;5186.262602028325;5195.766190521435;5220.8433746987275;5265.763040663141;5317.335333083364;4814.376164990089;4826.855194344175;4839.516048395168;4841.104395686809;4868.732219727914;5261.842144735664;5532.585056120807;5566.415526369713;5568.86077848053;5697.943020569783;3966.8809935701975;3985.6612187964056;3996.360582306817;4001.579834117405;4009.0979529605897;5824.883502329972;5826.533877289807;5886.440788125121;5954.166416701665;5954.523638108984;3917.7845218512684;4028.4158796974275;4034.8587799426878;4041.2927737645796;4042.5957404259925;4058.8782336529953;4061.5126184857413;4071.450354202204;4077.6330130288416;4097.795110244536;4702.224133018014;4723.291506274087;4752.1683705351425;4754.762261886961;4758.333833263346;5552.333719953632;5649.915251271234;5660.971695141498;5705.744736158039;5708.257926469532;1401.9905667919081;1410.8871290296752;1413.3145424469124;1415.6460884778805;1427.957590958606;884.5002573545926;896.7175339767953;917.1424717888796;923.7413524213231;930.8371035068836;4786.875084355173;4827.379465400949;4840.467548569654;4844.975775121102;4872.1473742094995;5103.719295438712;5131.5362130561725;5143.434222235551;5148.4851514848215;5149.433562308143;4827.8551643450755;4851.417829860439;4856.611471082305;4906.846890980617;5101.20931255656;3057.2356910772305;3104.62744470665;3128.515080162578;3129.2959084205872;3134.467140586106;6095.921559612456;6113.32753397126;6114.571979961449;6135.969320153371;6146.200993870768;5574.609777315549;5901.498372638288;5917.230760001258;5937.910931336033;5972.581919265696;6021.38069939569;6079.331273559905;6082.391760823883;6113.685557605137;6152.846178845564;5596.860078497907;5851.268591426072;5929.140274660236;5955.851103722442;5990.34106248321;5797.188393624811;5834.27071616048;5851.853703657443;5857.824265272048;5907.49786268172;6055.2430946131735;6154.815355539341;6155.261368635793;6160.815175544741;6169.660668663267;3905.37513997759;3956.485656864589;4054.614811592894;4081.408250782257;4084.183163367398;5842.532597392284;5876.206712093984;5877.735501902339;5889.617174883619;5889.911651325319;5728;5728.140778883201;5795.449432303924;5804.158397032491;5829.883402332014;5492.423295553909;5603.2155498231095;5630.071038278638;5648.435156484319;5682.488576028178;5620.831375058755;5648.85877853057;5707.573106723319;5712.6286791358425;5743.783481250513;5527.972360138174;5682.687452190169;5738.713064346683;5774.7690092397515;5797.362290147996;5549.445055494418;5552.250446189874;5570.972145139248;5599.580031497572;5664.886702266014 18:31:05 INFO - PROCESS | 13930 | |5;yui.html;720.6396801599201;737.8966944627753;797.5573556676046;832.0847068224954;834.6869923778584;15412.152331621757;16546.58633534162;16628.750568741478;16673.83326166738;16714.916425417887;15185.240737963086;15235.390584376639;15260.313285902133;15268.312925918333;15388;780.5784876166863;798.2895223251311;799.7760627024443;800.1358532784608;802.574635443216;795.8686816675241;796.080526991323;801.8957535520374;803.1968031968032;804.3123129724089;847.3602430165216;847.588919374103;848.3976376772499;849.1381248033251;851.2721623012328;838.584900474263;839.4166054592062;842.4145219072747;842.8525008123554;844.3878188313485;625.9812205633838;626.592714735421;626.8589567347356;627.3694936588745;627.6830200748639;13304.600861974157;13328.933355333258;13362.064655474122;13463.326833658279;13474.12418192824;12355.196912200769;12401;12422.56521021769;12482.126251162423;12974.416151273215;11261.155413344031;11262.211645184758;11283.266587671857;11327.716807079807;11342.262752921033;3807.676347510465;3852.3258429774955;3869.3615553433933;3871.9612803871883;3925.6260308891947;49217;49432.05971486403;58744.41255587432;64309.67845160744;74455.62772186159;11670.76658466826;11872.76254474923;11916.46375913086;12136.817947730791;12164.939175304067;19344.90327548353;21782.564348713255;21953.890230548746;21961.890190548944;21971.670424943637;8952.910470895338;8980.550972451481;9014.23379012778;9111.95444022789;9173.95413022944;4561.589456948891;4640.883977900579;4643.164230438553;4689.109069276827;4850.320955066293;3464.082018265162;3539.2567560812004;3587.192881601619;3589.300086483163;3594.155373487228;603.2338929559522;606.3178923710825;624.372505631837;629.1035274733578;639.2584601861818;715.2561336210387;717.8313096422337;736.4108713029555;739.9741009064657;745.4334705623766;8612.397132200686;8831.381803273838;8845.673149027698;8949.32880033987;9108.8633670495;626.3110578363763;654.2704884054245;684.3703792510902;713.4969846258479;720.3588805962697;4344.413504176959;4504.2793153095345;4506.436695413074;4539.614132798683;4550.340200670884;119714.40142799405;119972.40013799875;120550.39724801319;121418;122058;93566.53216733872;95542;98016;103511;106017;79342.60328698435;82511.5874420624;83141;84235.15764842519;84291.57854210812;8684.609192586222;8864.113588641343;8981.647147452331;8985.865212021694;9038.774030649287;37959.620403795605;46787.29819052785;47534.52465475301;48786.5121348782;48976.26535601897;64132;64747.35252647602;70418;70419.64790176017;72580;11462.541498340306;11653.825192622287;11826.053915686896;12495.750084998068;13083.607491775261;13608.523701670394;14417.42330306776;14724.042937209048;15094.924525377302;15617.219139043229;10678.786424271626;10694.091002264895;11018.889811101786;11155.27490713101;11685.240459370114;12348.3825808711;12525.624231273076;13328.666783330495;14421.495247666282;14561.490347837775;11964.820527691918;12311.737389591945;13043.282619455642;13059.34703264814;13112.934435327763;10828.133749300194;11384;11499.252548584314;11964.282143071443;11970.58102966392;9962.651307204213;10340.586376544854;10364;10891.128709703045;10919.781604367708 18:31:05 INFO - PROCESS | 13930 | __end_tp_report 18:31:05 INFO - PROCESS | 13930 | __start_cc_report 18:31:05 INFO - PROCESS | 13930 | _x_x_mozilla_cycle_collect,323 18:31:05 INFO - PROCESS | 13930 | __end_cc_report 18:31:05 INFO - PROCESS | 13930 | __startTimestamp1476495065793__endTimestamp 18:31:05 INFO - PROCESS | 13930 | 18:31:05 INFO - PROCESS | 13930 | ------- Summary: start ------- 18:31:05 INFO - PROCESS | 13930 | Number of tests: 6 18:31:05 INFO - PROCESS | 13930 | 18:31:05 INFO - PROCESS | 13930 | [#0] dojo.html Cycles:165 Average:5361.10 Median:5577.00 stddev:616.52 (11.1%) stddev-sans-first:590.88 18:31:05 INFO - PROCESS | 13930 | Values: 3038.5 3073.0 3076.7 3101.8 3102.3 5168.7 5248.8 5253.8 5322.2 5328.1 5228.8 5282.3 5362.7 5370.8 5424.2 4948.2 4954.6 4998.1 5023.6 5062.6 4967.7 4977.6 4992.8 5057.1 5101.0 5027.8 5040.9 5092.9 5093.4 5154.4 4821.5 4854.2 4856.7 4887.6 4902.4 4813.6 4822.9 4841.4 4848.6 4896.8 5340.3 5433.8 5463.7 5467.3 5482.9 5717.5 5795.0 5862.4 5907.1 5916.6 5934.5 5950.4 5976.9 5986.2 5989.0 5328.9 5507.4 5540.3 5549.3 5555.3 5761.9 5803.3 5814.9 5879.0 5895.3 5569.9 5577.5 5608.1 5619.1 5628.5 5649.2 5677.5 5685.7 5689.1 5705.4 5522.3 5704.7 5763.4 5770.9 5802.9 5725.7 5765.1 5767.0 5776.1 5778.3 4394.2 4403.6 4419.7 4434.6 4461.2 3785.3 3844.5 3865.4 3891.5 3955.7 5451.8 5458.7 5497.3 5501.8 5544.6 5784.9 5789.0 5790.9 5793.5 5802.1 5381.5 5428.0 5430.6 5434.1 5446.3 4833.9 4861.2 4868.2 4872.8 4880.1 5922.9 5932.9 5935.3 5936.5 5937.7 5711.7 5759.2 5764.3 5774.8 5779.9 5931.4 5941.0 5951.3 5954.2 5962.7 5725.5 5750.6 5753.3 5755.3 5769.7 5610.9 5661.9 5697.0 5737.3 5862.9 5562.8 5637.0 5647.6 5648.2 5651.5 5467.1 5538.3 5577.0 5621.6 5624.4 5536.3 5586.7 5615.5 5617.7 5669.3 5750.8 5753.7 5755.0 5756.1 5757.7 5414.8 5614.2 5625.6 5627.2 5632.0 18:31:05 INFO - PROCESS | 13930 | 18:31:05 INFO - PROCESS | 13930 | [#1] ext.html Cycles:180 Average:59837.78 Median:4295.10 stddev:117328.86 (2731.7%) stddev-sans-first:117573.61 18:31:05 INFO - PROCESS | 13930 | Values: 568.1 575.2 579.3 579.4 587.1 43304.4 44938.3 45016.8 48094.3 48097.3 46136.3 46223.0 46419.5 46458.5 46543.8 8693.3 8846.1 8855.6 8858.5 8882.1 8660.6 8763.8 8778.6 8810.2 8877.2 8856.1 8884.6 8918.4 8942.3 8943.2 8792.4 8834.6 8863.2 8894.3 8921.1 8700.4 8778.6 8791.4 8810.3 8841.2 42289.4 42294.8 42399.6 42465.6 42525.8 3440.6 3481.6 3497.7 3619.9 3899.0 28994.1 29025.0 29406.7 29861.9 30715.2 4294.8 4295.4 4299.2 4463.9 4507.1 320089.0 320813.0 321814.0 321845.0 322189.0 57534.0 57827.8 57872.4 57880.1 58012.7 59010.0 59661.7 60113.4 60127.0 60743.4 14897.1 14984.0 15047.1 15089.2 15138.1 11227.4 11291.3 11324.9 11381.4 11382.3 15666.3 16673.9 16738.8 16772.8 16775.7 3210.6 5542.3 5605.4 5890.5 5894.2 915.4 1008.7 1104.9 1110.9 1148.8 32556.8 32680.8 32877.8 32957.2 33525.8 1069.7 1070.2 1070.9 1126.0 1131.2 15930.8 17056.8 17077.7 17283.6 17322.3 517152.1 519464.0 520214.0 523741.0 525658.0 58785.0 59755.0 60036.4 60122.0 60171.7 1267.4 1303.8 1318.8 1337.6 1337.9 30624.4 31278.8 32224.0 32266.0 32674.8 52296.5 52507.7 52687.5 52697.0 52961.7 457954.0 459948.9 460936.0 462083.0 462743.0 28240.7 28345.6 28687.4 28787.4 28964.7 47126.0 47790.5 47872.0 48008.3 48663.3 40725.6 41140.0 44804.0 45259.5 46041.3 41699.6 42156.8 42193.4 43277.4 43940.0 41317.2 41365.2 42271.8 42363.6 42430.0 32222.5 36918.1 37858.8 38181.8 38537.0 28681.6 28945.7 29136.6 29213.0 29297.6 18:31:05 INFO - PROCESS | 13930 | 18:31:05 INFO - PROCESS | 13930 | [#2] jquery.html Cycles:180 Average:23982.20 Median:377.82 stddev:55458.76 (14678.6%) stddev-sans-first:55586.02 18:31:05 INFO - PROCESS | 13930 | Values: 377.4 378.3 389.4 389.5 391.4 17362.3 19821.0 19866.3 20069.2 20328.4 18271.3 18333.0 18518.8 18621.2 18857.2 5117.1 5556.2 5736.9 5794.1 5803.1 5652.5 5727.4 5782.3 5785.8 5800.1 5568.4 5603.6 5646.6 5746.1 5778.3 5626.1 5626.9 5629.5 5631.4 5689.2 5026.2 5029.1 5031.2 5059.9 5064.5 22484.8 22556.0 22632.0 22720.8 22767.8 2499.6 2499.8 2525.3 2539.6 2565.5 14308.9 14552.6 14604.5 14667.9 14917.6 1827.3 1881.4 1932.3 1942.5 1991.5 76649.2 77203.6 78702.0 79401.2 80246.0 8964.6 9033.4 9109.9 10478.6 10802.8 14707.6 14721.3 14742.7 14743.2 14789.6 7381.3 7561.3 7571.4 7773.4 7894.8 7170.6 7216.9 7448.3 7474.7 7487.4 6215.8 6343.8 6432.6 6449.4 6582.2 1832.4 1917.9 1951.8 1954.5 1979.1 907.3 943.9 982.3 1010.8 1046.6 19261.2 19620.1 19631.0 19678.8 19777.2 979.6 1001.8 1019.0 1019.7 1067.1 10680.6 11232.7 11306.6 11332.9 11421.3 217314.0 220425.0 220608.0 438536.0 441781.0 95200.5 96685.0 99340.5 99881.0 100606.0 938.7 940.1 977.1 984.2 990.9 16318.8 16901.9 17328.5 17507.2 17905.3 38314.6 39127.6 41810.6 42308.8 43754.6 55687.0 55850.2 55993.2 56758.9 58097.4 8186.9 8421.5 8608.7 8612.2 8781.9 8640.6 12992.4 13025.3 13072.3 13117.5 11200.6 11388.7 11563.8 11573.1 11740.4 11388.9 11455.1 11479.9 11517.5 11695.4 11426.4 11522.5 11745.5 11825.7 11962.1 8026.2 8162.6 8363.0 8386.4 8627.1 8883.7 11557.5 11560.6 11664.1 11986.9 18:31:05 INFO - PROCESS | 13930 | 18:31:05 INFO - PROCESS | 13930 | [#3] mootools.html Cycles:180 Average:5519.49 Median:5009.51 stddev:3156.39 (63.0%) stddev-sans-first:3150.56 18:31:05 INFO - PROCESS | 13930 | Values: 1468.7 1498.2 1652.7 1743.5 1772.1 7674.4 7944.0 8264.2 8835.7 8911.8 8251.9 8484.7 8536.5 8653.4 8707.6 2172.2 2228.4 2228.5 2231.8 2241.8 2194.1 2197.0 2228.3 2233.2 2235.7 2171.4 2182.5 2185.9 2186.4 2223.4 2178.6 2180.4 2186.3 2187.6 2192.9 2142.4 2176.8 2178.3 2187.7 2187.8 8651.6 8669.5 8670.8 8726.4 8727.8 4717.1 4879.0 4882.2 4887.6 4902.0 3090.1 3118.2 3137.9 3160.9 3175.2 984.7 1034.1 1040.4 1052.8 1062.3 11198.3 11237.9 11238.6 11267.0 11302.0 4202.0 4396.2 4421.0 4516.1 4572.7 9353.4 9430.7 9444.1 9450.6 9458.3 4989.4 5005.0 5014.0 5017.9 5029.6 4484.9 4563.7 4606.5 4719.7 4720.1 3517.3 3540.4 3557.7 3559.6 3613.6 1040.7 1048.2 1051.4 1056.2 1068.6 874.3 947.5 964.4 983.6 996.0 5552.6 5594.6 5869.6 6074.3 6079.5 430.1 438.9 443.6 446.6 448.0 3761.0 3834.5 3876.7 4064.7 4107.6 10241.0 10589.0 10630.7 10656.0 10683.7 10539.5 10565.0 10604.4 10605.2 10621.5 7961.9 7965.9 7977.0 8027.9 8117.4 5722.4 5746.6 5806.3 5867.7 5884.7 9069.0 9510.8 9654.5 9659.8 9764.0 9466.6 9537.5 9770.0 9812.1 9970.7 6756.3 6972.7 7150.4 7400.6 7543.4 7972.2 8182.4 8248.1 8264.3 8283.6 7265.1 7389.5 7398.6 7491.7 7572.6 7249.1 7339.8 7347.9 7363.0 7459.2 6343.6 6473.3 6477.4 6479.2 6498.5 5035.4 5069.5 5099.6 5162.8 5241.2 5031.5 5032.0 5071.8 5184.4 5237.3 18:31:05 INFO - PROCESS | 13930 | 18:31:05 INFO - PROCESS | 13930 | [#4] prototype.html Cycles:180 Average:4728.97 Median:5291.55 stddev:1412.99 (26.7%) stddev-sans-first:1377.30 18:31:05 INFO - PROCESS | 13930 | Values: 300.2 310.5 321.4 324.5 330.7 5325.4 5387.8 5554.6 5569.2 5575.7 5186.3 5354.7 5372.8 5400.4 5439.9 4234.5 4242.7 4259.0 4260.4 4272.6 4140.3 4195.4 4224.7 4233.4 4235.9 4217.9 4218.0 4229.2 4229.7 4236.0 4177.8 4222.6 4223.3 4232.6 4254.6 3624.0 3745.8 3747.6 3749.4 3753.1 5186.3 5195.8 5220.8 5265.8 5317.3 4814.4 4826.9 4839.5 4841.1 4868.7 5261.8 5532.6 5566.4 5568.9 5697.9 3966.9 3985.7 3996.4 4001.6 4009.1 5824.9 5826.5 5886.4 5954.2 5954.5 3917.8 4028.4 4034.9 4041.3 4042.6 4058.9 4061.5 4071.5 4077.6 4097.8 4702.2 4723.3 4752.2 4754.8 4758.3 5552.3 5649.9 5661.0 5705.7 5708.3 1402.0 1410.9 1413.3 1415.6 1428.0 884.5 896.7 917.1 923.7 930.8 4786.9 4827.4 4840.5 4845.0 4872.1 5103.7 5131.5 5143.4 5148.5 5149.4 4827.9 4851.4 4856.6 4906.8 5101.2 3057.2 3104.6 3128.5 3129.3 3134.5 6095.9 6113.3 6114.6 6136.0 6146.2 5574.6 5901.5 5917.2 5937.9 5972.6 6021.4 6079.3 6082.4 6113.7 6152.8 5596.9 5851.3 5929.1 5955.9 5990.3 5797.2 5834.3 5851.9 5857.8 5907.5 6055.2 6154.8 6155.3 6160.8 6169.7 3905.4 3956.5 4054.6 4081.4 4084.2 5842.5 5876.2 5877.7 5889.6 5889.9 5728.0 5728.1 5795.4 5804.2 5829.9 5492.4 5603.2 5630.1 5648.4 5682.5 5620.8 5648.9 5707.6 5712.6 5743.8 5528.0 5682.7 5738.7 5774.8 5797.4 5549.4 5552.3 5571.0 5599.6 5664.9 18:31:05 INFO - PROCESS | 13930 | 18:31:05 INFO - PROCESS | 13930 | [#5] yui.html Cycles:180 Average:19856.98 Median:4544.98 stddev:29189.33 (642.2%) stddev-sans-first:29235.85 18:31:05 INFO - PROCESS | 13930 | Values: 720.6 737.9 797.6 832.1 834.7 15412.2 16546.6 16628.8 16673.8 16714.9 15185.2 15235.4 15260.3 15268.3 15388.0 780.6 798.3 799.8 800.1 802.6 795.9 796.1 801.9 803.2 804.3 847.4 847.6 848.4 849.1 851.3 838.6 839.4 842.4 842.9 844.4 626.0 626.6 626.9 627.4 627.7 13304.6 13328.9 13362.1 13463.3 13474.1 12355.2 12401.0 12422.6 12482.1 12974.4 11261.2 11262.2 11283.3 11327.7 11342.3 3807.7 3852.3 3869.4 3872.0 3925.6 49217.0 49432.1 58744.4 64309.7 74455.6 11670.8 11872.8 11916.5 12136.8 12164.9 19344.9 21782.6 21953.9 21961.9 21971.7 8952.9 8980.6 9014.2 9112.0 9174.0 4561.6 4640.9 4643.2 4689.1 4850.3 3464.1 3539.3 3587.2 3589.3 3594.2 603.2 606.3 624.4 629.1 639.3 715.3 717.8 736.4 740.0 745.4 8612.4 8831.4 8845.7 8949.3 9108.9 626.3 654.3 684.4 713.5 720.4 4344.4 4504.3 4506.4 4539.6 4550.3 119714.4 119972.4 120550.4 121418.0 122058.0 93566.5 95542.0 98016.0 103511.0 106017.0 79342.6 82511.6 83141.0 84235.2 84291.6 8684.6 8864.1 8981.6 8985.9 9038.8 37959.6 46787.3 47534.5 48786.5 48976.3 64132.0 64747.4 70418.0 70419.6 72580.0 11462.5 11653.8 11826.1 12495.8 13083.6 13608.5 14417.4 14724.0 15094.9 15617.2 10678.8 10694.1 11018.9 11155.3 11685.2 12348.4 12525.6 13328.7 14421.5 14561.5 11964.8 12311.7 13043.3 13059.3 13112.9 10828.1 11384.0 11499.3 11964.3 11970.6 9962.7 10340.6 10364.0 10891.1 10919.8 18:31:05 INFO - PROCESS | 13930 | -------- Summary: end -------- 18:31:05 INFO - PROCESS | 13930 | 18:31:06 INFO - TEST-INFO | 13930: exit 0 18:31:06 INFO - TEST-OK | dromaeo_css | took 1116882ms 18:31:06 INFO - TEST-START | kraken 18:31:06 INFO - operating with platform_type : linux_ 18:31:06 INFO - Initialising browser for kraken test... 18:31:06 INFO - TEST-INFO | started process 14308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVH810M/profile http://localhost:54998/getInfo.html) 18:31:11 INFO - PROCESS | 14308 | __metrics Screen width/height:1600/1200 18:31:11 INFO - PROCESS | 14308 | colorDepth:24 18:31:11 INFO - PROCESS | 14308 | Browser inner width/height: 1024/697 18:31:11 INFO - PROCESS | 14308 | __metrics 18:31:11 ERROR - PROCESS | 14308 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 18:31:12 INFO - TEST-INFO | 14308: exit 0 18:31:12 INFO - Browser initialized. 18:31:12 INFO - Running cycle 1/1 for kraken test... 18:31:12 INFO - TEST-INFO | started process 14430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVH810M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:31:25 INFO - PROCESS | 14430 | RSS: Main: 183046144 18:31:25 INFO - PROCESS | 14430 | 18:31:27 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54998/tests/kraken/driver.html?testName=audio-beat-detection) 18:31:28 INFO - PROCESS | 14430 | RSS: Main: 196919296 18:31:28 INFO - PROCESS | 14430 | 18:31:31 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54998/tests/kraken/driver.html?testName=audio-dft) 18:31:32 INFO - PROCESS | 14430 | RSS: Main: 194646016 18:31:32 INFO - PROCESS | 14430 | 18:31:35 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54998/tests/kraken/driver.html?testName=audio-fft) 18:31:35 INFO - PROCESS | 14430 | RSS: Main: 191270912 18:31:35 INFO - PROCESS | 14430 | 18:31:37 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54998/tests/kraken/driver.html?testName=audio-oscillator) 18:31:38 INFO - PROCESS | 14430 | RSS: Main: 191590400 18:31:38 INFO - PROCESS | 14430 | 18:31:40 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54998/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:31:41 INFO - PROCESS | 14430 | RSS: Main: 191885312 18:31:41 INFO - PROCESS | 14430 | 18:31:44 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54998/tests/kraken/driver.html?testName=imaging-darkroom) 18:31:44 INFO - PROCESS | 14430 | RSS: Main: 191700992 18:31:44 INFO - PROCESS | 14430 | 18:31:48 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54998/tests/kraken/driver.html?testName=imaging-desaturate) 18:31:48 INFO - PROCESS | 14430 | RSS: Main: 192450560 18:31:48 INFO - PROCESS | 14430 | 18:31:51 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54998/tests/kraken/driver.html?testName=json-parse-financial) 18:31:52 INFO - PROCESS | 14430 | RSS: Main: 192565248 18:31:52 INFO - PROCESS | 14430 | 18:31:53 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54998/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:31:54 INFO - PROCESS | 14430 | RSS: Main: 192290816 18:31:54 INFO - PROCESS | 14430 | 18:31:56 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54998/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:31:56 INFO - PROCESS | 14430 | RSS: Main: 192389120 18:31:56 INFO - PROCESS | 14430 | 18:31:58 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54998/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:31:59 INFO - PROCESS | 14430 | RSS: Main: 192708608 18:31:59 INFO - PROCESS | 14430 | 18:32:02 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:32:03 INFO - PROCESS | 14430 | RSS: Main: 192217088 18:32:03 INFO - PROCESS | 14430 | 18:32:05 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:32:06 INFO - PROCESS | 14430 | RSS: Main: 192983040 18:32:06 INFO - PROCESS | 14430 | 18:32:08 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54998/tests/kraken/driver.html?testName=ai-astar) 18:32:08 INFO - PROCESS | 14430 | RSS: Main: 194273280 18:32:08 INFO - PROCESS | 14430 | 18:32:08 INFO - PROCESS | 14430 | __start_tp_report 18:32:08 INFO - PROCESS | 14430 | _x_x_mozilla_page_load 18:32:08 INFO - PROCESS | 14430 | _x_x_mozilla_page_load_details 18:32:08 INFO - PROCESS | 14430 | |i|pagename|runs| 18:32:08 INFO - PROCESS | 14430 | |0;ai-astar;110;113;113;114;112;113;113;115;112;113 18:32:08 INFO - PROCESS | 14430 | |1;audio-beat-detection;161;133;125;181;130;128;132;132;158;125 18:32:08 INFO - PROCESS | 14430 | |2;audio-dft;163;164;164;166;166;162;164;163;163;164 18:32:08 INFO - PROCESS | 14430 | |3;audio-fft;76;80;76;117;77;78;75;75;109;76 18:32:08 INFO - PROCESS | 14430 | |4;audio-oscillator;83;82;116;82;84;82;99;83;82;108 18:32:08 INFO - PROCESS | 14430 | |5;imaging-gaussian-blur;119;117;118;117;118;118;117;117;119;118 18:32:08 INFO - PROCESS | 14430 | |6;imaging-darkroom;149;149;148;146;149;148;147;146;147;148 18:32:08 INFO - PROCESS | 14430 | |7;imaging-desaturate;86;85;85;85;85;86;87;86;86;86 18:32:08 INFO - PROCESS | 14430 | |8;json-parse-financial;53;57;57;54;54;55;57;54;55;54 18:32:08 INFO - PROCESS | 14430 | |9;json-stringify-tinderbox;62;61;60;61;61;61;61;64;61;61 18:32:08 INFO - PROCESS | 14430 | |10;stanford-crypto-aes;81;82;82;82;81;81;81;80;80;80 18:32:08 INFO - PROCESS | 14430 | |11;stanford-crypto-ccm;143;134;141;134;132;137;150;138;186;135 18:32:08 INFO - PROCESS | 14430 | |12;stanford-crypto-pbkdf2;172;170;176;172;168;169;169;174;167;168 18:32:08 INFO - PROCESS | 14430 | |13;stanford-crypto-sha256-iterative;71;69;71;70;70;71;66;70;65;67 18:32:08 INFO - PROCESS | 14430 | __end_tp_report 18:32:08 INFO - PROCESS | 14430 | __start_cc_report 18:32:08 INFO - PROCESS | 14430 | _x_x_mozilla_cycle_collect,799 18:32:08 INFO - PROCESS | 14430 | __end_cc_report 18:32:08 INFO - PROCESS | 14430 | __startTimestamp1476495128529__endTimestamp 18:32:08 INFO - PROCESS | 14430 | 18:32:08 INFO - PROCESS | 14430 | ------- Summary: start ------- 18:32:08 INFO - PROCESS | 14430 | Number of tests: 14 18:32:08 INFO - PROCESS | 14430 | 18:32:08 INFO - PROCESS | 14430 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:1.32 (1.2%) stddev-sans-first:0.93 18:32:08 INFO - PROCESS | 14430 | Values: 110.0 113.0 113.0 114.0 112.0 113.0 113.0 115.0 112.0 113.0 18:32:08 INFO - PROCESS | 14430 | 18:32:08 INFO - PROCESS | 14430 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:132.50 stddev:19.19 (14.5%) stddev-sans-first:18.87 18:32:08 INFO - PROCESS | 14430 | Values: 161.0 133.0 125.0 181.0 130.0 128.0 132.0 132.0 158.0 125.0 18:32:08 INFO - PROCESS | 14430 | 18:32:08 INFO - PROCESS | 14430 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:1.29 (0.8%) stddev-sans-first:1.32 18:32:08 INFO - PROCESS | 14430 | Values: 163.0 164.0 164.0 166.0 166.0 162.0 164.0 163.0 163.0 164.0 18:32:08 INFO - PROCESS | 14430 | 18:32:08 INFO - PROCESS | 14430 | [#3] audio-fft Cycles:10 Average:83.90 Median:76.00 stddev:15.52 (20.4%) stddev-sans-first:16.20 18:32:08 INFO - PROCESS | 14430 | Values: 76.0 80.0 76.0 117.0 77.0 78.0 75.0 75.0 109.0 76.0 18:32:08 INFO - PROCESS | 14430 | 18:32:08 INFO - PROCESS | 14430 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:82.50 stddev:12.78 (15.5%) stddev-sans-first:13.30 18:32:08 INFO - PROCESS | 14430 | Values: 83.0 82.0 116.0 82.0 84.0 82.0 99.0 83.0 82.0 108.0 18:32:08 INFO - PROCESS | 14430 | 18:32:08 INFO - PROCESS | 14430 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.71 18:32:08 INFO - PROCESS | 14430 | Values: 119.0 117.0 118.0 117.0 118.0 118.0 117.0 117.0 119.0 118.0 18:32:08 INFO - PROCESS | 14430 | 18:32:08 INFO - PROCESS | 14430 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:1.16 (0.8%) stddev-sans-first:1.13 18:32:08 INFO - PROCESS | 14430 | Values: 149.0 149.0 148.0 146.0 149.0 148.0 147.0 146.0 147.0 148.0 18:32:08 INFO - PROCESS | 14430 | 18:32:08 INFO - PROCESS | 14430 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 18:32:08 INFO - PROCESS | 14430 | Values: 86.0 85.0 85.0 85.0 85.0 86.0 87.0 86.0 86.0 86.0 18:32:08 INFO - PROCESS | 14430 | 18:32:08 INFO - PROCESS | 14430 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.49 (2.7%) stddev-sans-first:1.39 18:32:08 INFO - PROCESS | 14430 | Values: 53.0 57.0 57.0 54.0 54.0 55.0 57.0 54.0 55.0 54.0 18:32:08 INFO - PROCESS | 14430 | 18:32:08 INFO - PROCESS | 14430 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:1.06 (1.7%) stddev-sans-first:1.09 18:32:08 INFO - PROCESS | 14430 | Values: 62.0 61.0 60.0 61.0 61.0 61.0 61.0 64.0 61.0 61.0 18:32:08 INFO - PROCESS | 14430 | 18:32:08 INFO - PROCESS | 14430 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:81.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 18:32:08 INFO - PROCESS | 14430 | Values: 81.0 82.0 82.0 82.0 81.0 81.0 81.0 80.0 80.0 80.0 18:32:08 INFO - PROCESS | 14430 | 18:32:08 INFO - PROCESS | 14430 | [#11] stanford-crypto-ccm Cycles:10 Average:143.00 Median:139.50 stddev:16.02 (11.5%) stddev-sans-first:16.99 18:32:08 INFO - PROCESS | 14430 | Values: 143.0 134.0 141.0 134.0 132.0 137.0 150.0 138.0 186.0 135.0 18:32:08 INFO - PROCESS | 14430 | 18:32:08 INFO - PROCESS | 14430 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:171.00 stddev:2.92 (1.7%) stddev-sans-first:3.04 18:32:08 INFO - PROCESS | 14430 | Values: 172.0 170.0 176.0 172.0 168.0 169.0 169.0 174.0 167.0 168.0 18:32:08 INFO - PROCESS | 14430 | 18:32:08 INFO - PROCESS | 14430 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:70.00 stddev:2.21 (3.2%) stddev-sans-first:2.22 18:32:08 INFO - PROCESS | 14430 | Values: 71.0 69.0 71.0 70.0 70.0 71.0 66.0 70.0 65.0 67.0 18:32:08 INFO - PROCESS | 14430 | -------- Summary: end -------- 18:32:08 INFO - PROCESS | 14430 | 18:32:09 INFO - TEST-INFO | 14430: exit 0 18:32:09 INFO - TEST-OK | kraken | took 62830ms 18:32:09 INFO - SUITE-END | took 1179s 18:32:09 INFO - Completed test suite (00:19:39) 18:32:09 INFO - javascript benchmark 18:32:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7116.723272634623, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3038.4682680530905, 3073.0, 3076.7384772294354, 3101.782875198737, 3102.2709663229143, 5168.689878607286, 5248.816291429801, 5253.763580638871, 5322.201669749539, 5328.147496400572, 5228.843134705955, 5282.339707536558, 5362.6514276572, 5370.838874833751, 5424.213489044087, 4948.208286674133, 4954.628402869781, 4998.10034193845, 5023.572996295319, 5062.645614806965, 4967.726775027372, 4977.576905962979, 4992.800287988494, 5057.089723849724, 5101.030804147219, 5027.824026159067, 5040.899182016376, 5092.949070509303, 5093.363329583802, 5154.355705536808, 4821.54195351441, 4854.199057155565, 4856.660033797635, 4887.608991280689, 4902.411710594716, 4813.566778989873, 4822.879428014293, 4841.419029716421, 4848.636352273558, 4896.804127834882, 5340.279062326575, 5433.809816656398, 5463.672179669233, 5467.316585426822, 5482.91775623366, 5717.48542631161, 5794.985877471468, 5862.38444963277, 5907.054871220584, 5916.645001299936, 5934.465898069151, 5950.375210602868, 5976.8505787355225, 5986.191864098335, 5988.97005514974, 5328.866778330573, 5507.394186639466, 5540.335159780771, 5549.306336707911, 5555.30558680165, 5761.8559536011935, 5803.274590676166, 5814.941850581525, 5879.0, 5895.322037965603, 5569.916451253234, 5577.52591029767, 5608.130739735348, 5619.072852979294, 5628.465295796893, 5649.209110724501, 5677.545796336283, 5685.658860468385, 5689.118186681071, 5705.429457054344, 5522.30971128609, 5704.657720536781, 5763.366029736726, 5770.913436298459, 5802.88394232113, 5725.656460612377, 5765.135229715576, 5767.048437007847, 5776.075827867521, 5778.306603207642, 4394.165108629414, 4403.559644035635, 4419.668524860648, 4434.600885920218, 4461.152381047591, 3785.261873934556, 3844.5386553613184, 3865.381538953754, 3891.474650922146, 3955.7428767130045, 5451.754671039813, 5458.727063646802, 5497.257870187554, 5501.752421141058, 5544.63959842609, 5784.942150578525, 5789.044807606698, 5790.94209057904, 5793.507551858139, 5802.100674395476, 5381.48875856793, 5427.972860135753, 5430.647007944471, 5434.076207044812, 5446.319210098738, 4833.854984350475, 4861.197902346144, 4868.2210846264425, 4872.78072486739, 4880.145974454456, 5922.940770592239, 5932.940670593239, 5935.347111817783, 5936.495397891142, 5937.70311484424, 5711.714414279187, 5759.164921086335, 5764.308283006066, 5774.82675519735, 5779.942200577941, 5931.406859314034, 5940.970295148497, 5951.345352011189, 5954.225950626565, 5962.672053036951, 5725.484706376279, 5750.568707347049, 5753.309602847685, 5755.280589926259, 5769.653820770767, 5610.887782244414, 5661.858453538694, 5696.971515142398, 5737.282839645044, 5862.912056319244, 5562.833115006556, 5637.041702910597, 5647.632903861236, 5648.209250704823, 5651.519620832275, 5467.07059799827, 5538.307711536058, 5577.0, 5621.606487545996, 5624.409437009219, 5536.335639723259, 5586.720663966867, 5615.494605485363, 5617.662940223436, 5669.262995810518, 5750.769969201185, 5753.654780713171, 5754.971225143848, 5756.136579513107, 5757.712114394348, 5414.810481633124, 5614.242077319673, 5625.578081643975, 5627.212190293444, 5631.971840140773], "value": 5318.470772678453, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.0513542384218, 575.2062154227167, 579.3308728418675, 579.4090028171265, 587.145703002132, 43304.350434743465, 44938.32592511115, 45016.774916125374, 48094.27858582124, 48097.27854082191, 46136.30795538061, 46223.0, 46419.53580464194, 46458.53541464584, 46543.76728116363, 8693.30453563715, 8846.115388461134, 8855.645774169057, 8858.468491890475, 8882.067382924797, 8660.610272537719, 8763.816884720545, 8778.561071946377, 8810.163034511743, 8877.245434138074, 8856.070112638177, 8884.555772211395, 8918.420302680337, 8942.284617230638, 8943.150400711922, 8792.384533082686, 8834.646614135427, 8863.157999989991, 8894.332925030649, 8921.107889211093, 8700.390972631918, 8778.64885404583, 8791.428557143765, 8810.339224558184, 8841.204291613722, 42289.36565951513, 42294.78852605717, 42399.57600423987, 42465.57534424647, 42525.78737106295, 3440.55272814535, 3481.56480439945, 3497.702695270905, 3619.9095022624647, 3898.9805050974846, 28994.13017609475, 29025.0, 29406.705932940826, 29861.850690746625, 30715.232119196975, 4294.849680261207, 4295.355696645497, 4299.204647140258, 4463.910721785546, 4507.076049409863, 320089.0, 320813.0, 321814.0, 321845.0, 322188.9999999977, 57534.0, 57827.81946992872, 57872.421275786706, 57880.13179802307, 58012.70993645005, 59010.0, 59661.70169149213, 60113.39886601078, 60127.0, 60743.39256607377, 14897.106173629616, 14984.0, 15047.097174169585, 15089.24553772307, 15138.091714497166, 11227.438628068563, 11291.266067705574, 11324.94337528307, 11381.430928453545, 11382.260153090023, 15666.295016724047, 16673.91663041677, 16738.83261167397, 16772.832271677125, 16775.748363774554, 3210.5665735125926, 5542.334919809568, 5605.411431799684, 5890.4993075589055, 5894.204282421818, 915.3729695158837, 1008.702432782331, 1104.9060829829393, 1110.8555887734542, 1148.8449059377044, 32556.837215814245, 32680.83659581687, 32877.83561082179, 32957.17607059795, 33525.83237083799, 1069.7058308965097, 1070.1652710885521, 1070.9410982396043, 1126.0259875207887, 1131.2138064045573, 15930.840691593168, 17056.829431705773, 17077.658446831243, 17283.567910802078, 17322.30710771555, 517152.1423928788, 519464.0, 520214.0, 523741.0, 525658.0, 58785.0, 59755.0, 60036.39963600395, 60122.0, 60171.69914150401, 1267.4043199696127, 1303.8109474126388, 1318.8021796730568, 1337.6455239361576, 1337.9197248165142, 30624.387512249185, 31278.843605781825, 32224.0, 32266.0, 32674.83662581672, 52296.47703522916, 52507.73746131245, 52687.473125268254, 52697.0, 52961.735191323794, 457954.0, 459948.9043431346, 460936.0, 462083.0, 462743.0, 28240.717592824632, 28345.574816378183, 28687.42625147527, 28787.424251515273, 28964.7103528962, 47126.0, 47790.52209477861, 47872.0, 48008.27987580259, 48663.27005094997, 40725.59274407218, 41140.0, 44804.0, 45259.54740452685, 46041.30938035865, 41699.58300416957, 42156.78921605372, 42193.36709949415, 43277.35083973806, 43940.0, 41317.1736565273, 41365.172696546506, 42271.7886410566, 42363.57636423596, 42430.0, 32222.516662250553, 36918.07704807401, 37858.81070594629, 38181.80005185224, 38537.03657408475, 28681.569776452954, 28945.710542894303, 29136.56295155532, 29213.0, 29297.560536591543], "value": 19820.29895689916, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.36037416578904, 378.28126559536895, 389.441151946956, 389.53645162256913, 391.4441493079826, 17362.30550777969, 19821.008949552517, 19866.304679336226, 20069.197232110735, 20328.390148295537, 18271.26914923405, 18333.0, 18518.814811851877, 18621.16204770785, 18857.15142818573, 5117.104506711329, 5556.222128901947, 5736.8852622947725, 5794.130880367937, 5803.129530570427, 5652.547796176316, 5727.42725727426, 5782.277215348082, 5785.797497087603, 5800.129980502916, 5568.387477377485, 5603.60774745768, 5646.632968857011, 5746.109353050284, 5778.335491418477, 5626.099824028177, 5626.859328516779, 5629.493345598875, 5631.4087020862835, 5689.175069614904, 5026.246063090529, 5029.119904016782, 5031.22016087507, 5059.873503162414, 5064.518870707314, 22484.775152248432, 22556.0, 22632.0, 22720.77279227203, 22767.77232227673, 2499.5875680512695, 2499.787518060967, 2525.305540976228, 2539.5555777739005, 2565.486902619465, 14308.928455357656, 14552.636184095376, 14604.488842890449, 14667.92666036663, 14917.552473425814, 1827.2782251010908, 1881.388548721671, 1932.3140285198692, 1942.5435022769639, 1991.4623051776084, 76649.23350766477, 77203.61398193029, 78702.0, 79401.20598793996, 80245.96310553406, 8964.551772411354, 9033.36766426357, 9109.863352049591, 10478.580856765797, 10802.783944321069, 14707.632309192142, 14721.26393680333, 14742.705145897022, 14743.189124598035, 14789.556313310617, 7381.298776616213, 7561.281678240558, 7571.3564347030015, 7773.378129749606, 7894.842103157905, 7170.569765814068, 7216.9278307216255, 7448.329650331496, 7474.739398542778, 7487.438442116863, 6215.751369945242, 6343.809685709436, 6432.646204458706, 6449.3873082057125, 6582.210134783857, 1832.4227868221735, 1917.947795858446, 1951.7755458122215, 1954.4722924810221, 1979.0698371765536, 907.2651152566442, 943.8961714211431, 982.3467394182932, 1010.8483727440796, 1046.576136664652, 19261.22955081781, 19620.117094730773, 19631.0, 19678.803211967985, 19777.15459712351, 979.588572799426, 1001.759577701361, 1018.9643362482277, 1019.7246743379246, 1067.1036329483115, 10680.62617808373, 11232.719182020515, 11306.604268850551, 11332.943335283271, 11421.257618254787, 217314.0, 220425.0, 220608.0, 438536.0, 441781.0, 95200.52399737957, 96685.0, 99340.50329748305, 99881.0, 100606.0, 938.7324612485545, 940.1444685336311, 977.1498796047484, 984.1880448629909, 990.8860481044773, 16318.836811631732, 16901.91549042247, 17328.48014559565, 17507.21217545188, 17905.28378864883, 38314.6168538311, 39127.608723912395, 41810.58189418189, 42308.788456057526, 43754.56245437632, 55687.0, 55850.16224756713, 55993.16010259931, 56758.86482270414, 58097.4190258092, 8186.935698359175, 8421.536815475207, 8608.741737747878, 8612.224899759052, 8781.912180878366, 8640.611172497378, 12992.350382481027, 13025.283609401575, 13072.281024543741, 13117.540886068942, 11200.551977920792, 11388.658340249805, 11563.826542601699, 11573.132015098732, 11740.41297935117, 11388.886111139114, 11455.140864435367, 11479.885201147881, 11517.481713322753, 11695.415229238673, 11426.428678565871, 11522.53909843597, 11745.47145378443, 11825.704357391134, 11962.102842287037, 8026.1572534883, 8162.632681529464, 8362.958185209034, 8386.412951093365, 8627.137286271323, 8883.689070882747, 11557.537698491966, 11560.595379161688, 11664.125190610568, 11986.880131198577], "value": 9103.96263470378, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1468.654866106465, 1498.176003198241, 1652.743824707171, 1743.5205318537407, 1772.0696634267001, 7674.386049116071, 7943.960280198591, 8264.214899584545, 8835.690750823722, 8911.777205569855, 8251.91748082519, 8484.66061357545, 8536.530490823017, 8653.437526560769, 8707.608157632905, 2172.152860384447, 2228.4428892776805, 2228.5320082782555, 2231.7991380775725, 2241.7870302321335, 2194.1333173396497, 2197.0, 2228.3315005498366, 2233.218373569246, 2235.731712194539, 2171.3703026122407, 2182.5416662500893, 2185.9344219673435, 2186.365953873375, 2223.4219103033165, 2178.553396553703, 2180.4003898927845, 2186.267600353883, 2187.595294870454, 2192.8574642648177, 2142.389419015573, 2176.7714389988982, 2178.3464960511783, 2187.660912558556, 2187.7812218778154, 8651.610677519528, 8669.523176225304, 8670.783230419227, 8726.38915275931, 8727.781805454852, 4717.127331443694, 4879.048585525824, 4882.218844984821, 4887.633427492952, 4901.975490122562, 3090.1082730987555, 3118.220444888778, 3137.905862824119, 3160.8893688720786, 3175.237942893689, 984.7242772023844, 1034.0848349210928, 1040.3965699894043, 1052.7578656908954, 1062.2511129653576, 11198.272112312674, 11237.943810280978, 11238.550457981672, 11267.04230140439, 11301.999999999918, 4202.0, 4396.1867054595, 4420.977895110504, 4516.1419330327135, 4572.748498832596, 9353.39202951806, 9430.717078487656, 9444.055594440639, 9450.621975121056, 9458.33791634579, 4989.376327959005, 5005.049040682259, 5013.974930125399, 5017.949820501748, 5029.597632189416, 4484.932726009112, 4563.657725670588, 4606.539346065434, 4719.716816990992, 4720.055988802184, 3517.3141237458963, 3540.415831387844, 3557.7331700122595, 3559.60844307126, 3613.638636136418, 1040.69819752271, 1048.1562342314357, 1051.374432212832, 1056.1972900595604, 1068.5779117248644, 874.2699845628844, 947.4552132523827, 964.3683387381277, 983.5721461164417, 996.038822536256, 5552.639078459887, 5594.608377413542, 5869.618474799125, 6074.271087469532, 6079.544034197453, 430.09465076015164, 438.89027743064236, 443.61848810023355, 446.6359916667905, 448.0255444408399, 3761.0, 3834.5206849143856, 3876.6898648108086, 4064.6545043671617, 4107.623945978131, 10241.0, 10589.0, 10630.734231644115, 10656.0, 10683.732906677395, 10539.473026348653, 10565.04914557678, 10604.416757078281, 10605.151587872951, 10621.5220315086, 7961.920380796234, 7965.920340796518, 7977.0, 8027.919720802834, 8117.431779775359, 5722.370539240764, 5746.597738158289, 5806.303243610793, 5867.706614669335, 5884.676342801187, 9068.954655226682, 9510.809783804423, 9654.469004204837, 9659.806803863743, 9764.0, 9466.621335146518, 9537.52312384392, 9769.951150244204, 9812.116909478182, 9970.700878973643, 6756.324367563205, 6972.721091156297, 7150.392216661642, 7400.629968501661, 7543.358814500829, 7972.162922893012, 8182.386321025828, 8248.092709802037, 8264.338852891635, 8283.58582070906, 7265.12818461788, 7389.519681220703, 7398.556086634819, 7491.737789177353, 7572.583507907118, 7249.057622509251, 7339.77980660581, 7347.889781653173, 7362.9631851840395, 7459.179490255959, 6343.55595108338, 6473.287938326875, 6477.4170324671, 6479.1901012373455, 6498.512611554058, 5035.420926593342, 5069.467705890828, 5099.592032637454, 5162.819301324435, 5241.187615919539, 5031.496850314939, 5032.0, 5071.771770270273, 5184.429712731521, 5237.3453318335205], "value": 4331.640583321127, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.20595524836796, 310.4845955713513, 321.43908879006136, 324.51485029880325, 330.6957599008912, 5325.387580428252, 5387.838364849061, 5554.555635549156, 5569.248151499546, 5575.665460072399, 5186.299849520314, 5354.705491197982, 5372.811951581695, 5400.432954539776, 5439.945600544003, 4234.513031001428, 4242.745435273893, 4258.97870510647, 4260.446142001551, 4272.615464608185, 4140.3168477201225, 4195.433616461784, 4224.683148763839, 4233.428487154226, 4235.9364609530885, 4217.861177482078, 4217.978910105445, 4229.238737027334, 4229.746215227081, 4235.957640423602, 4177.811998460076, 4222.598853108965, 4223.282042052859, 4232.645553422906, 4254.617084462382, 3624.039629498185, 3745.793981331026, 3747.6439738224826, 3749.362608356586, 3753.1367785409507, 5186.262602028325, 5195.766190521435, 5220.8433746987275, 5265.763040663141, 5317.335333083364, 4814.376164990089, 4826.855194344175, 4839.516048395168, 4841.104395686809, 4868.732219727914, 5261.842144735664, 5532.585056120807, 5566.415526369713, 5568.86077848053, 5697.943020569783, 3966.8809935701975, 3985.6612187964056, 3996.360582306817, 4001.579834117405, 4009.0979529605897, 5824.883502329972, 5826.533877289807, 5886.440788125121, 5954.166416701665, 5954.523638108984, 3917.7845218512684, 4028.4158796974275, 4034.8587799426878, 4041.2927737645796, 4042.5957404259925, 4058.8782336529953, 4061.5126184857413, 4071.450354202204, 4077.6330130288416, 4097.795110244536, 4702.224133018014, 4723.291506274087, 4752.1683705351425, 4754.762261886961, 4758.333833263346, 5552.333719953632, 5649.915251271234, 5660.971695141498, 5705.744736158039, 5708.257926469532, 1401.9905667919081, 1410.8871290296752, 1413.3145424469124, 1415.6460884778805, 1427.957590958606, 884.5002573545926, 896.7175339767953, 917.1424717888796, 923.7413524213231, 930.8371035068836, 4786.875084355173, 4827.379465400949, 4840.467548569654, 4844.975775121102, 4872.1473742094995, 5103.719295438712, 5131.5362130561725, 5143.434222235551, 5148.4851514848215, 5149.433562308143, 4827.8551643450755, 4851.417829860439, 4856.611471082305, 4906.846890980617, 5101.20931255656, 3057.2356910772305, 3104.62744470665, 3128.515080162578, 3129.2959084205872, 3134.467140586106, 6095.921559612456, 6113.32753397126, 6114.571979961449, 6135.969320153371, 6146.200993870768, 5574.609777315549, 5901.498372638288, 5917.230760001258, 5937.910931336033, 5972.581919265696, 6021.38069939569, 6079.331273559905, 6082.391760823883, 6113.685557605137, 6152.846178845564, 5596.860078497907, 5851.268591426072, 5929.140274660236, 5955.851103722442, 5990.34106248321, 5797.188393624811, 5834.27071616048, 5851.853703657443, 5857.824265272048, 5907.49786268172, 6055.2430946131735, 6154.815355539341, 6155.261368635793, 6160.815175544741, 6169.660668663267, 3905.37513997759, 3956.485656864589, 4054.614811592894, 4081.408250782257, 4084.183163367398, 5842.532597392284, 5876.206712093984, 5877.735501902339, 5889.617174883619, 5889.911651325319, 5728.0, 5728.140778883201, 5795.449432303924, 5804.158397032491, 5829.883402332014, 5492.423295553909, 5603.2155498231095, 5630.071038278638, 5648.435156484319, 5682.488576028178, 5620.831375058755, 5648.85877853057, 5707.573106723319, 5712.6286791358425, 5743.783481250513, 5527.972360138174, 5682.687452190169, 5738.713064346683, 5774.7690092397515, 5797.362290147996, 5549.445055494418, 5552.250446189874, 5570.972145139248, 5599.580031497572, 5664.886702266014], "value": 4270.67305383273, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.6396801599201, 737.8966944627753, 797.5573556676046, 832.0847068224954, 834.6869923778584, 15412.152331621757, 16546.58633534162, 16628.750568741478, 16673.83326166738, 16714.916425417887, 15185.240737963086, 15235.390584376639, 15260.313285902133, 15268.312925918333, 15388.0, 780.5784876166863, 798.2895223251311, 799.7760627024443, 800.1358532784608, 802.574635443216, 795.8686816675241, 796.080526991323, 801.8957535520374, 803.1968031968032, 804.3123129724089, 847.3602430165216, 847.588919374103, 848.3976376772499, 849.1381248033251, 851.2721623012328, 838.584900474263, 839.4166054592062, 842.4145219072747, 842.8525008123554, 844.3878188313485, 625.9812205633838, 626.592714735421, 626.8589567347356, 627.3694936588745, 627.6830200748639, 13304.600861974157, 13328.933355333258, 13362.064655474122, 13463.326833658279, 13474.12418192824, 12355.196912200769, 12401.0, 12422.56521021769, 12482.126251162423, 12974.416151273215, 11261.155413344031, 11262.211645184758, 11283.266587671857, 11327.716807079807, 11342.262752921033, 3807.676347510465, 3852.3258429774955, 3869.3615553433933, 3871.9612803871883, 3925.6260308891947, 49217.0, 49432.05971486403, 58744.41255587432, 64309.67845160744, 74455.62772186159, 11670.76658466826, 11872.76254474923, 11916.46375913086, 12136.817947730791, 12164.939175304067, 19344.90327548353, 21782.564348713255, 21953.890230548746, 21961.890190548944, 21971.670424943637, 8952.910470895338, 8980.550972451481, 9014.23379012778, 9111.95444022789, 9173.95413022944, 4561.589456948891, 4640.883977900579, 4643.164230438553, 4689.109069276827, 4850.320955066293, 3464.082018265162, 3539.2567560812004, 3587.192881601619, 3589.300086483163, 3594.155373487228, 603.2338929559522, 606.3178923710825, 624.372505631837, 629.1035274733578, 639.2584601861818, 715.2561336210387, 717.8313096422337, 736.4108713029555, 739.9741009064657, 745.4334705623766, 8612.397132200686, 8831.381803273838, 8845.673149027698, 8949.32880033987, 9108.8633670495, 626.3110578363763, 654.2704884054245, 684.3703792510902, 713.4969846258479, 720.3588805962697, 4344.413504176959, 4504.2793153095345, 4506.436695413074, 4539.614132798683, 4550.340200670884, 119714.40142799405, 119972.40013799875, 120550.39724801319, 121418.0, 122058.0, 93566.53216733872, 95542.0, 98016.0, 103511.0, 106017.0, 79342.60328698435, 82511.5874420624, 83141.0, 84235.15764842519, 84291.57854210812, 8684.609192586222, 8864.113588641343, 8981.647147452331, 8985.865212021694, 9038.774030649287, 37959.620403795605, 46787.29819052785, 47534.52465475301, 48786.5121348782, 48976.26535601897, 64132.0, 64747.35252647602, 70418.0, 70419.64790176017, 72580.0, 11462.541498340306, 11653.825192622287, 11826.053915686896, 12495.750084998068, 13083.607491775261, 13608.523701670394, 14417.42330306776, 14724.042937209048, 15094.924525377302, 15617.219139043229, 10678.786424271626, 10694.091002264895, 11018.889811101786, 11155.27490713101, 11685.240459370114, 12348.3825808711, 12525.624231273076, 13328.666783330495, 14421.495247666282, 14561.490347837775, 11964.820527691918, 12311.737389591945, 13043.282619455642, 13059.34703264814, 13112.934435327763, 10828.133749300194, 11384.0, 11499.252548584314, 11964.282143071443, 11970.58102966392, 9962.651307204213, 10340.586376544854, 10364.0, 10891.128709703045, 10919.781604367708], "value": 7317.41814980034, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 113.0, 114.0, 112.0, 113.0, 113.0, 115.0, 112.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 133.0, 125.0, 181.0, 130.0, 128.0, 132.0, 132.0, 158.0, 125.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 166.0, 166.0, 162.0, 164.0, 163.0, 163.0, 164.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 80.0, 76.0, 117.0, 77.0, 78.0, 75.0, 75.0, 109.0, 76.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 116.0, 82.0, 84.0, 82.0, 99.0, 83.0, 82.0, 108.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 119.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 146.0, 149.0, 148.0, 147.0, 146.0, 147.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 85.0, 86.0, 87.0, 86.0, 86.0, 86.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 57.0, 54.0, 54.0, 55.0, 57.0, 54.0, 55.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 64.0, 61.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 82.0, 82.0, 81.0, 81.0, 81.0, 80.0, 80.0, 80.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 134.0, 141.0, 134.0, 132.0, 137.0, 150.0, 138.0, 186.0, 135.0], "value": 143.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 170.0, 176.0, 172.0, 168.0, 169.0, 169.0, 174.0, 167.0, 168.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 71.0, 70.0, 70.0, 71.0, 66.0, 70.0, 65.0, 67.0], "value": 69.0, "unit": "score"}]}]} 18:32:09 INFO - Return code: 0 18:32:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:32:09 ERROR - # TBPL SUCCESS # 18:32:09 INFO - Running post-action listener: _resource_record_post_action 18:32:09 INFO - [mozharness: 2016-10-15 01:32:09.840952Z] Finished run-tests step (success) 18:32:09 INFO - Running post-run listener: _resource_record_post_run 18:32:09 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393408512; Read time: 12; Write time: 233548 18:32:09 INFO - TinderboxPrint: CPU usage
13.4% 18:32:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:32:09 INFO - TinderboxPrint: I/O write bytes / time
393,408,512 / 233,548 18:32:09 INFO - TinderboxPrint: CPU idle
8,266.0 (86.6%) 18:32:09 INFO - TinderboxPrint: CPU user
1,218.3 (12.8%) 18:32:09 INFO - TinderboxPrint: Swap in / out
0 / 0 18:32:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103776256; Read time: 0; Write time: 72304 18:32:09 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 289632256; Read time: 0; Write time: 161244 18:32:10 INFO - Running post-run listener: _upload_blobber_files 18:32:10 INFO - Blob upload gear active. 18:32:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:32:10 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 18:32:10 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'] 18:32:10 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 18:32:10 INFO - (blobuploader) - INFO - Open directory for files ... 18:32:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:32:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:32:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:14 INFO - (blobuploader) - INFO - Done attempting. 18:32:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:32:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:32:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:15 INFO - (blobuploader) - INFO - Done attempting. 18:32:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:32:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:32:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:15 INFO - (blobuploader) - INFO - Done attempting. 18:32:15 INFO - (blobuploader) - INFO - Iteration through files over. 18:32:15 INFO - Return code: 0 18:32:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:32:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:32:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/12e6b9e30e9fe3edc3902ede10966b7fa938e68226d5d9e8af0e3f4a0c064703643876f6a761216d77dce04cf7704d61609d57a756fbaac2cb6b62d946a37639", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c1b26811b5f80e0eec7c2594eb0758ad836868d3c3b3be08f7971468ca00ddb457611150d6916623816f294f687de32b2cb693af332ee73634e83cb831b420ad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/625282462508e4d865bdc52fa9a01878d4310329c9f6c39cd9f7de855f752b7721da51021a6762cd21c926b6921374b6dbce5d96f13ef567d2a4d4676c72647c"} 18:32:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:32:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:32:15 INFO - Contents: 18:32:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/12e6b9e30e9fe3edc3902ede10966b7fa938e68226d5d9e8af0e3f4a0c064703643876f6a761216d77dce04cf7704d61609d57a756fbaac2cb6b62d946a37639", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c1b26811b5f80e0eec7c2594eb0758ad836868d3c3b3be08f7971468ca00ddb457611150d6916623816f294f687de32b2cb693af332ee73634e83cb831b420ad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/625282462508e4d865bdc52fa9a01878d4310329c9f6c39cd9f7de855f752b7721da51021a6762cd21c926b6921374b6dbce5d96f13ef567d2a4d4676c72647c"} 18:32:15 INFO - Running post-run listener: copy_logs_to_upload_dir 18:32:15 INFO - Copying logs to upload dir... 18:32:15 INFO - mkdir: /builds/slave/test/build/upload/logs 18:32:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.124157 ========= master_lag: 0.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-14 18:32:16.020988) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 18:32:16.028110) ========= 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=8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/12e6b9e30e9fe3edc3902ede10966b7fa938e68226d5d9e8af0e3f4a0c064703643876f6a761216d77dce04cf7704d61609d57a756fbaac2cb6b62d946a37639", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c1b26811b5f80e0eec7c2594eb0758ad836868d3c3b3be08f7971468ca00ddb457611150d6916623816f294f687de32b2cb693af332ee73634e83cb831b420ad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/625282462508e4d865bdc52fa9a01878d4310329c9f6c39cd9f7de855f752b7721da51021a6762cd21c926b6921374b6dbce5d96f13ef567d2a4d4676c72647c"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476482062/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010181 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476482062/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/12e6b9e30e9fe3edc3902ede10966b7fa938e68226d5d9e8af0e3f4a0c064703643876f6a761216d77dce04cf7704d61609d57a756fbaac2cb6b62d946a37639", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c1b26811b5f80e0eec7c2594eb0758ad836868d3c3b3be08f7971468ca00ddb457611150d6916623816f294f687de32b2cb693af332ee73634e83cb831b420ad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/625282462508e4d865bdc52fa9a01878d4310329c9f6c39cd9f7de855f752b7721da51021a6762cd21c926b6921374b6dbce5d96f13ef567d2a4d4676c72647c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 18:32:16.051490) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 18:32:16.054858) ========= 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=8887e36bb8e381bfd44124ac000001a8-1476489600.409373-631658632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 18:32:16.104994) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 18:32:16.105303) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 18:32:16.105592) ========= ========= Total master_lag: 0.44 =========