builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1476877176.86 results: success (0) buildid: 20161019040324 builduid: 629725b99ff043f895aca205488b9287 revision: 40a7a506f5bb8774958f692c8a218c9f6a7e6a72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 04:39:36.864344) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 04:39:36.864839) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 04:39:36.865149) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 04:39:36.879983) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 04:39:36.880278) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-19 04:39:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-10-19 04:39:37 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.176883 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 04:39:37.071297) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 04:39:37.071662) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016452 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 04:39:37.121829) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 04:39:37.122219) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 40a7a506f5bb8774958f692c8a218c9f6a7e6a72 --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 40a7a506f5bb8774958f692c8a218c9f6a7e6a72 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-19 04:39:37,186 truncating revision to first 12 chars 2016-10-19 04:39:37,186 Setting DEBUG logging. 2016-10-19 04:39:37,187 attempt 1/10 2016-10-19 04:39:37,187 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/40a7a506f5bb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 04:39:38,183 unpacking tar archive at: mozilla-inbound-40a7a506f5bb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.321982 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 04:39:38.457548) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 04:39:38.457873) ========= script_repo_revision: 40a7a506f5bb8774958f692c8a218c9f6a7e6a72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 04:39:38.458242) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 04:39:38.458499) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 04:39:38.465925) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-19 04:39:38.466187) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:39:38 INFO - MultiFileLogger online at 20161019 04:39:38 in /builds/slave/test 04:39:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:39:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:39:38 INFO - {'append_to_log': False, 04:39:38 INFO - 'base_work_dir': '/builds/slave/test', 04:39:38 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:39:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:39:38 INFO - 'branch': 'Mozilla-Inbound', 04:39:38 INFO - 'buildbot_json_path': 'buildprops.json', 04:39:38 INFO - 'config_files': ('talos/linux_config.py',), 04:39:38 INFO - 'default_actions': ('clobber', 04:39:38 INFO - 'read-buildbot-config', 04:39:38 INFO - 'download-and-extract', 04:39:38 INFO - 'populate-webroot', 04:39:38 INFO - 'create-virtualenv', 04:39:38 INFO - 'install', 04:39:38 INFO - 'run-tests'), 04:39:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:39:38 INFO - 'download_minidump_stackwalk': True, 04:39:38 INFO - 'download_symbols': 'ondemand', 04:39:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:39:38 INFO - 'tooltool.py': '/tools/tooltool.py', 04:39:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:39:38 INFO - '/tools/misc-python/virtualenv.py')}, 04:39:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:39:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:39:38 INFO - 'installer_path': 'installer.exe', 04:39:38 INFO - 'log_level': 'info', 04:39:38 INFO - 'log_name': 'talos', 04:39:38 INFO - 'log_to_console': True, 04:39:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:39:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:39:38 INFO - 'opt_config_files': (), 04:39:38 INFO - 'pip_index': False, 04:39:38 INFO - 'sps_profile': False, 04:39:38 INFO - 'sps_profile_interval': 0, 04:39:38 INFO - 'suite': 'dromaeojs', 04:39:38 INFO - 'system_bits': '32', 04:39:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:39:38 INFO - 'title': 'talos-linux64-ix-041', 04:39:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:39:38 INFO - 'use_talos_json': True, 04:39:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:39:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:39:38 INFO - 'work_dir': 'build'} 04:39:38 INFO - [mozharness: 2016-10-19 11:39:38.630750Z] Running clobber step. 04:39:38 INFO - Running pre-action listener: _resource_record_pre_action 04:39:38 INFO - Running main action method: clobber 04:39:38 INFO - rmtree: /builds/slave/test/build 04:39:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:39:39 INFO - Running post-action listener: _resource_record_post_action 04:39:39 INFO - [mozharness: 2016-10-19 11:39:39.594491Z] Finished clobber step (success) 04:39:39 INFO - [mozharness: 2016-10-19 11:39:39.594590Z] Running read-buildbot-config step. 04:39:39 INFO - Running pre-action listener: _resource_record_pre_action 04:39:39 INFO - Running main action method: read_buildbot_config 04:39:39 INFO - Using buildbot properties: 04:39:39 INFO - { 04:39:39 INFO - "project": "", 04:39:39 INFO - "product": "firefox", 04:39:39 INFO - "script_repo_revision": "production", 04:39:39 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:39:39 INFO - "repository": "", 04:39:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:39:39 INFO - "buildid": "20161019040324", 04:39:39 INFO - "stage_platform": "linux64-pgo", 04:39:39 INFO - "basedir": "/builds/slave/test", 04:39:39 INFO - "buildnumber": 1861, 04:39:39 INFO - "platform": "ubuntu64_hw", 04:39:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:39:39 INFO - "slavebuilddir": "test", 04:39:39 INFO - "branch": "mozilla-inbound", 04:39:39 INFO - "revision": "40a7a506f5bb8774958f692c8a218c9f6a7e6a72", 04:39:39 INFO - "slavename": "talos-linux64-ix-041", 04:39:39 INFO - "builduid": "629725b99ff043f895aca205488b9287", 04:39:39 INFO - "repo_path": "integration/mozilla-inbound" 04:39:39 INFO - } 04:39:39 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:39:39 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 04:39:39 INFO - Running post-action listener: _resource_record_post_action 04:39:39 INFO - [mozharness: 2016-10-19 11:39:39.596936Z] Finished read-buildbot-config step (success) 04:39:39 INFO - [mozharness: 2016-10-19 11:39:39.597024Z] Running download-and-extract step. 04:39:39 INFO - Running pre-action listener: _resource_record_pre_action 04:39:39 INFO - Running main action method: download_and_extract 04:39:39 INFO - mkdir: /builds/slave/test/build/tests 04:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:39 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:39:39 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/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 04:39:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/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 04:39:39 INFO - Downloaded 1361 bytes. 04:39:39 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:39:39 INFO - Using the following test package requirements: 04:39:39 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:39:39 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:39:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:39:39 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:39:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:39:39 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:39:39 INFO - u'jsshell-linux-x86_64.zip'], 04:39:39 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:39:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:39:39 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:39:39 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:39:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:39:39 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:39:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:39:39 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:39:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:39:39 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:39:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:39:39 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:39:39 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/1476862378/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:39:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:39:39 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:39:39 INFO - Http code: 200 04:39:39 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 04:39:39 INFO - x-amz-cf-id: UIH-d6QIs2gISS4NN7RUHGM0KKrpyHmd3yL0I3GspzaNF9qheIclBA== 04:39:39 INFO - x-amz-replication-status: COMPLETED 04:39:39 INFO - x-amz-version-id: PU4By7sgMRStpihM2cCdJwnI2f4uJiQb 04:39:40 INFO - Expected file size: 22112374 04:39:40 INFO - Obtained file size: 22112374 04:39:44 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 04:39:44 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/1476862378/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:39:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:39:44 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:39:44 INFO - Http code: 200 04:39:44 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 04:39:44 INFO - x-amz-cf-id: gqYO71ts7_QfxfkRT6leZnI8F9fyorAKiiUF1PKUG2Es70oFBowvcg== 04:39:44 INFO - x-amz-replication-status: COMPLETED 04:39:44 INFO - x-amz-version-id: PU4By7sgMRStpihM2cCdJwnI2f4uJiQb 04:39:44 INFO - Expected file size: 22112374 04:39:44 INFO - Obtained file size: 22112374 04:39:49 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/1476862378/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:39:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:39:49 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:39:49 INFO - Http code: 200 04:39:49 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 04:39:49 INFO - x-amz-cf-id: omL-j2hQ6wkSk_hpIQU1_OLeJLJdyFk2EYCBEiAin-tCugW_N1kDZA== 04:39:49 INFO - x-amz-replication-status: COMPLETED 04:39:49 INFO - x-amz-version-id: Zrq2yrzmdZ_17.L5SNpICMBX4TMEdA_B 04:39:49 INFO - Expected file size: 14409028 04:39:49 INFO - Obtained file size: 14409028 04:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:49 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:39:49 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/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 04:39:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/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 04:39:50 INFO - Downloaded 59479914 bytes. 04:39:50 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:39:50 INFO - mkdir: /builds/slave/test/properties 04:39:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:39:50 INFO - Writing to file /builds/slave/test/properties/build_url 04:39:50 INFO - Contents: 04:39:50 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:39:51 INFO - Running post-action listener: _resource_record_post_action 04:39:51 INFO - Running post-action listener: set_extra_try_arguments 04:39:51 INFO - [mozharness: 2016-10-19 11:39:51.200031Z] Finished download-and-extract step (success) 04:39:51 INFO - [mozharness: 2016-10-19 11:39:51.200258Z] Running populate-webroot step. 04:39:51 INFO - Running pre-action listener: _resource_record_pre_action 04:39:51 INFO - Running main action method: populate_webroot 04:39:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:39:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:39:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:39:51 INFO - '--tppagecycles', 04:39:51 INFO - '7'], 04:39:51 INFO - 'tests': ['tsvgm']}}, 04:39:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:39:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:39:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:39:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:39:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:39:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:39:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:51 INFO - 'talos_options': ['--disable-e10s'], 04:39:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:51 INFO - 'talos_options': ['--disable-e10s'], 04:39:51 INFO - 'tests': ['damp', 'tps']}, 04:39:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:51 INFO - 'tests': ['damp', 'tps']}, 04:39:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:39:51 INFO - 'tests': ['dromaeo_dom']}, 04:39:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:39:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:39:51 INFO - 'tests': ['basic_compositor_video']}, 04:39:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:39:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:39:51 INFO - 'tests': ['a11yr', 04:39:51 INFO - 'ts_paint', 04:39:51 INFO - 'tpaint', 04:39:51 INFO - 'sessionrestore', 04:39:51 INFO - 'sessionrestore_no_auto_restore', 04:39:51 INFO - 'tabpaint']}, 04:39:51 INFO - 'other-e10s': {'tests': ['a11yr', 04:39:51 INFO - 'ts_paint', 04:39:51 INFO - 'tpaint', 04:39:51 INFO - 'sessionrestore', 04:39:51 INFO - 'sessionrestore_no_auto_restore', 04:39:51 INFO - 'tabpaint']}, 04:39:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:39:51 INFO - 'ts_paint', 04:39:51 INFO - 'tpaint', 04:39:51 INFO - 'sessionrestore', 04:39:51 INFO - 'sessionrestore_no_auto_restore', 04:39:51 INFO - 'tabpaint']}, 04:39:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:39:51 INFO - 'ts_paint', 04:39:51 INFO - 'tpaint', 04:39:51 INFO - 'sessionrestore', 04:39:51 INFO - 'sessionrestore_no_auto_restore', 04:39:51 INFO - 'tabpaint']}, 04:39:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:39:51 INFO - 'tests': ['a11yr', 04:39:51 INFO - 'ts_paint', 04:39:51 INFO - 'tpaint', 04:39:51 INFO - 'sessionrestore', 04:39:51 INFO - 'sessionrestore_no_auto_restore', 04:39:51 INFO - 'tabpaint']}, 04:39:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:39:51 INFO - 'tests': ['a11yr', 04:39:51 INFO - 'ts_paint', 04:39:51 INFO - 'tpaint', 04:39:51 INFO - 'sessionrestore', 04:39:51 INFO - 'sessionrestore_no_auto_restore', 04:39:51 INFO - 'tabpaint']}, 04:39:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:39:51 INFO - 'tests': ['tsvgx', 04:39:51 INFO - 'tsvgr_opacity', 04:39:51 INFO - 'tart', 04:39:51 INFO - 'tscrollx', 04:39:51 INFO - 'cart']}, 04:39:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:39:51 INFO - 'tsvgr_opacity', 04:39:51 INFO - 'tart', 04:39:51 INFO - 'tscrollx', 04:39:51 INFO - 'cart']}, 04:39:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:51 INFO - 'talos_options': ['--disable-e10s'], 04:39:51 INFO - 'tests': ['tp5o']}, 04:39:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:51 INFO - 'tests': ['tp5o']}, 04:39:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:51 INFO - 'talos_options': ['--disable-e10s', 04:39:51 INFO - '--xperf_path', 04:39:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:51 INFO - 'tests': ['tp5n']}, 04:39:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:51 INFO - 'talos_options': ['--xperf_path', 04:39:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:51 INFO - 'tests': ['tp5n']}}, 04:39:51 INFO - 'talos.zip': {'path': '', 04:39:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:39:51 INFO - Running post-action listener: _resource_record_post_action 04:39:51 INFO - [mozharness: 2016-10-19 11:39:51.221826Z] Finished populate-webroot step (success) 04:39:51 INFO - [mozharness: 2016-10-19 11:39:51.221913Z] Running create-virtualenv step. 04:39:51 INFO - Running pre-action listener: _resource_record_pre_action 04:39:51 INFO - Running main action method: create_virtualenv 04:39:51 INFO - Creating virtualenv /builds/slave/test/build/venv 04:39:51 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 04:39:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:39:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:39:51 INFO - Using real prefix '/usr' 04:39:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:39:51 INFO - Installing distribute.............................................................................................................................................................................................done. 04:39:53 INFO - Installing pip.................done. 04:39:53 INFO - Return code: 0 04:39:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:39:53 INFO - Reading from file tmpfile_stdout 04:39:53 INFO - Output received: 04:39:53 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) 04:39:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:54 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 0x7f67f9811f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2699f60>, '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 0x269ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269b1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', '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 04:39:54 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 04:39:54 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 04:39:54 INFO - Using env: {'DISPLAY': ':0', 04:39:54 INFO - 'HOME': '/home/cltbld', 04:39:54 INFO - 'LANG': 'en_US.UTF-8', 04:39:54 INFO - 'LANGUAGE': 'en_US:en', 04:39:54 INFO - 'LOGNAME': 'cltbld', 04:39:54 INFO - 'MAIL': '/var/mail/cltbld', 04:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:54 INFO - 'MOZ_NO_REMOTE': '1', 04:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:54 INFO - 'NO_EM_RESTART': '1', 04:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:54 INFO - 'PWD': '/builds/slave/test', 04:39:54 INFO - 'SHELL': '/bin/bash', 04:39:54 INFO - 'SHLVL': '1', 04:39:54 INFO - 'TERM': 'linux', 04:39:54 INFO - 'TMOUT': '86400', 04:39:54 INFO - 'USER': 'cltbld', 04:39:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', 04:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:54 INFO - '_': '/tools/buildbot/bin/python'} 04:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:54 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 04:39:54 INFO - Cleaning up... 04:39:54 INFO - Return code: 0 04:39:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:39:54 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')]} 04:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:54 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')]} 04:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:54 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 0x7f67f9811f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2699f60>, '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 0x269ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269b1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', '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 04:39:54 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 04:39:54 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 04:39:54 INFO - Using env: {'DISPLAY': ':0', 04:39:54 INFO - 'HOME': '/home/cltbld', 04:39:54 INFO - 'LANG': 'en_US.UTF-8', 04:39:54 INFO - 'LANGUAGE': 'en_US:en', 04:39:54 INFO - 'LOGNAME': 'cltbld', 04:39:54 INFO - 'MAIL': '/var/mail/cltbld', 04:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:54 INFO - 'MOZ_NO_REMOTE': '1', 04:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:54 INFO - 'NO_EM_RESTART': '1', 04:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:54 INFO - 'PWD': '/builds/slave/test', 04:39:54 INFO - 'SHELL': '/bin/bash', 04:39:54 INFO - 'SHLVL': '1', 04:39:54 INFO - 'TERM': 'linux', 04:39:54 INFO - 'TMOUT': '86400', 04:39:54 INFO - 'USER': 'cltbld', 04:39:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', 04:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:54 INFO - '_': '/tools/buildbot/bin/python'} 04:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:54 INFO - Downloading/unpacking psutil>=3.1.1 04:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:39:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:56 INFO - Installing collected packages: psutil 04:39:56 INFO - Running setup.py install for psutil 04:39:56 INFO - building 'psutil._psutil_linux' extension 04:39:56 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 04:39:56 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 04:39:56 INFO - building 'psutil._psutil_posix' extension 04:39:56 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 04:39:56 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 04:39:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:56 INFO - Successfully installed psutil 04:39:56 INFO - Cleaning up... 04:39:57 INFO - Return code: 0 04:39:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f67f9811f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2699f60>, '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 0x269ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269b1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', '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 04:39:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:39:57 INFO - Using env: {'DISPLAY': ':0', 04:39:57 INFO - 'HOME': '/home/cltbld', 04:39:57 INFO - 'LANG': 'en_US.UTF-8', 04:39:57 INFO - 'LANGUAGE': 'en_US:en', 04:39:57 INFO - 'LOGNAME': 'cltbld', 04:39:57 INFO - 'MAIL': '/var/mail/cltbld', 04:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:57 INFO - 'MOZ_NO_REMOTE': '1', 04:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:57 INFO - 'NO_EM_RESTART': '1', 04:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:57 INFO - 'PWD': '/builds/slave/test', 04:39:57 INFO - 'SHELL': '/bin/bash', 04:39:57 INFO - 'SHLVL': '1', 04:39:57 INFO - 'TERM': 'linux', 04:39:57 INFO - 'TMOUT': '86400', 04:39:57 INFO - 'USER': 'cltbld', 04:39:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', 04:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:57 INFO - '_': '/tools/buildbot/bin/python'} 04:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:39:59 INFO - Installing collected packages: mozsystemmonitor 04:39:59 INFO - Running setup.py install for mozsystemmonitor 04:39:59 INFO - Successfully installed mozsystemmonitor 04:39:59 INFO - Cleaning up... 04:39:59 INFO - Return code: 0 04:39:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:59 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 0x7f67f9811f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2699f60>, '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 0x269ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269b1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', '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 04:39:59 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 04:39:59 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 04:39:59 INFO - Using env: {'DISPLAY': ':0', 04:39:59 INFO - 'HOME': '/home/cltbld', 04:39:59 INFO - 'LANG': 'en_US.UTF-8', 04:39:59 INFO - 'LANGUAGE': 'en_US:en', 04:39:59 INFO - 'LOGNAME': 'cltbld', 04:39:59 INFO - 'MAIL': '/var/mail/cltbld', 04:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:59 INFO - 'MOZ_NO_REMOTE': '1', 04:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:59 INFO - 'NO_EM_RESTART': '1', 04:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:59 INFO - 'PWD': '/builds/slave/test', 04:39:59 INFO - 'SHELL': '/bin/bash', 04:39:59 INFO - 'SHLVL': '1', 04:39:59 INFO - 'TERM': 'linux', 04:39:59 INFO - 'TMOUT': '86400', 04:39:59 INFO - 'USER': 'cltbld', 04:39:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', 04:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:59 INFO - '_': '/tools/buildbot/bin/python'} 04:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:59 INFO - Downloading/unpacking jsonschema==2.5.1 04:39:59 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 04:39:59 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 04:39:59 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 04:39:59 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 04:39:59 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 04:39:59 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 04:40:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:40:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:40: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 04:40: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 04:40: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 04:40: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 04:40: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 04:40: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 04:40:01 INFO - Downloading functools32-3.2.3-2.tar.gz 04:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:40:01 INFO - warning: no files found matching '*.txt' 04:40:01 INFO - no previously-included directories found matching 'build' 04:40:01 INFO - no previously-included directories found matching 'dist' 04:40:01 INFO - no previously-included directories found matching '.git*' 04:40:01 INFO - Installing collected packages: jsonschema, functools32 04:40:01 INFO - Running setup.py install for functools32 04:40:01 INFO - warning: no files found matching '*.txt' 04:40:01 INFO - no previously-included directories found matching 'build' 04:40:01 INFO - no previously-included directories found matching 'dist' 04:40:01 INFO - no previously-included directories found matching '.git*' 04:40:01 INFO - Successfully installed jsonschema functools32 04:40:01 INFO - Cleaning up... 04:40:02 INFO - Return code: 0 04:40:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f67f9811f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2699f60>, '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 0x269ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269b1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', '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 04:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:40:02 INFO - Using env: {'DISPLAY': ':0', 04:40:02 INFO - 'HOME': '/home/cltbld', 04:40:02 INFO - 'LANG': 'en_US.UTF-8', 04:40:02 INFO - 'LANGUAGE': 'en_US:en', 04:40:02 INFO - 'LOGNAME': 'cltbld', 04:40:02 INFO - 'MAIL': '/var/mail/cltbld', 04:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:02 INFO - 'MOZ_NO_REMOTE': '1', 04:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:02 INFO - 'NO_EM_RESTART': '1', 04:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:02 INFO - 'PWD': '/builds/slave/test', 04:40:02 INFO - 'SHELL': '/bin/bash', 04:40:02 INFO - 'SHLVL': '1', 04:40:02 INFO - 'TERM': 'linux', 04:40:02 INFO - 'TMOUT': '86400', 04:40:02 INFO - 'USER': 'cltbld', 04:40:02 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', 04:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:02 INFO - '_': '/tools/buildbot/bin/python'} 04:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:40:02 INFO - Cleaning up... 04:40:02 INFO - Return code: 0 04:40:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f67f9811f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2699f60>, '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 0x269ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269b1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', '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 04:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:40:02 INFO - Using env: {'DISPLAY': ':0', 04:40:02 INFO - 'HOME': '/home/cltbld', 04:40:02 INFO - 'LANG': 'en_US.UTF-8', 04:40:02 INFO - 'LANGUAGE': 'en_US:en', 04:40:02 INFO - 'LOGNAME': 'cltbld', 04:40:02 INFO - 'MAIL': '/var/mail/cltbld', 04:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:02 INFO - 'MOZ_NO_REMOTE': '1', 04:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:02 INFO - 'NO_EM_RESTART': '1', 04:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:02 INFO - 'PWD': '/builds/slave/test', 04:40:02 INFO - 'SHELL': '/bin/bash', 04:40:02 INFO - 'SHLVL': '1', 04:40:02 INFO - 'TERM': 'linux', 04:40:02 INFO - 'TMOUT': '86400', 04:40:02 INFO - 'USER': 'cltbld', 04:40:02 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', 04:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:02 INFO - '_': '/tools/buildbot/bin/python'} 04:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:02 INFO - Downloading/unpacking blobuploader==1.2.4 04:40:02 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 04:40:02 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 04:40:02 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 04:40:02 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 04:40:02 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 04:40:02 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 04:40:04 INFO - Downloading blobuploader-1.2.4.tar.gz 04:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:40:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:40:04 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 04:40:04 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 04:40:04 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 04:40:04 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 04:40:04 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 04:40:04 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 04:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:40:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:40:04 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 04:40:04 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 04:40:04 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 04:40:04 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 04:40:04 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 04:40:04 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 04:40:05 INFO - Downloading docopt-0.6.1.tar.gz 04:40:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:40:05 INFO - Installing collected packages: blobuploader, requests, docopt 04:40:05 INFO - Running setup.py install for blobuploader 04:40:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:40:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:40:05 INFO - Running setup.py install for requests 04:40:05 INFO - Running setup.py install for docopt 04:40:05 INFO - Successfully installed blobuploader requests docopt 04:40:05 INFO - Cleaning up... 04:40:05 INFO - Return code: 0 04:40:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:05 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 0x7f67f9811f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2699f60>, '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 0x269ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269b1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', '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 04:40:05 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 04:40:05 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 04:40:05 INFO - Using env: {'DISPLAY': ':0', 04:40:05 INFO - 'HOME': '/home/cltbld', 04:40:05 INFO - 'LANG': 'en_US.UTF-8', 04:40:05 INFO - 'LANGUAGE': 'en_US:en', 04:40:05 INFO - 'LOGNAME': 'cltbld', 04:40:05 INFO - 'MAIL': '/var/mail/cltbld', 04:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:05 INFO - 'MOZ_NO_REMOTE': '1', 04:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:05 INFO - 'NO_EM_RESTART': '1', 04:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:05 INFO - 'PWD': '/builds/slave/test', 04:40:05 INFO - 'SHELL': '/bin/bash', 04:40:05 INFO - 'SHLVL': '1', 04:40:05 INFO - 'TERM': 'linux', 04:40:05 INFO - 'TMOUT': '86400', 04:40:05 INFO - 'USER': 'cltbld', 04:40:05 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', 04:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:05 INFO - '_': '/tools/buildbot/bin/python'} 04:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:40:06 INFO - Running setup.py (path:/tmp/pip-BgsM9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:40:06 INFO - Running setup.py (path:/tmp/pip-nkcIP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:40:06 INFO - Running setup.py (path:/tmp/pip-j29yZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:40:06 INFO - Running setup.py (path:/tmp/pip-heTlOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:40:06 INFO - Running setup.py (path:/tmp/pip-TbwqzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:40:06 INFO - Running setup.py (path:/tmp/pip-rKKvyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:40:06 INFO - Running setup.py (path:/tmp/pip-lp19jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:40:06 INFO - Running setup.py (path:/tmp/pip-oIqgiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:40:06 INFO - Running setup.py (path:/tmp/pip-sLCKkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:40:06 INFO - Running setup.py (path:/tmp/pip-tNx6lE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:40:06 INFO - Running setup.py (path:/tmp/pip-4BA0dT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:40:06 INFO - Running setup.py (path:/tmp/pip-w6zu_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:40:06 INFO - Running setup.py (path:/tmp/pip-DdGiYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:40:06 INFO - Running setup.py (path:/tmp/pip-LSRt5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:07 INFO - Running setup.py (path:/tmp/pip-OUJbEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:40:07 INFO - Running setup.py (path:/tmp/pip-7ZEOtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:40:07 INFO - Running setup.py (path:/tmp/pip-_Fg_RV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:40:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:40:07 INFO - Running setup.py install for manifestparser 04:40:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:40:07 INFO - Running setup.py install for mozcrash 04:40:07 INFO - Running setup.py install for mozdebug 04:40:07 INFO - Running setup.py install for mozdevice 04:40:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:40:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:40:07 INFO - Running setup.py install for mozfile 04:40:07 INFO - Running setup.py install for mozhttpd 04:40:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:40:07 INFO - Running setup.py install for mozinfo 04:40:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:40:07 INFO - Running setup.py install for mozInstall 04:40:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:40:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:40:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:40:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:40:08 INFO - Running setup.py install for mozleak 04:40:08 INFO - Running setup.py install for mozlog 04:40:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:40:08 INFO - Running setup.py install for moznetwork 04:40:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:40:08 INFO - Running setup.py install for mozprocess 04:40:08 INFO - Running setup.py install for mozprofile 04:40:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:40:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:40:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:40:08 INFO - Running setup.py install for mozrunner 04:40:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:40:08 INFO - Running setup.py install for mozscreenshot 04:40:08 INFO - Running setup.py install for moztest 04:40:08 INFO - Running setup.py install for mozversion 04:40:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:40:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:40:09 INFO - Cleaning up... 04:40:09 INFO - Return code: 0 04:40:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40:09 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')]} 04:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:09 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')]} 04:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:09 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 0x7f67f9811f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2699f60>, '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 0x269ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269b1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', '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 04:40:09 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 04:40:09 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 04:40:09 INFO - Using env: {'DISPLAY': ':0', 04:40:09 INFO - 'HOME': '/home/cltbld', 04:40:09 INFO - 'LANG': 'en_US.UTF-8', 04:40:09 INFO - 'LANGUAGE': 'en_US:en', 04:40:09 INFO - 'LOGNAME': 'cltbld', 04:40:09 INFO - 'MAIL': '/var/mail/cltbld', 04:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:09 INFO - 'MOZ_NO_REMOTE': '1', 04:40:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:09 INFO - 'NO_EM_RESTART': '1', 04:40:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:09 INFO - 'PWD': '/builds/slave/test', 04:40:09 INFO - 'SHELL': '/bin/bash', 04:40:09 INFO - 'SHLVL': '1', 04:40:09 INFO - 'TERM': 'linux', 04:40:09 INFO - 'TMOUT': '86400', 04:40:09 INFO - 'USER': 'cltbld', 04:40:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', 04:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:09 INFO - '_': '/tools/buildbot/bin/python'} 04:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:40:09 INFO - Running setup.py (path:/tmp/pip-eiHpIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:40:09 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)) 04:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:40:09 INFO - Running setup.py (path:/tmp/pip-EF1uSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:40:09 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)) 04:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:40:09 INFO - Running setup.py (path:/tmp/pip-hz09H6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:40:09 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)) 04:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:40:09 INFO - Running setup.py (path:/tmp/pip-QKHwYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:40:09 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)) 04:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:40:09 INFO - Running setup.py (path:/tmp/pip-YpVTyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:40:09 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)) 04:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:40:09 INFO - Running setup.py (path:/tmp/pip-wogSPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:40:09 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)) 04:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:40:09 INFO - Running setup.py (path:/tmp/pip-bbBLTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:40:09 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)) 04:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:40:09 INFO - Running setup.py (path:/tmp/pip-TWP1Xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:40:09 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)) 04:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:40:09 INFO - Running setup.py (path:/tmp/pip-888ZVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:40:09 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)) 04:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:40:09 INFO - Running setup.py (path:/tmp/pip-mIVEUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:40:09 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)) 04:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:40:09 INFO - Running setup.py (path:/tmp/pip-mWp1ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:40:10 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)) 04:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:40:10 INFO - Running setup.py (path:/tmp/pip-NiZz9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:40:10 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)) 04:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:40:10 INFO - Running setup.py (path:/tmp/pip-P7EXeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:40:10 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)) 04:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:40:10 INFO - Running setup.py (path:/tmp/pip-g9PfaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:40:10 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)) 04:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:10 INFO - Running setup.py (path:/tmp/pip-Xhlo9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:10 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)) 04:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:40:10 INFO - Running setup.py (path:/tmp/pip-a2DgZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:40:10 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)) 04:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:40:10 INFO - Running setup.py (path:/tmp/pip-eCOpNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:40:10 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)) 04:40:10 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)) 04:40:10 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)) 04:40:10 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)) 04:40:10 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)) 04:40:10 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)) 04:40:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:12 INFO - Downloading blessings-1.6.tar.gz 04:40:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:40:12 INFO - Installing collected packages: blessings 04:40:12 INFO - Running setup.py install for blessings 04:40:12 INFO - Successfully installed blessings 04:40:12 INFO - Cleaning up... 04:40:12 INFO - Return code: 0 04:40:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:40:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:40:12 INFO - Reading from file tmpfile_stdout 04:40:12 INFO - Current package versions: 04:40:12 INFO - argparse == 1.2.1 04:40:12 INFO - blessings == 1.6 04:40:12 INFO - blobuploader == 1.2.4 04:40:12 INFO - docopt == 0.6.1 04:40:12 INFO - functools32 == 3.2.3-2 04:40:12 INFO - jsonschema == 2.5.1 04:40:12 INFO - manifestparser == 1.1 04:40:12 INFO - mozInstall == 1.12 04:40:12 INFO - mozcrash == 0.17 04:40:12 INFO - mozdebug == 0.1 04:40:12 INFO - mozdevice == 0.48 04:40:12 INFO - mozfile == 1.2 04:40:12 INFO - mozhttpd == 0.7 04:40:12 INFO - mozinfo == 0.9 04:40:12 INFO - mozleak == 0.1 04:40:12 INFO - mozlog == 3.4 04:40:12 INFO - moznetwork == 0.27 04:40:12 INFO - mozprocess == 0.23 04:40:12 INFO - mozprofile == 0.28 04:40:12 INFO - mozrunner == 6.12 04:40:12 INFO - mozscreenshot == 0.1 04:40:12 INFO - mozsystemmonitor == 0.3 04:40:12 INFO - moztest == 0.7 04:40:12 INFO - mozversion == 1.4 04:40:12 INFO - psutil == 3.1.1 04:40:12 INFO - requests == 1.2.3 04:40:12 INFO - wsgiref == 0.1.2 04:40:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40: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')]} 04:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40: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')]} 04:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:12 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 0x7f67f9811f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2699f60>, '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 0x269ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269b1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', '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 04:40:12 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 04:40:12 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 04:40:12 INFO - Using env: {'DISPLAY': ':0', 04:40:12 INFO - 'HOME': '/home/cltbld', 04:40:12 INFO - 'LANG': 'en_US.UTF-8', 04:40:12 INFO - 'LANGUAGE': 'en_US:en', 04:40:12 INFO - 'LOGNAME': 'cltbld', 04:40:12 INFO - 'MAIL': '/var/mail/cltbld', 04:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:12 INFO - 'MOZ_NO_REMOTE': '1', 04:40:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:12 INFO - 'NO_EM_RESTART': '1', 04:40:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:12 INFO - 'PWD': '/builds/slave/test', 04:40:12 INFO - 'SHELL': '/bin/bash', 04:40:12 INFO - 'SHLVL': '1', 04:40:12 INFO - 'TERM': 'linux', 04:40:12 INFO - 'TMOUT': '86400', 04:40:12 INFO - 'USER': 'cltbld', 04:40:12 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', 04:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:12 INFO - '_': '/tools/buildbot/bin/python'} 04:40:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:13 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)) 04:40:13 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)) 04:40:13 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)) 04:40:13 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)) 04:40:13 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)) 04:40:13 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)) 04:40:13 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)) 04:40:13 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)) 04:40:13 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)) 04:40:13 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)) 04:40:13 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)) 04:40:13 INFO - Cleaning up... 04:40:13 INFO - Return code: 0 04:40:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:40:13 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')]} 04:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:13 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')]} 04:40:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:13 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 0x7f67f9811f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2699f60>, '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 0x269ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269b1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', '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 04:40:13 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 04:40:13 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 04:40:13 INFO - Using env: {'DISPLAY': ':0', 04:40:13 INFO - 'HOME': '/home/cltbld', 04:40:13 INFO - 'LANG': 'en_US.UTF-8', 04:40:13 INFO - 'LANGUAGE': 'en_US:en', 04:40:13 INFO - 'LOGNAME': 'cltbld', 04:40:13 INFO - 'MAIL': '/var/mail/cltbld', 04:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:13 INFO - 'MOZ_NO_REMOTE': '1', 04:40:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:13 INFO - 'NO_EM_RESTART': '1', 04:40:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:13 INFO - 'PWD': '/builds/slave/test', 04:40:13 INFO - 'SHELL': '/bin/bash', 04:40:13 INFO - 'SHLVL': '1', 04:40:13 INFO - 'TERM': 'linux', 04:40:13 INFO - 'TMOUT': '86400', 04:40:13 INFO - 'USER': 'cltbld', 04:40:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', 04:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:13 INFO - '_': '/tools/buildbot/bin/python'} 04:40:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:40:13 INFO - Cleaning up... 04:40:13 INFO - Return code: 0 04:40:13 INFO - Running post-action listener: _resource_record_post_action 04:40:13 INFO - Running post-action listener: _start_resource_monitoring 04:40:13 INFO - Starting resource monitoring. 04:40:13 INFO - [mozharness: 2016-10-19 11:40:13.368709Z] Finished create-virtualenv step (success) 04:40:13 INFO - [mozharness: 2016-10-19 11:40:13.369203Z] Running install step. 04:40:13 INFO - Running pre-action listener: _resource_record_pre_action 04:40:13 INFO - Running main action method: install 04:40:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:40:13 INFO - Reading from file tmpfile_stdout 04:40:13 INFO - Detecting whether we're running mozinstall >=1.0... 04:40:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:40:13 INFO - Reading from file tmpfile_stdout 04:40:13 INFO - Output received: 04:40:13 INFO - Usage: mozinstall [options] installer 04:40:13 INFO - Options: 04:40:13 INFO - -h, --help show this help message and exit 04:40:13 INFO - -d DEST, --destination=DEST 04:40:13 INFO - Directory to install application into. [default: 04:40:13 INFO - "/builds/slave/test"] 04:40:13 INFO - --app=APP Application being installed. [default: firefox] 04:40:13 INFO - mkdir: /builds/slave/test/build/application 04:40:13 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'] 04:40:13 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 04:40:30 INFO - Reading from file tmpfile_stdout 04:40:30 INFO - Output received: 04:40:30 INFO - /builds/slave/test/build/application/firefox/firefox 04:40:30 INFO - Running post-action listener: _resource_record_post_action 04:40:30 INFO - [mozharness: 2016-10-19 11:40:30.610966Z] Finished install step (success) 04:40:30 INFO - [mozharness: 2016-10-19 11:40:30.611235Z] Running run-tests step. 04:40:30 INFO - Running pre-action listener: _resource_record_pre_action 04:40:30 INFO - Running main action method: run_tests 04:40:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:40:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:40:30 INFO - Python 2.7.3 04:40:30 INFO - Return code: 0 04:40:30 INFO - grabbing minidump binary from tooltool 04:40: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')]} 04:40:30 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 0x2699f60>, '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 0x269ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269b1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:40:30 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 04:40:30 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 04:40:30 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 04:40:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:40:30 INFO - Return code: 0 04:40:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:40:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:40:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:40:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:40:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:40:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:40:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:40:30 INFO - Using env: {'DISPLAY': ':0', 04:40:30 INFO - 'HOME': '/home/cltbld', 04:40:30 INFO - 'LANG': 'en_US.UTF-8', 04:40:30 INFO - 'LANGUAGE': 'en_US:en', 04:40:30 INFO - 'LOGNAME': 'cltbld', 04:40:30 INFO - 'MAIL': '/var/mail/cltbld', 04:40:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:40:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:40:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:30 INFO - 'MOZ_NO_REMOTE': '1', 04:40:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:40:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:30 INFO - 'NO_EM_RESTART': '1', 04:40:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:30 INFO - 'PWD': '/builds/slave/test', 04:40:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:40:30 INFO - 'SHELL': '/bin/bash', 04:40:30 INFO - 'SHLVL': '1', 04:40:30 INFO - 'TERM': 'linux', 04:40:30 INFO - 'TMOUT': '86400', 04:40:30 INFO - 'USER': 'cltbld', 04:40:30 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039', 04:40:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:30 INFO - '_': '/tools/buildbot/bin/python'} 04:40:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:40:30 INFO - mozversion application_buildid: 20161019003258 04:40:30 INFO - mozversion application_changeset: 40a7a506f5bb8774958f692c8a218c9f6a7e6a72 04:40:30 INFO - mozversion application_display_name: Nightly 04:40:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:40:30 INFO - mozversion application_name: Firefox 04:40:30 INFO - mozversion application_remotingname: firefox 04:40:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:40:30 INFO - mozversion application_vendor: Mozilla 04:40:30 INFO - mozversion application_version: 52.0a1 04:40:30 INFO - mozversion platform_buildid: 20161019003258 04:40:30 INFO - mozversion platform_changeset: 40a7a506f5bb8774958f692c8a218c9f6a7e6a72 04:40:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:40:30 INFO - mozversion platform_version: 52.0a1 04:40:30 INFO - using testdate: 1476877230 04:40:30 INFO - actual date: 1476877230 04:40:30 INFO - starting webserver on 'localhost:58089' 04:40:30 INFO - SUITE-START | Running 2 tests 04:40:30 INFO - TEST-START | dromaeo_css 04:40:30 INFO - operating with platform_type : linux_ 04:40:30 INFO - Initialising browser for dromaeo_css test... 04:40:30 INFO - TEST-INFO | started process 8396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjACb6T/profile http://localhost:58089/getInfo.html) 04:40:34 INFO - PROCESS | 8396 | __metrics Screen width/height:1600/1200 04:40:34 INFO - PROCESS | 8396 | colorDepth:24 04:40:34 INFO - PROCESS | 8396 | Browser inner width/height: 1024/697 04:40:34 INFO - PROCESS | 8396 | __metrics 04:40:35 INFO - PROCESS | 8396 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:40:35 INFO - PROCESS | 8396 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:40:36 INFO - PROCESS | 8396 | console.error: PushService: 04:40:36 INFO - PROCESS | 8396 | stateChangeProcessEnqueue: Error transitioning state 04:40:36 INFO - PROCESS | 8396 | UnknownError 04:40:37 INFO - TEST-INFO | 8396: exit 0 04:40:37 INFO - Browser initialized. 04:40:37 INFO - Running cycle 1/1 for dromaeo_css test... 04:40:37 INFO - TEST-INFO | started process 8478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjACb6T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:49 INFO - PROCESS | 8478 | RSS: Main: 172204032 04:40:49 INFO - PROCESS | 8478 | 04:41:40 INFO - PROCESS | 8478 | 1476877300548 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] 04:43:50 INFO - PROCESS | 8478 | Cycle 1(1): loaded http://localhost:58089/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58089/tests/dromaeo/cssquery-ext.html) 04:43:53 INFO - PROCESS | 8478 | RSS: Main: 415129600 04:43:53 INFO - PROCESS | 8478 | 04:46:55 INFO - PROCESS | 8478 | Cycle 1(1): loaded http://localhost:58089/tests/dromaeo/cssquery-ext.html (next: http://localhost:58089/tests/dromaeo/cssquery-jquery.html) 04:46:56 INFO - PROCESS | 8478 | RSS: Main: 286015488 04:46:56 INFO - PROCESS | 8478 | 04:49:58 INFO - PROCESS | 8478 | Cycle 1(1): loaded http://localhost:58089/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58089/tests/dromaeo/cssquery-mootools.html) 04:49:58 INFO - PROCESS | 8478 | RSS: Main: 218050560 04:49:58 INFO - PROCESS | 8478 | 04:53:00 INFO - PROCESS | 8478 | Cycle 1(1): loaded http://localhost:58089/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58089/tests/dromaeo/cssquery-prototype.html) 04:53:01 INFO - PROCESS | 8478 | RSS: Main: 255946752 04:53:01 INFO - PROCESS | 8478 | 04:56:04 INFO - PROCESS | 8478 | Cycle 1(1): loaded http://localhost:58089/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58089/tests/dromaeo/cssquery-yui.html) 04:56:04 INFO - PROCESS | 8478 | RSS: Main: 219299840 04:56:04 INFO - PROCESS | 8478 | 04:59:07 INFO - PROCESS | 8478 | Cycle 1(1): loaded http://localhost:58089/tests/dromaeo/cssquery-yui.html (next: http://localhost:58089/tests/dromaeo/cssquery-dojo.html) 04:59:07 INFO - PROCESS | 8478 | RSS: Main: 328564736 04:59:07 INFO - PROCESS | 8478 | 04:59:07 INFO - PROCESS | 8478 | __start_tp_report 04:59:07 INFO - PROCESS | 8478 | _x_x_mozilla_page_load 04:59:07 INFO - PROCESS | 8478 | _x_x_mozilla_page_load_details 04:59:07 INFO - PROCESS | 8478 | |i|pagename|runs| 04:59:07 INFO - PROCESS | 8478 | |0;dojo.html;3060.969390306097;3088.2588178837086;3091.2890035291884;3109.4247564200637;3142.3715256948603;5092.134337162682;5176.66351687141;5289.391719952207;5359.222912677665;5385.676859388434;5229.032628963644;5262.578993680506;5409.134538473845;5417.864553386167;5472.616916815825;4702.929456058145;4720.858374248778;4778.928316075262;4810.110129626013;4820.301056346828;4812.855614331558;4825;4912.189488734354;4919;4979.128652485819;4655.162070827284;4893.730844803535;4895.363602731622;4963.354763880709;4989.052080104769;4672.95327046732;4743.857684269477;4748.477667456577;4750.904981900343;4752.59602933751;4676.649251306166;4711.7879695413785;4712.387389639359;4714.057188562301;4719.4100737407825;5230.607704422146;5343.893122137535;5360.3299587551555;5360.9463905360835;5379.327584051994;5640.830775076754;5658.886822263573;5664.858378540528;5665.12190610456;5667.914981275284;5639.351474580435;5699.287589051369;5701.914471282934;5706.743196556165;5711.40030296817;5107.514786095315;5148.588112950955;5276.630635855492;5398.001369746531;5402.297701298885;5829.941700583025;5867.794627188028;5869.941300586939;5880.970595146997;5934.347221805598;5635.0702134147405;5651.124075768263;5651.689157096317;5654.773809047674;5658.660480371191;5388.38033626138;5438.864028399243;5480.451954804487;5574.721263936787;5580.693061881554;5576.609637325349;5579.246801681721;5585.916211256835;5627.746751396197;5634.633748806396;5592.273004509388;5599.468050535193;5600.355959064678;5601.159826026047;5606.747696353674;4190;4234.70357075008;4237.470316210473;4269.4449721536;4300.225959327351;3859.498265225559;3886.1839013806853;3918.52977642679;3923.548791888912;3929.096307849211;5357.062514060024;5377.193420986805;5388.515033646991;5391.973040134774;5413.675179489243;5457.508824205761;5575.358833734173;5708.743106560215;5708.771649133988;5716;5233.5551478124025;5329.227262046981;5330.38700549434;5350.678959262456;5406.324209473816;4864.73243971585;4887.633427492952;4891.559759621651;4900.754962251873;4943.184374578154;5498.670079795225;5871.442212989759;5872.794452194153;5881;5884;5405.027095122916;5557.638753481011;5663.575231857545;5674.971625141848;5749.568782341425;5799.449052340021;5840.123981402823;5843.357230704534;5851.356350801493;5852.853678657897;5575.665460072409;5585.776568937197;5586.16207568868;5587.916181257203;5590.468905453975;5335.33308336458;5446.428125046813;5459.918101228564;5517.200005999188;5526.143447765603;5373.838784836461;5389.56883449331;5391.029614669397;5392.676439413648;5393.6224464287125;5362.195670649434;5373.5432488237375;5376.274202982548;5379.731013449234;5386.865328366822;5317.361916570037;5346.919796203138;5362.678239305654;5365.034293827149;5371.865703357447;5431.185322201702;5438.211459338295;5443.292371991616;5447.210154527651;5448.373437054789;5347.51872331492;5366.141417373202;5388.218708287198;5392.649477783932;5436.592255580927 04:59:07 INFO - PROCESS | 8478 | |1;ext.html;586.1325238646803;598.2850493660076;605.3643674142149;610.2280615021998;626.0952923026226;30210.697893021064;33617.159571010736;33642;43669.34495982555;45362.77318613411;43183.784081079626;43664.3450348245;43679.126417471634;43686.344704829455;43693;8571.871421928676;8756.211940925316;8762.60568274426;8763.12368763125;8766.430182038148;7692.807679808022;7902.683892644287;7907.604619768988;8171.305439037689;8592.183742544448;10286.537105830255;10597.84103238452;10603.310784798963;10969;11050.171237157245;10561.366318020944;10643.361398316125;10650.25448218625;10652.62715804943;10666.78666426667;10458.843117353246;10516.263861529696;10517.894821051768;10524.31591946521;10525.526351314133;40364.394534082014;40552.391714124315;40562.37750489977;40609.39085913714;41018.79490602528;3110.53341998702;3182.299894023311;3211.903642890717;3389.7796643218358;3426.640202778722;29849.25376865574;30200.24499387511;30262.697373026207;31340.529892051636;31692;3726.3851464508325;3763.07804587875;3782.111203867089;3863.961360386388;3909.7458665186673;319337;320812.7309178723;320862;321259.39370303234;321730;32184.83907580447;53881.46118538843;54107;54526.45473545293;54641.726791365785;33082;35070.96683881335;35214.29571408557;35316.823415882754;35524.822375887954;14211;14285.857141428452;14304.141751494735;14314.570562883131;14321.212333321768;12547.811782823264;12715.745685086247;12719.364031798374;12729.68175795594;12736.745265094647;7365.7790266292095;7531.623418829036;7725.922740772633;7980.4812687175145;7996.56018918965;3120.453920563892;3169.0560343115676;3192.632847222599;3195.0734287056493;3225.5000474926424;912.9726108216631;931.38993958957;998.4458625462938;1048.5962904281907;1105.7346236903086;30332.84833575818;30806;30905.84547077295;31237.219069522987;31399.37201255962;1068.7755571329951;1088.4612117001977;1096.3860238266595;1113.9443027848574;1131.63221952864;15351.462698805712;16107.275172617261;16207.270672819752;16460.341586336654;16533.338666453208;495012;503419.4145146327;515011;515839;779972;52862.73568632132;53644;56307;58069;60123.69938150281;1272.8281681972815;1274.9043821713408;1300.518808041031;1308.8167656527903;1328.1300748010262;29325.26686832846;30681.232969175948;30717;31135.37729245357;31483.370332593677;47550;48332;48336.27495587639;48357.27464087971;48371.27443088286;453300;460847;465151;725311;725509;40421.35154457275;40481.797591011855;40539;40932.795336023126;41123;43814;43897.12205755931;45260;45504;45573.77213113913;38187.42718859275;39270.41094383644;39796.80101599474;40022.59977400305;40545.59454405536;37971.43042854304;39575.80212098921;39875.40186897257;39905.201895961334;40522.59477405306;39030.41454378243;39036.41445378265;39046.609533904295;39062.414063789634;39361.21277574375;33078.834605826814;35297;35329;35538.28923421465;35541.46687799633;26441.471170576096;27057.458850823266;27429.72570274272;27544.58683119795;27713 04:59:07 INFO - PROCESS | 8478 | |2;jquery.html;362.68446451587124;371.96466335698113;376.1058653660086;387.4014647369813;407.25269131144347;13952.441902323908;17951;19047;19930.90034549829;20158.092885820137;18371.540711482186;19506.70739938902;19608.41174764756;19670.901645491787;19717.309894153706;5458.890822183554;5757.165211044396;5766.365699773021;5766.884662306751;5768.134779783024;4113.177364527091;4278.572142785728;4332.545082766312;5630.183623374608;6312.558120931537;6321.367863213665;6352.872942541147;6358.268799088118;6368.649724265164;6377.681115944208;6099.359567245442;6274.498040156799;6308.558400911938;6309.558330916838;6364.872702545947;5382;5573.8606534836545;5575.637583557096;5578.748956296977;5582.190582365534;20881.373558793108;21548;22527.436814079778;22941.197058102887;22967.425814354774;1978.732871062417;2073.523089689365;2088.9582208355746;2241.9215327463626;2348;9842.704718858446;10023.298369114093;10074.395536267848;10228.64199753005;10563;1894.4222012286248;1946.1923301829866;1973.2107157137116;1980.8514361422951;2003.1086166655843;79065.60467197685;79868.60065699692;80495.5975220126;81189;81462;9802.36284641496;9913.603455861828;10009.799804004026;10060.647877324258;10089.848652270222;13659.590212293648;13686.452541898212;13689.383977721027;13699.315034248248;13708.93145534286;7367.8158046049275;7387.85224295511;7526.849463010709;7657.655405506765;7819.0617125945255;7441.925580744231;7488.5506869588;7723.343515801107;7756.185600511978;7775.300222979959;4092.6725861930972;4163.12574359388;4237.87286381409;4312.072904325585;4603.125406172817;1680.915954202285;1740.8433241008117;1744.4034967859782;1827.6801559726994;1884.0391400385902;729.68623491899;878.9472631642122;915.7115508614766;950.9809803803885;974.6296407365156;18035.523304047078;19524;19975.700364494543;20003.49991250201;20013.6997945028;880.4629176202511;937.5218638494417;961.9855702164473;971.7327734872825;987.8756192894637;10350.360658032154;11037.724056898642;11061.391623460626;11079.556817727362;11163.665090047312;404112;408242;408364;409124;433556;89653.55173224091;89979.55010224906;90205;90230.54884725665;93934;955.3933252384786;969.3311614985637;983.4345251480428;994.8656931314325;996.4320337407609;16764.748528771834;17132.828671713123;17614.383496577557;17650;17954.102294885466;40067.59932400638;40575.797121014206;40737.59262407338;41504.377434337905;42648;54410.838374242594;54991.725041374535;55018.72490637521;55805.72097139488;56759.71620141873;5772.5959182856795;6069.696515174312;7849.607519623882;8463.857379253968;8741.125887411208;9825.950870245602;12838.935805320914;12897;13085.607431777062;13296;10819.350838949687;10820.675379738306;10883.891161088288;11022.559097636326;11579.710507237387;10342.638007669695;10864.130869530576;11097.611583594859;11403.258788178742;11404.714882128013;11580.768384632429;11839.822402663794;11869.940650296694;11944.761104777683;12300.507979680713;8193.426460147972;8327.583620819056;8349.290310323691;8431.494110353398;8554.786130346542;7532.7740167795055;7892.684292628231;8020.197980201933;8040.959795200986;8168.673253069811 04:59:07 INFO - PROCESS | 8478 | |3;mootools.html;1428.4357678716904;1472.32273154349;1609.7182992976234;1712.143928035982;1764.7705798246227;7343;7618;8064.112947575769;8643.870341944868;8666.696665616704;8093.554854483001;8376.288015518689;8406.369522285822;8605.87091193631;8608.311335093193;2258.254775923941;2280.794728474437;2282.6918366020623;2286.90852365906;2289.107248173214;1885.7737071551433;1956.3837391221791;2193.0898677049004;2220.100859152046;2248.718910136233;2162.9891850540725;2245.932622021334;2259.423846919033;2270.3302525754943;2271.3640180749417;2256.2554357062213;2256.311824893407;2270.6026445371995;2289.0614847912275;2292.79364857162;2224.588451136545;2226.6326056200705;2228.3760547046854;2229.576380487702;2232.4195709115584;8505.192006759347;8612.138786121337;8619.051904290523;8628.784280392978;8637.568121593895;4877.244027175793;5040.924386134211;5044.747762611854;5055.368078990126;5064.772085256172;3069.1406406206297;3196.280836811722;3254.153919980822;3257.951130733041;3277.049655599873;984.4536282363285;1012.2863381316228;1022.7801022780138;1029.0429900192817;1033.6175615022414;11619.477123529461;11671.241369310968;11717.062634989266;11804;11823.11326650496;4098.938515922204;4239.936400953989;4319.222539942841;4422.823087076546;4425.557444255549;10010;10029.648962286285;10041.698749037394;10048.14590759779;10052.145567626687;4792.113459010095;4809.831655892027;4812.302216178705;4824.204006338915;4826.420829500483;4423.712458690175;4426.247537918562;4437.800298986554;4442.267025940748;4447.3773671685985;3559.750817442806;3578.946315805265;3678.4850120983083;3696.9075773105887;3726.9627303727157;1015.3704703084135;1037.7405648587853;1111.360967443723;1115.866096068477;1127.3912087472672;806.733777853307;828.6064119543169;846.9915300847036;875.7241468937265;888.8355654203993;5415.566754659618;5468.863278418072;5481.205225242317;5581.972090139523;5741.339745929272;458.88986643206056;463.20097831241515;472.65968502678015;483.87419270989795;625.7684656677059;3584.874529391459;3733.663970242691;3736.6637002669345;3737.831797569116;3746.8875933722034;10114.595416183418;10388.065074143364;10486.73783155412;10491.895081049091;10495.212859035602;10200.23498237635;10386.324888882198;10403.791924161475;10411.895881041244;10425.165986721044;7818.530888146729;7832.647530861125;7939.761807145795;7940.245676660593;7942.205779422012;5456.809011684572;5465.7813687453645;5485.232067510472;5531.778728850962;5628.774849005994;9201.677941272023;9326.860097098684;9394.577244024173;9404.76488087776;9474.857877131986;9738.707838764849;9744.317897747089;9778.9022109778;9865.112139907444;9885.308028437941;7542.396608271215;7615.504992175491;7695.576743279174;7702.653380597774;7707.34487568563;8211.917880821115;8226.958865205635;8278.213569710868;8279.62741676638;8280.337572994025;7351.742689005859;7450.552966821791;7482.401407887465;7528.661210245443;7582.203868593939;7355.2277010913085;7403.8149046274275;7414.258574142758;7453.142888567884;7488.737894173678;6369.649669268235;6397.4562162216735;6476.931306334402;6482.124913136666;6500.837479063061;4632.559906808848;4665.953340466552;4679.479169269933;4718.268668356411;4759.904801904012;4650.534946505322;4838.685485443435;4866.732329721899;4910;4981.128302547112 04:59:07 INFO - PROCESS | 8478 | |4;prototype.html;312.8107494965546;321.5032774363611;323.5890419167657;323.8898774416698;330.49929357024104;5362.578916587103;5404.864878378043;5409.675419474829;5448.509634132927;5459.617826752129;5067.543921047105;5154.639175257734;5206.817761378353;5264.947350526493;5373.838784836451;4148.191102734968;4149.6887733420035;4150.294449943502;4166.708330416872;4166.708330416872;4138.461999940018;4145.3781932710035;4147.004718867465;4152.3771434284945;4163.417121602978;3829.5978922213185;3924.489816323888;3998.6801055915457;4057.756534607918;4112.362583799516;4089.1821635672686;4097.8565750198895;4101.815418306169;4105.712600117993;4112.444819949298;3612.2661122661007;3626.1841085755495;3626.691731202851;3630.509881166035;3636.3636363636256;5014.598832093424;5128.487151284879;5143.382794064736;5163.845084647466;5184.7446360833155;4711.411073615798;4715.7877895494785;4727.409073865767;4732.219183834663;4744.624059022879;5489.835304940818;5493.313335833021;5497.835064948058;5504.4770746778995;5513.50378465936;3944.5858184890462;4002.239574480839;4003.739756915791;4005.379166229239;4044.503533692523;5682.943170568283;5684.4315568443235;5688.345840228385;5694.202811606337;5700.631848356365;4121.1345617420675;4123.97938010308;4127.607877251657;4131.855385061569;4145.067359844072;4070.4097905804083;4133.937990930139;4199.790010499462;4200.222958752641;4205.705600607928;4640.907181856412;4667.766611669403;4682.367880336111;4691.132140554008;4703.717776933395;5506.366767821672;5514.6691198528215;5532.889342213214;5535.889282214333;5556.944430555724;1406.5288128477075;1440.7910852926268;1447.1534152520683;1462.1738717624507;1464.2971373740663;937.3485427627869;955.603424578806;961.8509131084693;962.8590120706984;966.7728083900278;4555.703879247838;4800.831970881002;4800.903981920342;4810.99999999993;4869.9513004870205;5015.648904576645;5020.849374518771;5025.366755804305;5027.924581131286;5035.723035233097;4748.6675932685075;4756.262779269219;4762.214234651244;4766.952330476651;4767.427908650984;2678.718734532885;2690.636764036869;2700.3654141276784;2700.7839372850126;2869.684334723179;5895.233619629421;5903.845096539818;5912.733926973297;5928.170056192136;5932.7330270137945;5804.3167481430755;5804.5356371491025;5823.505002074787;5843.970780146072;5859.912101318484;5693.206639908416;5873.647581145145;5888.116782482662;5920.644761314335;5925.34821169671;5701.315842098975;5713.628614140068;5725.969325521446;5728.455796699307;5745;5447.155690867922;5648.265725455664;5678.2050512929045;5691.943080569141;5703.828885133453;5821.854453638693;5854.2389489367815;5864.67744274069;5867.618604790675;5867.647941123546;4091.897702557341;4140.399642051825;4148.730332528376;4153.8961525962095;4159.1265834175165;5433.723075077432;5543.528800051879;5589.293025963417;5727.339071669336;5772.451617096369;5596.636218645775;5602.0196465619165;5603.8792241552665;5623.2408624835125;5628.718564071698;5342.412334643109;5599.564189577547;5605.178317046894;5608.327000759935;5632;5572.916406253828;5600.551955843604;5604.943950560605;5609.887802244014;5612.652963288863;5630.465105814941;5640.689762063126;5646.3506696728755;5649.802256920988;5675.347335056356;5227.451117632594;5466.426025267289;5490;5528.806491772769;5571.387147413862 04:59:07 INFO - PROCESS | 8478 | |5;yui.html;622.5237693164728;644.983875403115;664.8637029408966;686.9352503619389;726.9709211631535;14640.780388294184;15125.16811575363;15269.847301526981;15656;15757.684846303067;13452.730945381087;13727.107737997023;13786.793198102036;13822.723545529083;13844.723105537883;796.8844517544967;815.9306458950996;817.0685418622775;817.9672813087469;818.2063398503471;667.349334398962;685.4413652872918;780.6955287437876;799.6441583495347;806.4757907360204;849.5072857742495;851.8381507513584;852.2627926843298;858.52351944671;860.7675927499571;854.3763052971366;855.3371137368526;855.9828803423928;856.019857263433;856.0668870930684;504.03477340892147;516.4267662894184;521.7573828169881;521.7756364763151;605.1044454207753;13684.315784210849;14286.928565357211;14329.570112896525;14346.42614295427;14360.784588231185;13530.797038044437;13763.655908602264;14166.787498187536;14633.853661463461;14796.556103316918;11095.72260693481;11151.485148514852;11196.720081997933;11332.716682082932;11424.885751142549;4449.977750111261;4457.264551349056;4463.285874260136;4515.187266292066;4516.977415112936;61911;64039;64499.67750161266;70275;74167.99999999946;11275.379854108103;11553.768924621461;11637.941810290895;11787.587434439753;11804.52781888732;21056.473588160417;21142.15431382758;21219.363419097142;21331.78668213298;21748.347549573537;7646.617669116522;7840.725574604861;7859.960700196577;7887.44787864844;7943.364530837519;4543.227651299287;4598.793054312497;4683.320918466803;4807.326974223612;4890.315355850184;3278.278778668737;3377.037544299912;3382.5940887093707;3384.526166336715;3384.6953774160443;601.3475379213602;616.4236438929615;625.1903784598956;627.8179327994831;629.8586791843646;543.7879227101433;551.8537587539305;591.8549955260903;701.9227884932653;720.8558288342248;9283.675071372605;9339.486328252011;9406.153446189739;9437.245020398352;9598;544.1231227504034;563.1833840930667;586.633354153654;679.2460368990417;706.3254591864757;4391.1563279363345;4407.316865885793;4437.622802061861;4447.73313601185;4478.216312145361;100172.49913750385;107304;109215;110197;110786;55595.722021389636;73134;94419.52790236143;94800;97998.10009499497;50143.49856501461;53129;75285;81254;82792.75810862842;8665.480071195749;8907.643694252158;8945.19493245585;9308.767280818034;9533.904660953302;49072;51356.22965655593;51441.742791285804;51672.22491662553;53323;69172.3082769186;69593.65203173952;73463.63268183624;75112;75895.62052189704;11810.409479525817;12013.81979270329;12638.304893230961;12667.556635517712;12713.364331783188;11985.34080625574;12234.510619575118;12287.447064881922;13298.069135160446;13302.334883255991;12130.757384852077;12863.614091577268;12953.805692914802;13293.933530332286;13752.93123534376;10577;12913.289769062792;13556.661083472993;13578.388972496065;14037.859621403655;11949.103817213918;12352.444140013542;12369.319687417279;13043.478260869459;13221.140625859289;10479;10655.467226638792;10712.785744284914;10741.838872416763;11265.211435199457;9762.75593110178;9931.602735890483;10148.23888208402;10227.7443063924;10228.48857557134 04:59:07 INFO - PROCESS | 8478 | __end_tp_report 04:59:07 INFO - PROCESS | 8478 | __start_cc_report 04:59:07 INFO - PROCESS | 8478 | _x_x_mozilla_cycle_collect,2484 04:59:07 INFO - PROCESS | 8478 | __end_cc_report 04:59:07 INFO - PROCESS | 8478 | __startTimestamp1476878347890__endTimestamp 04:59:07 INFO - PROCESS | 8478 | 04:59:07 INFO - PROCESS | 8478 | ------- Summary: start ------- 04:59:07 INFO - PROCESS | 8478 | Number of tests: 6 04:59:07 INFO - PROCESS | 8478 | 04:59:07 INFO - PROCESS | 8478 | [#0] dojo.html Cycles:165 Average:5227.24 Median:5388.52 stddev:584.23 (10.8%) stddev-sans-first:560.76 04:59:07 INFO - PROCESS | 8478 | Values: 3061.0 3088.3 3091.3 3109.4 3142.4 5092.1 5176.7 5289.4 5359.2 5385.7 5229.0 5262.6 5409.1 5417.9 5472.6 4702.9 4720.9 4778.9 4810.1 4820.3 4812.9 4825.0 4912.2 4919.0 4979.1 4655.2 4893.7 4895.4 4963.4 4989.1 4673.0 4743.9 4748.5 4750.9 4752.6 4676.6 4711.8 4712.4 4714.1 4719.4 5230.6 5343.9 5360.3 5360.9 5379.3 5640.8 5658.9 5664.9 5665.1 5667.9 5639.4 5699.3 5701.9 5706.7 5711.4 5107.5 5148.6 5276.6 5398.0 5402.3 5829.9 5867.8 5869.9 5881.0 5934.3 5635.1 5651.1 5651.7 5654.8 5658.7 5388.4 5438.9 5480.5 5574.7 5580.7 5576.6 5579.2 5585.9 5627.7 5634.6 5592.3 5599.5 5600.4 5601.2 5606.7 4190.0 4234.7 4237.5 4269.4 4300.2 3859.5 3886.2 3918.5 3923.5 3929.1 5357.1 5377.2 5388.5 5392.0 5413.7 5457.5 5575.4 5708.7 5708.8 5716.0 5233.6 5329.2 5330.4 5350.7 5406.3 4864.7 4887.6 4891.6 4900.8 4943.2 5498.7 5871.4 5872.8 5881.0 5884.0 5405.0 5557.6 5663.6 5675.0 5749.6 5799.4 5840.1 5843.4 5851.4 5852.9 5575.7 5585.8 5586.2 5587.9 5590.5 5335.3 5446.4 5459.9 5517.2 5526.1 5373.8 5389.6 5391.0 5392.7 5393.6 5362.2 5373.5 5376.3 5379.7 5386.9 5317.4 5346.9 5362.7 5365.0 5371.9 5431.2 5438.2 5443.3 5447.2 5448.4 5347.5 5366.1 5388.2 5392.6 5436.6 04:59:07 INFO - PROCESS | 8478 | 04:59:07 INFO - PROCESS | 8478 | [#1] ext.html Cycles:180 Average:61977.90 Median:19633.93 stddev:135590.17 (690.6%) stddev-sans-first:135892.19 04:59:07 INFO - PROCESS | 8478 | Values: 586.1 598.3 605.4 610.2 626.1 30210.7 33617.2 33642.0 43669.3 45362.8 43183.8 43664.3 43679.1 43686.3 43693.0 8571.9 8756.2 8762.6 8763.1 8766.4 7692.8 7902.7 7907.6 8171.3 8592.2 10286.5 10597.8 10603.3 10969.0 11050.2 10561.4 10643.4 10650.3 10652.6 10666.8 10458.8 10516.3 10517.9 10524.3 10525.5 40364.4 40552.4 40562.4 40609.4 41018.8 3110.5 3182.3 3211.9 3389.8 3426.6 29849.3 30200.2 30262.7 31340.5 31692.0 3726.4 3763.1 3782.1 3864.0 3909.7 319337.0 320812.7 320862.0 321259.4 321730.0 32184.8 53881.5 54107.0 54526.5 54641.7 33082.0 35071.0 35214.3 35316.8 35524.8 14211.0 14285.9 14304.1 14314.6 14321.2 12547.8 12715.7 12719.4 12729.7 12736.7 7365.8 7531.6 7725.9 7980.5 7996.6 3120.5 3169.1 3192.6 3195.1 3225.5 913.0 931.4 998.4 1048.6 1105.7 30332.8 30806.0 30905.8 31237.2 31399.4 1068.8 1088.5 1096.4 1113.9 1131.6 15351.5 16107.3 16207.3 16460.3 16533.3 495012.0 503419.4 515011.0 515839.0 779972.0 52862.7 53644.0 56307.0 58069.0 60123.7 1272.8 1274.9 1300.5 1308.8 1328.1 29325.3 30681.2 30717.0 31135.4 31483.4 47550.0 48332.0 48336.3 48357.3 48371.3 453300.0 460847.0 465151.0 725311.0 725509.0 40421.4 40481.8 40539.0 40932.8 41123.0 43814.0 43897.1 45260.0 45504.0 45573.8 38187.4 39270.4 39796.8 40022.6 40545.6 37971.4 39575.8 39875.4 39905.2 40522.6 39030.4 39036.4 39046.6 39062.4 39361.2 33078.8 35297.0 35329.0 35538.3 35541.5 26441.5 27057.5 27429.7 27544.6 27713.0 04:59:07 INFO - PROCESS | 8478 | 04:59:07 INFO - PROCESS | 8478 | [#2] jquery.html Cycles:180 Average:26367.16 Median:22833.75 stddev:68566.32 (300.3%) stddev-sans-first:68730.86 04:59:07 INFO - PROCESS | 8478 | Values: 362.7 372.0 376.1 387.4 407.3 13952.4 17951.0 19047.0 19930.9 20158.1 18371.5 19506.7 19608.4 19670.9 19717.3 5458.9 5757.2 5766.4 5766.9 5768.1 4113.2 4278.6 4332.5 5630.2 6312.6 6321.4 6352.9 6358.3 6368.6 6377.7 6099.4 6274.5 6308.6 6309.6 6364.9 5382.0 5573.9 5575.6 5578.7 5582.2 20881.4 21548.0 22527.4 22941.2 22967.4 1978.7 2073.5 2089.0 2241.9 2348.0 9842.7 10023.3 10074.4 10228.6 10563.0 1894.4 1946.2 1973.2 1980.9 2003.1 79065.6 79868.6 80495.6 81189.0 81462.0 9802.4 9913.6 10009.8 10060.6 10089.8 13659.6 13686.5 13689.4 13699.3 13708.9 7367.8 7387.9 7526.8 7657.7 7819.1 7441.9 7488.6 7723.3 7756.2 7775.3 4092.7 4163.1 4237.9 4312.1 4603.1 1680.9 1740.8 1744.4 1827.7 1884.0 729.7 878.9 915.7 951.0 974.6 18035.5 19524.0 19975.7 20003.5 20013.7 880.5 937.5 962.0 971.7 987.9 10350.4 11037.7 11061.4 11079.6 11163.7 404112.0 408242.0 408364.0 409124.0 433556.0 89653.6 89979.6 90205.0 90230.5 93934.0 955.4 969.3 983.4 994.9 996.4 16764.7 17132.8 17614.4 17650.0 17954.1 40067.6 40575.8 40737.6 41504.4 42648.0 54410.8 54991.7 55018.7 55805.7 56759.7 5772.6 6069.7 7849.6 8463.9 8741.1 9826.0 12838.9 12897.0 13085.6 13296.0 10819.4 10820.7 10883.9 11022.6 11579.7 10342.6 10864.1 11097.6 11403.3 11404.7 11580.8 11839.8 11869.9 11944.8 12300.5 8193.4 8327.6 8349.3 8431.5 8554.8 7532.8 7892.7 8020.2 8041.0 8168.7 04:59:07 INFO - PROCESS | 8478 | 04:59:07 INFO - PROCESS | 8478 | [#3] mootools.html Cycles:180 Average:5494.95 Median:2595.46 stddev:3186.31 (122.8%) stddev-sans-first:3180.59 04:59:07 INFO - PROCESS | 8478 | Values: 1428.4 1472.3 1609.7 1712.1 1764.8 7343.0 7618.0 8064.1 8643.9 8666.7 8093.6 8376.3 8406.4 8605.9 8608.3 2258.3 2280.8 2282.7 2286.9 2289.1 1885.8 1956.4 2193.1 2220.1 2248.7 2163.0 2245.9 2259.4 2270.3 2271.4 2256.3 2256.3 2270.6 2289.1 2292.8 2224.6 2226.6 2228.4 2229.6 2232.4 8505.2 8612.1 8619.1 8628.8 8637.6 4877.2 5040.9 5044.7 5055.4 5064.8 3069.1 3196.3 3254.2 3258.0 3277.0 984.5 1012.3 1022.8 1029.0 1033.6 11619.5 11671.2 11717.1 11804.0 11823.1 4098.9 4239.9 4319.2 4422.8 4425.6 10010.0 10029.6 10041.7 10048.1 10052.1 4792.1 4809.8 4812.3 4824.2 4826.4 4423.7 4426.2 4437.8 4442.3 4447.4 3559.8 3578.9 3678.5 3696.9 3727.0 1015.4 1037.7 1111.4 1115.9 1127.4 806.7 828.6 847.0 875.7 888.8 5415.6 5468.9 5481.2 5582.0 5741.3 458.9 463.2 472.7 483.9 625.8 3584.9 3733.7 3736.7 3737.8 3746.9 10114.6 10388.1 10486.7 10491.9 10495.2 10200.2 10386.3 10403.8 10411.9 10425.2 7818.5 7832.6 7939.8 7940.2 7942.2 5456.8 5465.8 5485.2 5531.8 5628.8 9201.7 9326.9 9394.6 9404.8 9474.9 9738.7 9744.3 9778.9 9865.1 9885.3 7542.4 7615.5 7695.6 7702.7 7707.3 8211.9 8227.0 8278.2 8279.6 8280.3 7351.7 7450.6 7482.4 7528.7 7582.2 7355.2 7403.8 7414.3 7453.1 7488.7 6369.6 6397.5 6476.9 6482.1 6500.8 4632.6 4666.0 4679.5 4718.3 4759.9 4650.5 4838.7 4866.7 4910.0 4981.1 04:59:07 INFO - PROCESS | 8478 | 04:59:07 INFO - PROCESS | 8478 | [#4] prototype.html Cycles:180 Average:4628.75 Median:5174.29 stddev:1368.43 (26.4%) stddev-sans-first:1333.37 04:59:07 INFO - PROCESS | 8478 | Values: 312.8 321.5 323.6 323.9 330.5 5362.6 5404.9 5409.7 5448.5 5459.6 5067.5 5154.6 5206.8 5264.9 5373.8 4148.2 4149.7 4150.3 4166.7 4166.7 4138.5 4145.4 4147.0 4152.4 4163.4 3829.6 3924.5 3998.7 4057.8 4112.4 4089.2 4097.9 4101.8 4105.7 4112.4 3612.3 3626.2 3626.7 3630.5 3636.4 5014.6 5128.5 5143.4 5163.8 5184.7 4711.4 4715.8 4727.4 4732.2 4744.6 5489.8 5493.3 5497.8 5504.5 5513.5 3944.6 4002.2 4003.7 4005.4 4044.5 5682.9 5684.4 5688.3 5694.2 5700.6 4121.1 4124.0 4127.6 4131.9 4145.1 4070.4 4133.9 4199.8 4200.2 4205.7 4640.9 4667.8 4682.4 4691.1 4703.7 5506.4 5514.7 5532.9 5535.9 5556.9 1406.5 1440.8 1447.2 1462.2 1464.3 937.3 955.6 961.9 962.9 966.8 4555.7 4800.8 4800.9 4811.0 4870.0 5015.6 5020.8 5025.4 5027.9 5035.7 4748.7 4756.3 4762.2 4767.0 4767.4 2678.7 2690.6 2700.4 2700.8 2869.7 5895.2 5903.8 5912.7 5928.2 5932.7 5804.3 5804.5 5823.5 5844.0 5859.9 5693.2 5873.6 5888.1 5920.6 5925.3 5701.3 5713.6 5726.0 5728.5 5745.0 5447.2 5648.3 5678.2 5691.9 5703.8 5821.9 5854.2 5864.7 5867.6 5867.6 4091.9 4140.4 4148.7 4153.9 4159.1 5433.7 5543.5 5589.3 5727.3 5772.5 5596.6 5602.0 5603.9 5623.2 5628.7 5342.4 5599.6 5605.2 5608.3 5632.0 5572.9 5600.6 5604.9 5609.9 5612.7 5630.5 5640.7 5646.4 5649.8 5675.3 5227.5 5466.4 5490.0 5528.8 5571.4 04:59:07 INFO - PROCESS | 8478 | 04:59:07 INFO - PROCESS | 8478 | [#5] yui.html Cycles:180 Average:19049.01 Median:4745.32 stddev:26901.12 (566.9%) stddev-sans-first:26941.00 04:59:07 INFO - PROCESS | 8478 | Values: 622.5 645.0 664.9 686.9 727.0 14640.8 15125.2 15269.8 15656.0 15757.7 13452.7 13727.1 13786.8 13822.7 13844.7 796.9 815.9 817.1 818.0 818.2 667.3 685.4 780.7 799.6 806.5 849.5 851.8 852.3 858.5 860.8 854.4 855.3 856.0 856.0 856.1 504.0 516.4 521.8 521.8 605.1 13684.3 14286.9 14329.6 14346.4 14360.8 13530.8 13763.7 14166.8 14633.9 14796.6 11095.7 11151.5 11196.7 11332.7 11424.9 4450.0 4457.3 4463.3 4515.2 4517.0 61911.0 64039.0 64499.7 70275.0 74168.0 11275.4 11553.8 11637.9 11787.6 11804.5 21056.5 21142.2 21219.4 21331.8 21748.3 7646.6 7840.7 7860.0 7887.4 7943.4 4543.2 4598.8 4683.3 4807.3 4890.3 3278.3 3377.0 3382.6 3384.5 3384.7 601.3 616.4 625.2 627.8 629.9 543.8 551.9 591.9 701.9 720.9 9283.7 9339.5 9406.2 9437.2 9598.0 544.1 563.2 586.6 679.2 706.3 4391.2 4407.3 4437.6 4447.7 4478.2 100172.5 107304.0 109215.0 110197.0 110786.0 55595.7 73134.0 94419.5 94800.0 97998.1 50143.5 53129.0 75285.0 81254.0 82792.8 8665.5 8907.6 8945.2 9308.8 9533.9 49072.0 51356.2 51441.7 51672.2 53323.0 69172.3 69593.7 73463.6 75112.0 75895.6 11810.4 12013.8 12638.3 12667.6 12713.4 11985.3 12234.5 12287.4 13298.1 13302.3 12130.8 12863.6 12953.8 13293.9 13752.9 10577.0 12913.3 13556.7 13578.4 14037.9 11949.1 12352.4 12369.3 13043.5 13221.1 10479.0 10655.5 10712.8 10741.8 11265.2 9762.8 9931.6 10148.2 10227.7 10228.5 04:59:07 INFO - PROCESS | 8478 | -------- Summary: end -------- 04:59:07 INFO - PROCESS | 8478 | 04:59:08 INFO - TEST-INFO | 8478: exit 0 04:59:08 INFO - TEST-OK | dromaeo_css | took 1117924ms 04:59:08 INFO - TEST-START | kraken 04:59:08 INFO - operating with platform_type : linux_ 04:59:08 INFO - Initialising browser for kraken test... 04:59:08 INFO - TEST-INFO | started process 8789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps5h1Km/profile http://localhost:58089/getInfo.html) 04:59:12 INFO - PROCESS | 8789 | __metrics Screen width/height:1600/1200 04:59:12 INFO - PROCESS | 8789 | colorDepth:24 04:59:12 INFO - PROCESS | 8789 | Browser inner width/height: 1024/697 04:59:12 INFO - PROCESS | 8789 | __metrics 04:59:13 INFO - PROCESS | 8789 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:59:13 INFO - PROCESS | 8789 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:59:13 INFO - PROCESS | 8789 | console.error: PushService: 04:59:13 INFO - PROCESS | 8789 | stateChangeProcessEnqueue: Error transitioning state 04:59:13 INFO - PROCESS | 8789 | UnknownError 04:59:14 INFO - TEST-INFO | 8789: exit 0 04:59:14 INFO - Browser initialized. 04:59:14 INFO - Running cycle 1/1 for kraken test... 04:59:14 INFO - TEST-INFO | started process 8872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps5h1Km/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:59:26 INFO - PROCESS | 8872 | RSS: Main: 171814912 04:59:26 INFO - PROCESS | 8872 | 04:59:29 INFO - PROCESS | 8872 | Cycle 1(1): loaded http://localhost:58089/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58089/tests/kraken/driver.html?testName=audio-beat-detection) 04:59:30 INFO - PROCESS | 8872 | RSS: Main: 228913152 04:59:30 INFO - PROCESS | 8872 | 04:59:32 INFO - PROCESS | 8872 | Cycle 1(1): loaded http://localhost:58089/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58089/tests/kraken/driver.html?testName=audio-dft) 04:59:33 INFO - PROCESS | 8872 | RSS: Main: 215695360 04:59:33 INFO - PROCESS | 8872 | 04:59:36 INFO - PROCESS | 8872 | Cycle 1(1): loaded http://localhost:58089/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58089/tests/kraken/driver.html?testName=audio-fft) 04:59:36 INFO - PROCESS | 8872 | RSS: Main: 297156608 04:59:36 INFO - PROCESS | 8872 | 04:59:39 INFO - PROCESS | 8872 | Cycle 1(1): loaded http://localhost:58089/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58089/tests/kraken/driver.html?testName=audio-oscillator) 04:59:39 INFO - PROCESS | 8872 | RSS: Main: 206381056 04:59:39 INFO - PROCESS | 8872 | 04:59:41 INFO - PROCESS | 8872 | Cycle 1(1): loaded http://localhost:58089/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58089/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:59:42 INFO - PROCESS | 8872 | RSS: Main: 211664896 04:59:42 INFO - PROCESS | 8872 | 04:59:45 INFO - PROCESS | 8872 | Cycle 1(1): loaded http://localhost:58089/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58089/tests/kraken/driver.html?testName=imaging-darkroom) 04:59:45 INFO - PROCESS | 8872 | RSS: Main: 247357440 04:59:45 INFO - PROCESS | 8872 | 04:59:49 INFO - PROCESS | 8872 | Cycle 1(1): loaded http://localhost:58089/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58089/tests/kraken/driver.html?testName=imaging-desaturate) 04:59:49 INFO - PROCESS | 8872 | RSS: Main: 246157312 04:59:49 INFO - PROCESS | 8872 | 04:59:52 INFO - PROCESS | 8872 | Cycle 1(1): loaded http://localhost:58089/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58089/tests/kraken/driver.html?testName=json-parse-financial) 04:59:53 INFO - PROCESS | 8872 | RSS: Main: 246292480 04:59:53 INFO - PROCESS | 8872 | 04:59:54 INFO - PROCESS | 8872 | Cycle 1(1): loaded http://localhost:58089/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58089/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:59:55 INFO - PROCESS | 8872 | RSS: Main: 208498688 04:59:55 INFO - PROCESS | 8872 | 04:59:56 INFO - PROCESS | 8872 | Cycle 1(1): loaded http://localhost:58089/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58089/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:59:57 INFO - PROCESS | 8872 | RSS: Main: 216559616 04:59:57 INFO - PROCESS | 8872 | 04:59:59 INFO - PROCESS | 8872 | Cycle 1(1): loaded http://localhost:58089/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58089/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:00:00 INFO - PROCESS | 8872 | RSS: Main: 225734656 05:00:00 INFO - PROCESS | 8872 | 05:00:02 INFO - PROCESS | 8872 | Cycle 1(1): loaded http://localhost:58089/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58089/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:00:03 INFO - PROCESS | 8872 | RSS: Main: 234627072 05:00:03 INFO - PROCESS | 8872 | 05:00:06 INFO - PROCESS | 8872 | Cycle 1(1): loaded http://localhost:58089/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58089/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:00:06 INFO - PROCESS | 8872 | RSS: Main: 231153664 05:00:06 INFO - PROCESS | 8872 | 05:00:08 INFO - PROCESS | 8872 | Cycle 1(1): loaded http://localhost:58089/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58089/tests/kraken/driver.html?testName=ai-astar) 05:00:08 INFO - PROCESS | 8872 | RSS: Main: 281944064 05:00:08 INFO - PROCESS | 8872 | 05:00:08 INFO - PROCESS | 8872 | __start_tp_report 05:00:08 INFO - PROCESS | 8872 | _x_x_mozilla_page_load 05:00:08 INFO - PROCESS | 8872 | _x_x_mozilla_page_load_details 05:00:08 INFO - PROCESS | 8872 | |i|pagename|runs| 05:00:08 INFO - PROCESS | 8872 | |0;ai-astar;106;113;111;112;114;114;115;115;112;112 05:00:08 INFO - PROCESS | 8872 | |1;audio-beat-detection;151;122;124;157;126;123;123;119;147;119 05:00:08 INFO - PROCESS | 8872 | |2;audio-dft;161;161;160;161;159;162;167;161;161;160 05:00:08 INFO - PROCESS | 8872 | |3;audio-fft;75;74;74;110;75;75;76;75;97;75 05:00:08 INFO - PROCESS | 8872 | |4;audio-oscillator;83;82;106;82;83;82;113;82;81;117 05:00:08 INFO - PROCESS | 8872 | |5;imaging-gaussian-blur;117;116;117;116;117;117;116;117;117;116 05:00:08 INFO - PROCESS | 8872 | |6;imaging-darkroom;146;146;147;145;145;146;148;146;146;146 05:00:08 INFO - PROCESS | 8872 | |7;imaging-desaturate;85;84;84;85;85;84;84;85;85;84 05:00:08 INFO - PROCESS | 8872 | |8;json-parse-financial;52;51;52;50;51;52;52;52;52;53 05:00:08 INFO - PROCESS | 8872 | |9;json-stringify-tinderbox;59;59;59;59;59;59;58;59;59;59 05:00:08 INFO - PROCESS | 8872 | |10;stanford-crypto-aes;80;80;79;79;78;81;79;79;78;79 05:00:08 INFO - PROCESS | 8872 | |11;stanford-crypto-ccm;131;133;133;128;138;128;129;128;173;131 05:00:08 INFO - PROCESS | 8872 | |12;stanford-crypto-pbkdf2;167;166;163;164;161;163;162;164;163;164 05:00:08 INFO - PROCESS | 8872 | |13;stanford-crypto-sha256-iterative;65;67;67;65;67;72;65;67;64;65 05:00:08 INFO - PROCESS | 8872 | __end_tp_report 05:00:08 INFO - PROCESS | 8872 | __start_cc_report 05:00:08 INFO - PROCESS | 8872 | _x_x_mozilla_cycle_collect,1677 05:00:08 INFO - PROCESS | 8872 | __end_cc_report 05:00:08 INFO - PROCESS | 8872 | __startTimestamp1476878408719__endTimestamp 05:00:08 INFO - PROCESS | 8872 | 05:00:08 INFO - PROCESS | 8872 | ------- Summary: start ------- 05:00:08 INFO - PROCESS | 8872 | Number of tests: 14 05:00:08 INFO - PROCESS | 8872 | 05:00:08 INFO - PROCESS | 8872 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.50 stddev:2.63 (2.3%) stddev-sans-first:1.45 05:00:08 INFO - PROCESS | 8872 | Values: 106.0 113.0 111.0 112.0 114.0 114.0 115.0 115.0 112.0 112.0 05:00:08 INFO - PROCESS | 8872 | 05:00:08 INFO - PROCESS | 8872 | [#1] audio-beat-detection Cycles:10 Average:131.10 Median:125.00 stddev:14.54 (11.6%) stddev-sans-first:13.52 05:00:08 INFO - PROCESS | 8872 | Values: 151.0 122.0 124.0 157.0 126.0 123.0 123.0 119.0 147.0 119.0 05:00:08 INFO - PROCESS | 8872 | 05:00:08 INFO - PROCESS | 8872 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:2.16 (1.3%) stddev-sans-first:2.29 05:00:08 INFO - PROCESS | 8872 | Values: 161.0 161.0 160.0 161.0 159.0 162.0 167.0 161.0 161.0 160.0 05:00:08 INFO - PROCESS | 8872 | 05:00:08 INFO - PROCESS | 8872 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.00 stddev:12.47 (16.6%) stddev-sans-first:13.06 05:00:08 INFO - PROCESS | 8872 | Values: 75.0 74.0 74.0 110.0 75.0 75.0 76.0 75.0 97.0 75.0 05:00:08 INFO - PROCESS | 8872 | 05:00:08 INFO - PROCESS | 8872 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:82.00 stddev:14.67 (17.9%) stddev-sans-first:15.26 05:00:08 INFO - PROCESS | 8872 | Values: 83.0 82.0 106.0 82.0 83.0 82.0 113.0 82.0 81.0 117.0 05:00:08 INFO - PROCESS | 8872 | 05:00:08 INFO - PROCESS | 8872 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:00:08 INFO - PROCESS | 8872 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 05:00:08 INFO - PROCESS | 8872 | 05:00:08 INFO - PROCESS | 8872 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 05:00:08 INFO - PROCESS | 8872 | Values: 146.0 146.0 147.0 145.0 145.0 146.0 148.0 146.0 146.0 146.0 05:00:08 INFO - PROCESS | 8872 | 05:00:08 INFO - PROCESS | 8872 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 05:00:08 INFO - PROCESS | 8872 | Values: 85.0 84.0 84.0 85.0 85.0 84.0 84.0 85.0 85.0 84.0 05:00:08 INFO - PROCESS | 8872 | 05:00:08 INFO - PROCESS | 8872 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:0.82 (1.6%) stddev-sans-first:0.87 05:00:08 INFO - PROCESS | 8872 | Values: 52.0 51.0 52.0 50.0 51.0 52.0 52.0 52.0 52.0 53.0 05:00:08 INFO - PROCESS | 8872 | 05:00:08 INFO - PROCESS | 8872 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 05:00:08 INFO - PROCESS | 8872 | Values: 59.0 59.0 59.0 59.0 59.0 59.0 58.0 59.0 59.0 59.0 05:00:08 INFO - PROCESS | 8872 | 05:00:08 INFO - PROCESS | 8872 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.00 stddev:0.92 (1.2%) stddev-sans-first:0.93 05:00:08 INFO - PROCESS | 8872 | Values: 80.0 80.0 79.0 79.0 78.0 81.0 79.0 79.0 78.0 79.0 05:00:08 INFO - PROCESS | 8872 | 05:00:08 INFO - PROCESS | 8872 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:132.00 stddev:13.64 (10.3%) stddev-sans-first:14.39 05:00:08 INFO - PROCESS | 8872 | Values: 131.0 133.0 133.0 128.0 138.0 128.0 129.0 128.0 173.0 131.0 05:00:08 INFO - PROCESS | 8872 | 05:00:08 INFO - PROCESS | 8872 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.70 Median:164.00 stddev:1.77 (1.1%) stddev-sans-first:1.41 05:00:08 INFO - PROCESS | 8872 | Values: 167.0 166.0 163.0 164.0 161.0 163.0 162.0 164.0 163.0 164.0 05:00:08 INFO - PROCESS | 8872 | 05:00:08 INFO - PROCESS | 8872 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:2.27 (3.4%) stddev-sans-first:2.35 05:00:08 INFO - PROCESS | 8872 | Values: 65.0 67.0 67.0 65.0 67.0 72.0 65.0 67.0 64.0 65.0 05:00:08 INFO - PROCESS | 8872 | -------- Summary: end -------- 05:00:08 INFO - PROCESS | 8872 | 05:00:09 INFO - TEST-INFO | 8872: exit 0 05:00:09 INFO - TEST-OK | kraken | took 61176ms 05:00:09 INFO - SUITE-END | took 1179s 05:00:10 INFO - Completed test suite (00:19:39) 05:00:10 INFO - javascript benchmark 05:00:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3060.969390306097, 3088.2588178837086, 3091.2890035291884, 3109.4247564200637, 3142.3715256948603, 5092.134337162682, 5176.66351687141, 5289.391719952207, 5359.222912677665, 5385.676859388434, 5229.032628963644, 5262.578993680506, 5409.134538473845, 5417.864553386167, 5472.616916815825, 4702.929456058145, 4720.858374248778, 4778.928316075262, 4810.110129626013, 4820.301056346828, 4812.855614331558, 4825.0, 4912.189488734354, 4919.0, 4979.128652485819, 4655.162070827284, 4893.730844803535, 4895.363602731622, 4963.354763880709, 4989.052080104769, 4672.95327046732, 4743.857684269477, 4748.477667456577, 4750.904981900343, 4752.59602933751, 4676.649251306166, 4711.7879695413785, 4712.387389639359, 4714.057188562301, 4719.4100737407825, 5230.607704422146, 5343.893122137535, 5360.3299587551555, 5360.9463905360835, 5379.327584051994, 5640.830775076754, 5658.886822263573, 5664.858378540528, 5665.12190610456, 5667.914981275284, 5639.351474580435, 5699.287589051369, 5701.914471282934, 5706.743196556165, 5711.40030296817, 5107.514786095315, 5148.588112950955, 5276.630635855492, 5398.001369746531, 5402.297701298885, 5829.941700583025, 5867.794627188028, 5869.941300586939, 5880.970595146997, 5934.347221805598, 5635.0702134147405, 5651.124075768263, 5651.689157096317, 5654.773809047674, 5658.660480371191, 5388.38033626138, 5438.864028399243, 5480.451954804487, 5574.721263936787, 5580.693061881554, 5576.609637325349, 5579.246801681721, 5585.916211256835, 5627.746751396197, 5634.633748806396, 5592.273004509388, 5599.468050535193, 5600.355959064678, 5601.159826026047, 5606.747696353674, 4190.0, 4234.70357075008, 4237.470316210473, 4269.4449721536, 4300.225959327351, 3859.498265225559, 3886.1839013806853, 3918.52977642679, 3923.548791888912, 3929.096307849211, 5357.062514060024, 5377.193420986805, 5388.515033646991, 5391.973040134774, 5413.675179489243, 5457.508824205761, 5575.358833734173, 5708.743106560215, 5708.771649133988, 5716.0, 5233.5551478124025, 5329.227262046981, 5330.38700549434, 5350.678959262456, 5406.324209473816, 4864.73243971585, 4887.633427492952, 4891.559759621651, 4900.754962251873, 4943.184374578154, 5498.670079795225, 5871.442212989759, 5872.794452194153, 5881.0, 5884.0, 5405.027095122916, 5557.638753481011, 5663.575231857545, 5674.971625141848, 5749.568782341425, 5799.449052340021, 5840.123981402823, 5843.357230704534, 5851.356350801493, 5852.853678657897, 5575.665460072409, 5585.776568937197, 5586.16207568868, 5587.916181257203, 5590.468905453975, 5335.33308336458, 5446.428125046813, 5459.918101228564, 5517.200005999188, 5526.143447765603, 5373.838784836461, 5389.56883449331, 5391.029614669397, 5392.676439413648, 5393.6224464287125, 5362.195670649434, 5373.5432488237375, 5376.274202982548, 5379.731013449234, 5386.865328366822, 5317.361916570037, 5346.919796203138, 5362.678239305654, 5365.034293827149, 5371.865703357447, 5431.185322201702, 5438.211459338295, 5443.292371991616, 5447.210154527651, 5448.373437054789, 5347.51872331492, 5366.141417373202, 5388.218708287198, 5392.649477783932, 5436.592255580927], "value": 5188.905123814552, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.1325238646803, 598.2850493660076, 605.3643674142149, 610.2280615021998, 626.0952923026226, 30210.697893021064, 33617.159571010736, 33642.0, 43669.34495982555, 45362.77318613411, 43183.784081079626, 43664.3450348245, 43679.126417471634, 43686.344704829455, 43693.0, 8571.871421928676, 8756.211940925316, 8762.60568274426, 8763.12368763125, 8766.430182038148, 7692.807679808022, 7902.683892644287, 7907.604619768988, 8171.305439037689, 8592.183742544448, 10286.537105830255, 10597.84103238452, 10603.310784798963, 10969.0, 11050.171237157245, 10561.366318020944, 10643.361398316125, 10650.25448218625, 10652.62715804943, 10666.78666426667, 10458.843117353246, 10516.263861529696, 10517.894821051768, 10524.31591946521, 10525.526351314133, 40364.394534082014, 40552.391714124315, 40562.37750489977, 40609.39085913714, 41018.79490602528, 3110.53341998702, 3182.299894023311, 3211.903642890717, 3389.7796643218358, 3426.640202778722, 29849.25376865574, 30200.24499387511, 30262.697373026207, 31340.529892051636, 31692.0, 3726.3851464508325, 3763.07804587875, 3782.111203867089, 3863.961360386388, 3909.7458665186673, 319337.0, 320812.7309178723, 320862.0, 321259.39370303234, 321730.0, 32184.83907580447, 53881.46118538843, 54107.0, 54526.45473545293, 54641.726791365785, 33082.0, 35070.96683881335, 35214.29571408557, 35316.823415882754, 35524.822375887954, 14211.0, 14285.857141428452, 14304.141751494735, 14314.570562883131, 14321.212333321768, 12547.811782823264, 12715.745685086247, 12719.364031798374, 12729.68175795594, 12736.745265094647, 7365.7790266292095, 7531.623418829036, 7725.922740772633, 7980.4812687175145, 7996.56018918965, 3120.453920563892, 3169.0560343115676, 3192.632847222599, 3195.0734287056493, 3225.5000474926424, 912.9726108216631, 931.38993958957, 998.4458625462938, 1048.5962904281907, 1105.7346236903086, 30332.84833575818, 30806.0, 30905.84547077295, 31237.219069522987, 31399.37201255962, 1068.7755571329951, 1088.4612117001977, 1096.3860238266595, 1113.9443027848574, 1131.63221952864, 15351.462698805712, 16107.275172617261, 16207.270672819752, 16460.341586336654, 16533.338666453208, 495012.0, 503419.4145146327, 515011.0, 515839.0, 779972.0, 52862.73568632132, 53644.0, 56307.0, 58069.0, 60123.69938150281, 1272.8281681972815, 1274.9043821713408, 1300.518808041031, 1308.8167656527903, 1328.1300748010262, 29325.26686832846, 30681.232969175948, 30717.0, 31135.37729245357, 31483.370332593677, 47550.0, 48332.0, 48336.27495587639, 48357.27464087971, 48371.27443088286, 453300.0, 460847.0, 465151.0, 725311.0, 725509.0, 40421.35154457275, 40481.797591011855, 40539.0, 40932.795336023126, 41123.0, 43814.0, 43897.12205755931, 45260.0, 45504.0, 45573.77213113913, 38187.42718859275, 39270.41094383644, 39796.80101599474, 40022.59977400305, 40545.59454405536, 37971.43042854304, 39575.80212098921, 39875.40186897257, 39905.201895961334, 40522.59477405306, 39030.41454378243, 39036.41445378265, 39046.609533904295, 39062.414063789634, 39361.21277574375, 33078.834605826814, 35297.0, 35329.0, 35538.28923421465, 35541.46687799633, 26441.471170576096, 27057.458850823266, 27429.72570274272, 27544.58683119795, 27713.0], "value": 18722.0303452806, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.68446451587124, 371.96466335698113, 376.1058653660086, 387.4014647369813, 407.25269131144347, 13952.441902323908, 17951.0, 19047.0, 19930.90034549829, 20158.092885820137, 18371.540711482186, 19506.70739938902, 19608.41174764756, 19670.901645491787, 19717.309894153706, 5458.890822183554, 5757.165211044396, 5766.365699773021, 5766.884662306751, 5768.134779783024, 4113.177364527091, 4278.572142785728, 4332.545082766312, 5630.183623374608, 6312.558120931537, 6321.367863213665, 6352.872942541147, 6358.268799088118, 6368.649724265164, 6377.681115944208, 6099.359567245442, 6274.498040156799, 6308.558400911938, 6309.558330916838, 6364.872702545947, 5382.0, 5573.8606534836545, 5575.637583557096, 5578.748956296977, 5582.190582365534, 20881.373558793108, 21548.0, 22527.436814079778, 22941.197058102887, 22967.425814354774, 1978.732871062417, 2073.523089689365, 2088.9582208355746, 2241.9215327463626, 2348.0, 9842.704718858446, 10023.298369114093, 10074.395536267848, 10228.64199753005, 10563.0, 1894.4222012286248, 1946.1923301829866, 1973.2107157137116, 1980.8514361422951, 2003.1086166655843, 79065.60467197685, 79868.60065699692, 80495.5975220126, 81189.0, 81462.0, 9802.36284641496, 9913.603455861828, 10009.799804004026, 10060.647877324258, 10089.848652270222, 13659.590212293648, 13686.452541898212, 13689.383977721027, 13699.315034248248, 13708.93145534286, 7367.8158046049275, 7387.85224295511, 7526.849463010709, 7657.655405506765, 7819.0617125945255, 7441.925580744231, 7488.5506869588, 7723.343515801107, 7756.185600511978, 7775.300222979959, 4092.6725861930972, 4163.12574359388, 4237.87286381409, 4312.072904325585, 4603.125406172817, 1680.915954202285, 1740.8433241008117, 1744.4034967859782, 1827.6801559726994, 1884.0391400385902, 729.68623491899, 878.9472631642122, 915.7115508614766, 950.9809803803885, 974.6296407365156, 18035.523304047078, 19524.0, 19975.700364494543, 20003.49991250201, 20013.6997945028, 880.4629176202511, 937.5218638494417, 961.9855702164473, 971.7327734872825, 987.8756192894637, 10350.360658032154, 11037.724056898642, 11061.391623460626, 11079.556817727362, 11163.665090047312, 404112.0, 408242.0, 408364.0, 409124.0, 433556.0, 89653.55173224091, 89979.55010224906, 90205.0, 90230.54884725665, 93934.0, 955.3933252384786, 969.3311614985637, 983.4345251480428, 994.8656931314325, 996.4320337407609, 16764.748528771834, 17132.828671713123, 17614.383496577557, 17650.0, 17954.102294885466, 40067.59932400638, 40575.797121014206, 40737.59262407338, 41504.377434337905, 42648.0, 54410.838374242594, 54991.725041374535, 55018.72490637521, 55805.72097139488, 56759.71620141873, 5772.5959182856795, 6069.696515174312, 7849.607519623882, 8463.857379253968, 8741.125887411208, 9825.950870245602, 12838.935805320914, 12897.0, 13085.607431777062, 13296.0, 10819.350838949687, 10820.675379738306, 10883.891161088288, 11022.559097636326, 11579.710507237387, 10342.638007669695, 10864.130869530576, 11097.611583594859, 11403.258788178742, 11404.714882128013, 11580.768384632429, 11839.822402663794, 11869.940650296694, 11944.761104777683, 12300.507979680713, 8193.426460147972, 8327.583620819056, 8349.290310323691, 8431.494110353398, 8554.786130346542, 7532.7740167795055, 7892.684292628231, 8020.197980201933, 8040.959795200986, 8168.673253069811], "value": 8768.513198643253, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1428.4357678716904, 1472.32273154349, 1609.7182992976234, 1712.143928035982, 1764.7705798246227, 7343.0, 7618.0, 8064.112947575769, 8643.870341944868, 8666.696665616704, 8093.554854483001, 8376.288015518689, 8406.369522285822, 8605.87091193631, 8608.311335093193, 2258.254775923941, 2280.794728474437, 2282.6918366020623, 2286.90852365906, 2289.107248173214, 1885.7737071551433, 1956.3837391221791, 2193.0898677049004, 2220.100859152046, 2248.718910136233, 2162.9891850540725, 2245.932622021334, 2259.423846919033, 2270.3302525754943, 2271.3640180749417, 2256.2554357062213, 2256.311824893407, 2270.6026445371995, 2289.0614847912275, 2292.79364857162, 2224.588451136545, 2226.6326056200705, 2228.3760547046854, 2229.576380487702, 2232.4195709115584, 8505.192006759347, 8612.138786121337, 8619.051904290523, 8628.784280392978, 8637.568121593895, 4877.244027175793, 5040.924386134211, 5044.747762611854, 5055.368078990126, 5064.772085256172, 3069.1406406206297, 3196.280836811722, 3254.153919980822, 3257.951130733041, 3277.049655599873, 984.4536282363285, 1012.2863381316228, 1022.7801022780138, 1029.0429900192817, 1033.6175615022414, 11619.477123529461, 11671.241369310968, 11717.062634989266, 11804.0, 11823.11326650496, 4098.938515922204, 4239.936400953989, 4319.222539942841, 4422.823087076546, 4425.557444255549, 10010.0, 10029.648962286285, 10041.698749037394, 10048.14590759779, 10052.145567626687, 4792.113459010095, 4809.831655892027, 4812.302216178705, 4824.204006338915, 4826.420829500483, 4423.712458690175, 4426.247537918562, 4437.800298986554, 4442.267025940748, 4447.3773671685985, 3559.750817442806, 3578.946315805265, 3678.4850120983083, 3696.9075773105887, 3726.9627303727157, 1015.3704703084135, 1037.7405648587853, 1111.360967443723, 1115.866096068477, 1127.3912087472672, 806.733777853307, 828.6064119543169, 846.9915300847036, 875.7241468937265, 888.8355654203993, 5415.566754659618, 5468.863278418072, 5481.205225242317, 5581.972090139523, 5741.339745929272, 458.88986643206056, 463.20097831241515, 472.65968502678015, 483.87419270989795, 625.7684656677059, 3584.874529391459, 3733.663970242691, 3736.6637002669345, 3737.831797569116, 3746.8875933722034, 10114.595416183418, 10388.065074143364, 10486.73783155412, 10491.895081049091, 10495.212859035602, 10200.23498237635, 10386.324888882198, 10403.791924161475, 10411.895881041244, 10425.165986721044, 7818.530888146729, 7832.647530861125, 7939.761807145795, 7940.245676660593, 7942.205779422012, 5456.809011684572, 5465.7813687453645, 5485.232067510472, 5531.778728850962, 5628.774849005994, 9201.677941272023, 9326.860097098684, 9394.577244024173, 9404.76488087776, 9474.857877131986, 9738.707838764849, 9744.317897747089, 9778.9022109778, 9865.112139907444, 9885.308028437941, 7542.396608271215, 7615.504992175491, 7695.576743279174, 7702.653380597774, 7707.34487568563, 8211.917880821115, 8226.958865205635, 8278.213569710868, 8279.62741676638, 8280.337572994025, 7351.742689005859, 7450.552966821791, 7482.401407887465, 7528.661210245443, 7582.203868593939, 7355.2277010913085, 7403.8149046274275, 7414.258574142758, 7453.142888567884, 7488.737894173678, 6369.649669268235, 6397.4562162216735, 6476.931306334402, 6482.124913136666, 6500.837479063061, 4632.559906808848, 4665.953340466552, 4679.479169269933, 4718.268668356411, 4759.904801904012, 4650.534946505322, 4838.685485443435, 4866.732329721899, 4910.0, 4981.128302547112], "value": 4308.939228193033, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.8107494965546, 321.5032774363611, 323.5890419167657, 323.8898774416698, 330.49929357024104, 5362.578916587103, 5404.864878378043, 5409.675419474829, 5448.509634132927, 5459.617826752129, 5067.543921047105, 5154.639175257734, 5206.817761378353, 5264.947350526493, 5373.838784836451, 4148.191102734968, 4149.6887733420035, 4150.294449943502, 4166.708330416872, 4166.708330416872, 4138.461999940018, 4145.3781932710035, 4147.004718867465, 4152.3771434284945, 4163.417121602978, 3829.5978922213185, 3924.489816323888, 3998.6801055915457, 4057.756534607918, 4112.362583799516, 4089.1821635672686, 4097.8565750198895, 4101.815418306169, 4105.712600117993, 4112.444819949298, 3612.2661122661007, 3626.1841085755495, 3626.691731202851, 3630.509881166035, 3636.3636363636256, 5014.598832093424, 5128.487151284879, 5143.382794064736, 5163.845084647466, 5184.7446360833155, 4711.411073615798, 4715.7877895494785, 4727.409073865767, 4732.219183834663, 4744.624059022879, 5489.835304940818, 5493.313335833021, 5497.835064948058, 5504.4770746778995, 5513.50378465936, 3944.5858184890462, 4002.239574480839, 4003.739756915791, 4005.379166229239, 4044.503533692523, 5682.943170568283, 5684.4315568443235, 5688.345840228385, 5694.202811606337, 5700.631848356365, 4121.1345617420675, 4123.97938010308, 4127.607877251657, 4131.855385061569, 4145.067359844072, 4070.4097905804083, 4133.937990930139, 4199.790010499462, 4200.222958752641, 4205.705600607928, 4640.907181856412, 4667.766611669403, 4682.367880336111, 4691.132140554008, 4703.717776933395, 5506.366767821672, 5514.6691198528215, 5532.889342213214, 5535.889282214333, 5556.944430555724, 1406.5288128477075, 1440.7910852926268, 1447.1534152520683, 1462.1738717624507, 1464.2971373740663, 937.3485427627869, 955.603424578806, 961.8509131084693, 962.8590120706984, 966.7728083900278, 4555.703879247838, 4800.831970881002, 4800.903981920342, 4810.99999999993, 4869.9513004870205, 5015.648904576645, 5020.849374518771, 5025.366755804305, 5027.924581131286, 5035.723035233097, 4748.6675932685075, 4756.262779269219, 4762.214234651244, 4766.952330476651, 4767.427908650984, 2678.718734532885, 2690.636764036869, 2700.3654141276784, 2700.7839372850126, 2869.684334723179, 5895.233619629421, 5903.845096539818, 5912.733926973297, 5928.170056192136, 5932.7330270137945, 5804.3167481430755, 5804.5356371491025, 5823.505002074787, 5843.970780146072, 5859.912101318484, 5693.206639908416, 5873.647581145145, 5888.116782482662, 5920.644761314335, 5925.34821169671, 5701.315842098975, 5713.628614140068, 5725.969325521446, 5728.455796699307, 5745.0, 5447.155690867922, 5648.265725455664, 5678.2050512929045, 5691.943080569141, 5703.828885133453, 5821.854453638693, 5854.2389489367815, 5864.67744274069, 5867.618604790675, 5867.647941123546, 4091.897702557341, 4140.399642051825, 4148.730332528376, 4153.8961525962095, 4159.1265834175165, 5433.723075077432, 5543.528800051879, 5589.293025963417, 5727.339071669336, 5772.451617096369, 5596.636218645775, 5602.0196465619165, 5603.8792241552665, 5623.2408624835125, 5628.718564071698, 5342.412334643109, 5599.564189577547, 5605.178317046894, 5608.327000759935, 5632.0, 5572.916406253828, 5600.551955843604, 5604.943950560605, 5609.887802244014, 5612.652963288863, 5630.465105814941, 5640.689762063126, 5646.3506696728755, 5649.802256920988, 5675.347335056356, 5227.451117632594, 5466.426025267289, 5490.0, 5528.806491772769, 5571.387147413862], "value": 4193.238548217319, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.5237693164728, 644.983875403115, 664.8637029408966, 686.9352503619389, 726.9709211631535, 14640.780388294184, 15125.16811575363, 15269.847301526981, 15656.0, 15757.684846303067, 13452.730945381087, 13727.107737997023, 13786.793198102036, 13822.723545529083, 13844.723105537883, 796.8844517544967, 815.9306458950996, 817.0685418622775, 817.9672813087469, 818.2063398503471, 667.349334398962, 685.4413652872918, 780.6955287437876, 799.6441583495347, 806.4757907360204, 849.5072857742495, 851.8381507513584, 852.2627926843298, 858.52351944671, 860.7675927499571, 854.3763052971366, 855.3371137368526, 855.9828803423928, 856.019857263433, 856.0668870930684, 504.03477340892147, 516.4267662894184, 521.7573828169881, 521.7756364763151, 605.1044454207753, 13684.315784210849, 14286.928565357211, 14329.570112896525, 14346.42614295427, 14360.784588231185, 13530.797038044437, 13763.655908602264, 14166.787498187536, 14633.853661463461, 14796.556103316918, 11095.72260693481, 11151.485148514852, 11196.720081997933, 11332.716682082932, 11424.885751142549, 4449.977750111261, 4457.264551349056, 4463.285874260136, 4515.187266292066, 4516.977415112936, 61911.0, 64039.0, 64499.67750161266, 70275.0, 74167.99999999946, 11275.379854108103, 11553.768924621461, 11637.941810290895, 11787.587434439753, 11804.52781888732, 21056.473588160417, 21142.15431382758, 21219.363419097142, 21331.78668213298, 21748.347549573537, 7646.617669116522, 7840.725574604861, 7859.960700196577, 7887.44787864844, 7943.364530837519, 4543.227651299287, 4598.793054312497, 4683.320918466803, 4807.326974223612, 4890.315355850184, 3278.278778668737, 3377.037544299912, 3382.5940887093707, 3384.526166336715, 3384.6953774160443, 601.3475379213602, 616.4236438929615, 625.1903784598956, 627.8179327994831, 629.8586791843646, 543.7879227101433, 551.8537587539305, 591.8549955260903, 701.9227884932653, 720.8558288342248, 9283.675071372605, 9339.486328252011, 9406.153446189739, 9437.245020398352, 9598.0, 544.1231227504034, 563.1833840930667, 586.633354153654, 679.2460368990417, 706.3254591864757, 4391.1563279363345, 4407.316865885793, 4437.622802061861, 4447.73313601185, 4478.216312145361, 100172.49913750385, 107304.0, 109215.0, 110197.0, 110786.0, 55595.722021389636, 73134.0, 94419.52790236143, 94800.0, 97998.10009499497, 50143.49856501461, 53129.0, 75285.0, 81254.0, 82792.75810862842, 8665.480071195749, 8907.643694252158, 8945.19493245585, 9308.767280818034, 9533.904660953302, 49072.0, 51356.22965655593, 51441.742791285804, 51672.22491662553, 53323.0, 69172.3082769186, 69593.65203173952, 73463.63268183624, 75112.0, 75895.62052189704, 11810.409479525817, 12013.81979270329, 12638.304893230961, 12667.556635517712, 12713.364331783188, 11985.34080625574, 12234.510619575118, 12287.447064881922, 13298.069135160446, 13302.334883255991, 12130.757384852077, 12863.614091577268, 12953.805692914802, 13293.933530332286, 13752.93123534376, 10577.0, 12913.289769062792, 13556.661083472993, 13578.388972496065, 14037.859621403655, 11949.103817213918, 12352.444140013542, 12369.319687417279, 13043.478260869459, 13221.140625859289, 10479.0, 10655.467226638792, 10712.785744284914, 10741.838872416763, 11265.211435199457, 9762.75593110178, 9931.602735890483, 10148.23888208402, 10227.7443063924, 10228.48857557134], "value": 7130.850052389252, "unit": "score"}], "name": "dromaeo_css", "value": 6919.533690517965, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 111.0, 112.0, 114.0, 114.0, 115.0, 115.0, 112.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 122.0, 124.0, 157.0, 126.0, 123.0, 123.0, 119.0, 147.0, 119.0], "value": 131.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 159.0, 162.0, 167.0, 161.0, 161.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 110.0, 75.0, 75.0, 76.0, 75.0, 97.0, 75.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 106.0, 82.0, 83.0, 82.0, 113.0, 82.0, 81.0, 117.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 145.0, 145.0, 146.0, 148.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 50.0, 51.0, 52.0, 52.0, 52.0, 52.0, 53.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0, 59.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 79.0, 78.0, 81.0, 79.0, 79.0, 78.0, 79.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 133.0, 133.0, 128.0, 138.0, 128.0, 129.0, 128.0, 173.0, 131.0], "value": 135.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 163.0, 164.0, 161.0, 163.0, 162.0, 164.0, 163.0, 164.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 65.0, 67.0, 72.0, 65.0, 67.0, 64.0, 65.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1478.8000000000004, "alertThreshold": 2.0}]} 05:00:10 INFO - Return code: 0 05:00:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:00:10 INFO - # TBPL SUCCESS # 05:00:10 INFO - Running post-action listener: _resource_record_post_action 05:00:10 INFO - [mozharness: 2016-10-19 12:00:10.512964Z] Finished run-tests step (success) 05:00:10 INFO - Running post-run listener: _resource_record_post_run 05:00:10 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 392302592; Read time: 0; Write time: 310952 05:00:10 INFO - TinderboxPrint: CPU usage
13.1% 05:00:10 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:00:10 INFO - TinderboxPrint: I/O write bytes / time
392,302,592 / 310,952 05:00:10 INFO - TinderboxPrint: CPU idle
8,301.6 (86.9%) 05:00:10 INFO - TinderboxPrint: CPU user
1,200.3 (12.6%) 05:00:10 INFO - TinderboxPrint: Swap in / out
0 / 0 05:00:10 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103067648; Read time: 0; Write time: 67812 05:00:10 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287944704; Read time: 0; Write time: 243116 05:00:11 INFO - Running post-run listener: _upload_blobber_files 05:00:11 INFO - Blob upload gear active. 05:00:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:00:11 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 05:00:11 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'] 05:00:11 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 05:00:11 INFO - (blobuploader) - INFO - Open directory for files ... 05:00:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:00:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:00:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:00:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:00:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:00:15 INFO - (blobuploader) - INFO - Done attempting. 05:00:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:00:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:00:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:00:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:00:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:00:16 INFO - (blobuploader) - INFO - Done attempting. 05:00:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:00:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:00:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:00:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:00:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:00:17 INFO - (blobuploader) - INFO - Done attempting. 05:00:17 INFO - (blobuploader) - INFO - Iteration through files over. 05:00:17 INFO - Return code: 0 05:00:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:00:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:00:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8d5b10e7027b5466ad8ed49d4418fd2900e06dc2d77d495efb9c5dedfdf4b7c56dfe3bc5982c27e3e1803774fa85f0bf1a80278429a28f0fd457d6b3d6d9bc7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7552ac67c0d5981717f67bab0e9e2544e8bf0ba051170cdbee2cc3878af6756d3be3105a6035af2bb00bf0bc9a0d3f74305aaef5709e7f812a9ff98298a6d328", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1274397a84daaf6372c42ac5606fb362542a573681e0e8ac30f371f0e4c36143bd2ac134119f93c2b092cd8b8ee40350eebe3aea65694d96cb770d3143a060eb"} 05:00:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:00:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:00:17 INFO - Contents: 05:00:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8d5b10e7027b5466ad8ed49d4418fd2900e06dc2d77d495efb9c5dedfdf4b7c56dfe3bc5982c27e3e1803774fa85f0bf1a80278429a28f0fd457d6b3d6d9bc7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7552ac67c0d5981717f67bab0e9e2544e8bf0ba051170cdbee2cc3878af6756d3be3105a6035af2bb00bf0bc9a0d3f74305aaef5709e7f812a9ff98298a6d328", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1274397a84daaf6372c42ac5606fb362542a573681e0e8ac30f371f0e4c36143bd2ac134119f93c2b092cd8b8ee40350eebe3aea65694d96cb770d3143a060eb"} 05:00:17 INFO - Running post-run listener: copy_logs_to_upload_dir 05:00:17 INFO - Copying logs to upload dir... 05:00:17 INFO - mkdir: /builds/slave/test/build/upload/logs 05:00:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.810464 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-19 05:00:17.298996) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 05:00:17.302097) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8d5b10e7027b5466ad8ed49d4418fd2900e06dc2d77d495efb9c5dedfdf4b7c56dfe3bc5982c27e3e1803774fa85f0bf1a80278429a28f0fd457d6b3d6d9bc7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7552ac67c0d5981717f67bab0e9e2544e8bf0ba051170cdbee2cc3878af6756d3be3105a6035af2bb00bf0bc9a0d3f74305aaef5709e7f812a9ff98298a6d328", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1274397a84daaf6372c42ac5606fb362542a573681e0e8ac30f371f0e4c36143bd2ac134119f93c2b092cd8b8ee40350eebe3aea65694d96cb770d3143a060eb"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011455 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476862378/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8d5b10e7027b5466ad8ed49d4418fd2900e06dc2d77d495efb9c5dedfdf4b7c56dfe3bc5982c27e3e1803774fa85f0bf1a80278429a28f0fd457d6b3d6d9bc7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7552ac67c0d5981717f67bab0e9e2544e8bf0ba051170cdbee2cc3878af6756d3be3105a6035af2bb00bf0bc9a0d3f74305aaef5709e7f812a9ff98298a6d328", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1274397a84daaf6372c42ac5606fb362542a573681e0e8ac30f371f0e4c36143bd2ac134119f93c2b092cd8b8ee40350eebe3aea65694d96cb770d3143a060eb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 05:00:17.331485) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 05:00:17.332185) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1476877176.187050-703709039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 05:00:17.414922) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 05:00:17.415566) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 05:00:17.416198) ========= ========= Total master_lag: 0.18 =========