builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1476465299.41 results: success (0) buildid: 20161014094518 builduid: afda9523af63446e938b98bcd8270536 revision: 68f7f7949d1770ea1a99b822dff2fd2122187672 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 10:14:59.405870) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 10:14:59.406388) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 10:14:59.406705) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 10:14:59.421743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:14:59.422198) ========= 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=af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 10:14:59-- 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% 40.7M=0s 2016-10-14 10:14:59 (40.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139235 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:14:59.575884) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:14:59.576336) ========= 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=af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019891 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:14:59.626707) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:14:59.627132) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 68f7f7949d1770ea1a99b822dff2fd2122187672 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 68f7f7949d1770ea1a99b822dff2fd2122187672 --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=af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 10:14:59,926 truncating revision to first 12 chars 2016-10-14 10:14:59,926 Setting DEBUG logging. 2016-10-14 10:14:59,926 attempt 1/10 2016-10-14 10:14:59,926 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/68f7f7949d17?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 10:15:00,456 unpacking tar archive at: autoland-68f7f7949d17/testing/mozharness/ program finished with exit code 0 elapsedTime=0.834663 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:15:00.478716) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 10:15:00.479084) ========= script_repo_revision: 68f7f7949d1770ea1a99b822dff2fd2122187672 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 10:15:00.479554) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 10:15:00.479858) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 10:15:00.489794) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-14 10:15:00.490332) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:15:00 INFO - MultiFileLogger online at 20161014 10:15:00 in /builds/slave/test 10:15:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 10:15:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:15:00 INFO - {'append_to_log': False, 10:15:00 INFO - 'base_work_dir': '/builds/slave/test', 10:15:00 INFO - 'blob_upload_branch': 'Autoland', 10:15:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:15:00 INFO - 'branch': 'Autoland', 10:15:00 INFO - 'buildbot_json_path': 'buildprops.json', 10:15:00 INFO - 'config_files': ('talos/linux_config.py',), 10:15:00 INFO - 'default_actions': ('clobber', 10:15:00 INFO - 'read-buildbot-config', 10:15:00 INFO - 'download-and-extract', 10:15:00 INFO - 'populate-webroot', 10:15:00 INFO - 'create-virtualenv', 10:15:00 INFO - 'install', 10:15:00 INFO - 'run-tests'), 10:15:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:15:00 INFO - 'download_minidump_stackwalk': True, 10:15:00 INFO - 'download_symbols': 'ondemand', 10:15:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:15:00 INFO - 'tooltool.py': '/tools/tooltool.py', 10:15:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:15:00 INFO - '/tools/misc-python/virtualenv.py')}, 10:15:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:15:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:15:00 INFO - 'installer_path': 'installer.exe', 10:15:00 INFO - 'log_level': 'info', 10:15:00 INFO - 'log_name': 'talos', 10:15:00 INFO - 'log_to_console': True, 10:15:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:15:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:15:00 INFO - 'opt_config_files': (), 10:15:00 INFO - 'pip_index': False, 10:15:00 INFO - 'sps_profile': False, 10:15:00 INFO - 'sps_profile_interval': 0, 10:15:00 INFO - 'suite': 'dromaeojs', 10:15:00 INFO - 'system_bits': '32', 10:15:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:15:00 INFO - 'title': 'talos-linux64-ix-020', 10:15:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:15:00 INFO - 'use_talos_json': True, 10:15:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:15:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:15:00 INFO - 'work_dir': 'build'} 10:15:00 INFO - [mozharness: 2016-10-14 17:15:00.888686Z] Running clobber step. 10:15:00 INFO - Running pre-action listener: _resource_record_pre_action 10:15:00 INFO - Running main action method: clobber 10:15:00 INFO - rmtree: /builds/slave/test/build 10:15:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:15:01 INFO - Running post-action listener: _resource_record_post_action 10:15:01 INFO - [mozharness: 2016-10-14 17:15:01.343891Z] Finished clobber step (success) 10:15:01 INFO - [mozharness: 2016-10-14 17:15:01.343993Z] Running read-buildbot-config step. 10:15:01 INFO - Running pre-action listener: _resource_record_pre_action 10:15:01 INFO - Running main action method: read_buildbot_config 10:15:01 INFO - Using buildbot properties: 10:15:01 INFO - { 10:15:01 INFO - "project": "", 10:15:01 INFO - "product": "firefox", 10:15:01 INFO - "script_repo_revision": "production", 10:15:01 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 10:15:01 INFO - "repository": "", 10:15:01 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 10:15:01 INFO - "buildid": "20161014094518", 10:15:01 INFO - "stage_platform": "linux64-pgo", 10:15:01 INFO - "basedir": "/builds/slave/test", 10:15:01 INFO - "buildnumber": 373, 10:15:01 INFO - "platform": "ubuntu64_hw", 10:15:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:15:01 INFO - "slavebuilddir": "test", 10:15:01 INFO - "branch": "autoland", 10:15:01 INFO - "revision": "68f7f7949d1770ea1a99b822dff2fd2122187672", 10:15:01 INFO - "slavename": "talos-linux64-ix-020", 10:15:01 INFO - "builduid": "afda9523af63446e938b98bcd8270536", 10:15:01 INFO - "repo_path": "integration/autoland" 10:15:01 INFO - } 10:15:01 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:15:01 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 10:15:01 INFO - Running post-action listener: _resource_record_post_action 10:15:01 INFO - [mozharness: 2016-10-14 17:15:01.346351Z] Finished read-buildbot-config step (success) 10:15:01 INFO - [mozharness: 2016-10-14 17:15:01.346439Z] Running download-and-extract step. 10:15:01 INFO - Running pre-action listener: _resource_record_pre_action 10:15:01 INFO - Running main action method: download_and_extract 10:15:01 INFO - mkdir: /builds/slave/test/build/tests 10:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:01 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:15:01 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:15:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:15:01 INFO - Downloaded 1361 bytes. 10:15:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:15:01 INFO - Using the following test package requirements: 10:15:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:15:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:15:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:15:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:01 INFO - u'jsshell-linux-x86_64.zip'], 10:15:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:15:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:15:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:15:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:15:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:15:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:15:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:15:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:15:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:15:01 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:15:01 INFO - Http code: 200 10:15:01 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 10:15:01 INFO - x-amz-cf-id: p2POqwg-ghzmLVWaWey18eBqeRI4dLp4pNzQpTQhSz93okOoCeMkkQ== 10:15:01 INFO - x-amz-replication-status: COMPLETED 10:15:01 INFO - x-amz-version-id: jRedrkPkkDwxZwiir214BilE0uUadM5o 10:15:02 INFO - Expected file size: 22123050 10:15:02 INFO - Obtained file size: 22123050 10:15:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:15:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:15:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:15:06 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:15:06 INFO - Http code: 200 10:15:06 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 10:15:06 INFO - x-amz-cf-id: XDpYe6Pf3IbEjBsIGoM8zlIwm2hKIUvBs4HQJDcKXGjTCmBvz2FRwA== 10:15:06 INFO - x-amz-replication-status: COMPLETED 10:15:06 INFO - x-amz-version-id: jRedrkPkkDwxZwiir214BilE0uUadM5o 10:15:07 INFO - Expected file size: 22123050 10:15:07 INFO - Obtained file size: 22123050 10:15:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:15:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:15:12 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:15:12 INFO - Http code: 200 10:15:12 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 10:15:12 INFO - x-amz-cf-id: va1y6-gQHhUtoVgPAvoAOHRKiFRYsTcAYNvDSs5BLn-qszbFTWGvjw== 10:15:12 INFO - x-amz-replication-status: COMPLETED 10:15:12 INFO - x-amz-version-id: pOYRSmGRm1LL86wSd3bndJO5C8.xoHk2 10:15:12 INFO - Expected file size: 14409006 10:15:12 INFO - Obtained file size: 14409006 10:15: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')]} 10:15:12 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:15:12 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:15:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:15:15 INFO - Downloaded 59623374 bytes. 10:15:15 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:15:15 INFO - mkdir: /builds/slave/test/properties 10:15:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:15:15 INFO - Writing to file /builds/slave/test/properties/build_url 10:15:15 INFO - Contents: 10:15:15 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:15:16 INFO - Running post-action listener: _resource_record_post_action 10:15:16 INFO - Running post-action listener: set_extra_try_arguments 10:15:16 INFO - [mozharness: 2016-10-14 17:15:16.177057Z] Finished download-and-extract step (success) 10:15:16 INFO - [mozharness: 2016-10-14 17:15:16.177291Z] Running populate-webroot step. 10:15:16 INFO - Running pre-action listener: _resource_record_pre_action 10:15:16 INFO - Running main action method: populate_webroot 10:15:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:15:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:15:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:15:16 INFO - '--tppagecycles', 10:15:16 INFO - '7'], 10:15:16 INFO - 'tests': ['tsvgm']}}, 10:15:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:15:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:15:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:15:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:15:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:15:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:15:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:16 INFO - 'talos_options': ['--disable-e10s'], 10:15:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:16 INFO - 'talos_options': ['--disable-e10s'], 10:15:16 INFO - 'tests': ['damp', 'tps']}, 10:15:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:16 INFO - 'tests': ['damp', 'tps']}, 10:15:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:15:16 INFO - 'tests': ['dromaeo_dom']}, 10:15:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:15:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:15:16 INFO - 'tests': ['basic_compositor_video']}, 10:15:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:15:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:15:16 INFO - 'tests': ['a11yr', 10:15:16 INFO - 'ts_paint', 10:15:16 INFO - 'tpaint', 10:15:16 INFO - 'sessionrestore', 10:15:16 INFO - 'sessionrestore_no_auto_restore', 10:15:16 INFO - 'tabpaint']}, 10:15:16 INFO - 'other-e10s': {'tests': ['a11yr', 10:15:16 INFO - 'ts_paint', 10:15:16 INFO - 'tpaint', 10:15:16 INFO - 'sessionrestore', 10:15:16 INFO - 'sessionrestore_no_auto_restore', 10:15:16 INFO - 'tabpaint']}, 10:15:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:15:16 INFO - 'ts_paint', 10:15:16 INFO - 'tpaint', 10:15:16 INFO - 'sessionrestore', 10:15:16 INFO - 'sessionrestore_no_auto_restore', 10:15:16 INFO - 'tabpaint']}, 10:15:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:15:16 INFO - 'ts_paint', 10:15:16 INFO - 'tpaint', 10:15:16 INFO - 'sessionrestore', 10:15:16 INFO - 'sessionrestore_no_auto_restore', 10:15:16 INFO - 'tabpaint']}, 10:15:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:15:16 INFO - 'tests': ['a11yr', 10:15:16 INFO - 'ts_paint', 10:15:16 INFO - 'tpaint', 10:15:16 INFO - 'sessionrestore', 10:15:16 INFO - 'sessionrestore_no_auto_restore', 10:15:16 INFO - 'tabpaint']}, 10:15:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:15:16 INFO - 'tests': ['a11yr', 10:15:16 INFO - 'ts_paint', 10:15:16 INFO - 'tpaint', 10:15:16 INFO - 'sessionrestore', 10:15:16 INFO - 'sessionrestore_no_auto_restore', 10:15:16 INFO - 'tabpaint']}, 10:15:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:15:16 INFO - 'tests': ['tsvgx', 10:15:16 INFO - 'tsvgr_opacity', 10:15:16 INFO - 'tart', 10:15:16 INFO - 'tscrollx', 10:15:16 INFO - 'cart']}, 10:15:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:15:16 INFO - 'tsvgr_opacity', 10:15:16 INFO - 'tart', 10:15:16 INFO - 'tscrollx', 10:15:16 INFO - 'cart']}, 10:15:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:16 INFO - 'talos_options': ['--disable-e10s'], 10:15:16 INFO - 'tests': ['tp5o']}, 10:15:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:16 INFO - 'tests': ['tp5o']}, 10:15:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:16 INFO - 'talos_options': ['--disable-e10s', 10:15:16 INFO - '--xperf_path', 10:15:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:16 INFO - 'tests': ['tp5n']}, 10:15:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:16 INFO - 'talos_options': ['--xperf_path', 10:15:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:16 INFO - 'tests': ['tp5n']}}, 10:15:16 INFO - 'talos.zip': {'path': '', 10:15:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:15:16 INFO - Running post-action listener: _resource_record_post_action 10:15:16 INFO - [mozharness: 2016-10-14 17:15:16.195503Z] Finished populate-webroot step (success) 10:15:16 INFO - [mozharness: 2016-10-14 17:15:16.195590Z] Running create-virtualenv step. 10:15:16 INFO - Running pre-action listener: _resource_record_pre_action 10:15:16 INFO - Running main action method: create_virtualenv 10:15:16 INFO - Creating virtualenv /builds/slave/test/build/venv 10:15:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:15:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:15:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:15:16 INFO - Using real prefix '/usr' 10:15:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:15:16 INFO - Installing distribute.............................................................................................................................................................................................done. 10:15:18 INFO - Installing pip.................done. 10:15:18 INFO - Return code: 0 10:15:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:15:18 INFO - Reading from file tmpfile_stdout 10:15:18 INFO - Output received: 10:15:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:15:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:18 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 0x7f746f135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a4790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a1930>, '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 0x27a2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:15:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:15:18 INFO - Using env: {'DISPLAY': ':0', 10:15:18 INFO - 'HOME': '/home/cltbld', 10:15:18 INFO - 'LANG': 'en_US.UTF-8', 10:15:18 INFO - 'LANGUAGE': 'en_US:en', 10:15:18 INFO - 'LOGNAME': 'cltbld', 10:15:18 INFO - 'MAIL': '/var/mail/cltbld', 10:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:18 INFO - 'MOZ_NO_REMOTE': '1', 10:15:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:18 INFO - 'NO_EM_RESTART': '1', 10:15:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:18 INFO - 'PWD': '/builds/slave/test', 10:15:18 INFO - 'SHELL': '/bin/bash', 10:15:18 INFO - 'SHLVL': '1', 10:15:18 INFO - 'TERM': 'linux', 10:15:18 INFO - 'TMOUT': '86400', 10:15:18 INFO - 'USER': 'cltbld', 10:15:18 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 10:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:18 INFO - '_': '/tools/buildbot/bin/python'} 10:15:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:15:19 INFO - Cleaning up... 10:15:19 INFO - Return code: 0 10:15:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:19 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 0x7f746f135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a4790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a1930>, '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 0x27a2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:15:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:15:19 INFO - Using env: {'DISPLAY': ':0', 10:15:19 INFO - 'HOME': '/home/cltbld', 10:15:19 INFO - 'LANG': 'en_US.UTF-8', 10:15:19 INFO - 'LANGUAGE': 'en_US:en', 10:15:19 INFO - 'LOGNAME': 'cltbld', 10:15:19 INFO - 'MAIL': '/var/mail/cltbld', 10:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:19 INFO - 'MOZ_NO_REMOTE': '1', 10:15:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:19 INFO - 'NO_EM_RESTART': '1', 10:15:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:19 INFO - 'PWD': '/builds/slave/test', 10:15:19 INFO - 'SHELL': '/bin/bash', 10:15:19 INFO - 'SHLVL': '1', 10:15:19 INFO - 'TERM': 'linux', 10:15:19 INFO - 'TMOUT': '86400', 10:15:19 INFO - 'USER': 'cltbld', 10:15:19 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 10:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:19 INFO - '_': '/tools/buildbot/bin/python'} 10:15:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:19 INFO - Downloading/unpacking psutil>=3.1.1 10:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:15:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:21 INFO - Installing collected packages: psutil 10:15:21 INFO - Running setup.py install for psutil 10:15:21 INFO - building 'psutil._psutil_linux' extension 10:15:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:15:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:15:21 INFO - building 'psutil._psutil_posix' extension 10:15:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:15:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:15:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:21 INFO - Successfully installed psutil 10:15:21 INFO - Cleaning up... 10:15:21 INFO - Return code: 0 10:15:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:22 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 0x7f746f135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a4790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a1930>, '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 0x27a2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:15:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:15:22 INFO - Using env: {'DISPLAY': ':0', 10:15:22 INFO - 'HOME': '/home/cltbld', 10:15:22 INFO - 'LANG': 'en_US.UTF-8', 10:15:22 INFO - 'LANGUAGE': 'en_US:en', 10:15:22 INFO - 'LOGNAME': 'cltbld', 10:15:22 INFO - 'MAIL': '/var/mail/cltbld', 10:15:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:22 INFO - 'MOZ_NO_REMOTE': '1', 10:15:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:22 INFO - 'NO_EM_RESTART': '1', 10:15:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:22 INFO - 'PWD': '/builds/slave/test', 10:15:22 INFO - 'SHELL': '/bin/bash', 10:15:22 INFO - 'SHLVL': '1', 10:15:22 INFO - 'TERM': 'linux', 10:15:22 INFO - 'TMOUT': '86400', 10:15:22 INFO - 'USER': 'cltbld', 10:15:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 10:15:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:22 INFO - '_': '/tools/buildbot/bin/python'} 10:15:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:15:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:15:24 INFO - Installing collected packages: mozsystemmonitor 10:15:24 INFO - Running setup.py install for mozsystemmonitor 10:15:24 INFO - Successfully installed mozsystemmonitor 10:15:24 INFO - Cleaning up... 10:15:24 INFO - Return code: 0 10:15:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:24 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 0x7f746f135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a4790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a1930>, '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 0x27a2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:15:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:15:24 INFO - Using env: {'DISPLAY': ':0', 10:15:24 INFO - 'HOME': '/home/cltbld', 10:15:24 INFO - 'LANG': 'en_US.UTF-8', 10:15:24 INFO - 'LANGUAGE': 'en_US:en', 10:15:24 INFO - 'LOGNAME': 'cltbld', 10:15:24 INFO - 'MAIL': '/var/mail/cltbld', 10:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:24 INFO - 'MOZ_NO_REMOTE': '1', 10:15:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:24 INFO - 'NO_EM_RESTART': '1', 10:15:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:24 INFO - 'PWD': '/builds/slave/test', 10:15:24 INFO - 'SHELL': '/bin/bash', 10:15:24 INFO - 'SHLVL': '1', 10:15:24 INFO - 'TERM': 'linux', 10:15:24 INFO - 'TMOUT': '86400', 10:15:24 INFO - 'USER': 'cltbld', 10:15:24 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 10:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:24 INFO - '_': '/tools/buildbot/bin/python'} 10:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:24 INFO - Downloading/unpacking jsonschema==2.5.1 10:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:15:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:26 INFO - Downloading functools32-3.2.3-2.tar.gz 10:15:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:15:26 INFO - warning: no files found matching '*.txt' 10:15:26 INFO - no previously-included directories found matching 'build' 10:15:26 INFO - no previously-included directories found matching 'dist' 10:15:26 INFO - no previously-included directories found matching '.git*' 10:15:26 INFO - Installing collected packages: jsonschema, functools32 10:15:26 INFO - Running setup.py install for functools32 10:15:26 INFO - warning: no files found matching '*.txt' 10:15:26 INFO - no previously-included directories found matching 'build' 10:15:26 INFO - no previously-included directories found matching 'dist' 10:15:26 INFO - no previously-included directories found matching '.git*' 10:15:26 INFO - Successfully installed jsonschema functools32 10:15:26 INFO - Cleaning up... 10:15:26 INFO - Return code: 0 10:15:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:26 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 0x7f746f135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a4790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a1930>, '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 0x27a2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:15:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:15:26 INFO - Using env: {'DISPLAY': ':0', 10:15:26 INFO - 'HOME': '/home/cltbld', 10:15:26 INFO - 'LANG': 'en_US.UTF-8', 10:15:26 INFO - 'LANGUAGE': 'en_US:en', 10:15:26 INFO - 'LOGNAME': 'cltbld', 10:15:26 INFO - 'MAIL': '/var/mail/cltbld', 10:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:26 INFO - 'MOZ_NO_REMOTE': '1', 10:15:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:26 INFO - 'NO_EM_RESTART': '1', 10:15:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:26 INFO - 'PWD': '/builds/slave/test', 10:15:26 INFO - 'SHELL': '/bin/bash', 10:15:26 INFO - 'SHLVL': '1', 10:15:26 INFO - 'TERM': 'linux', 10:15:26 INFO - 'TMOUT': '86400', 10:15:26 INFO - 'USER': 'cltbld', 10:15:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 10:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:26 INFO - '_': '/tools/buildbot/bin/python'} 10:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:15:27 INFO - Cleaning up... 10:15:27 INFO - Return code: 0 10:15:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:27 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 0x7f746f135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a4790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a1930>, '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 0x27a2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:15:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:15:27 INFO - Using env: {'DISPLAY': ':0', 10:15:27 INFO - 'HOME': '/home/cltbld', 10:15:27 INFO - 'LANG': 'en_US.UTF-8', 10:15:27 INFO - 'LANGUAGE': 'en_US:en', 10:15:27 INFO - 'LOGNAME': 'cltbld', 10:15:27 INFO - 'MAIL': '/var/mail/cltbld', 10:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:27 INFO - 'MOZ_NO_REMOTE': '1', 10:15:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:27 INFO - 'NO_EM_RESTART': '1', 10:15:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:27 INFO - 'PWD': '/builds/slave/test', 10:15:27 INFO - 'SHELL': '/bin/bash', 10:15:27 INFO - 'SHLVL': '1', 10:15:27 INFO - 'TERM': 'linux', 10:15:27 INFO - 'TMOUT': '86400', 10:15:27 INFO - 'USER': 'cltbld', 10:15:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 10:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:27 INFO - '_': '/tools/buildbot/bin/python'} 10:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:27 INFO - Downloading/unpacking blobuploader==1.2.4 10:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:29 INFO - Downloading blobuploader-1.2.4.tar.gz 10:15:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:15:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:15:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:29 INFO - Downloading docopt-0.6.1.tar.gz 10:15:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:15:30 INFO - Installing collected packages: blobuploader, requests, docopt 10:15:30 INFO - Running setup.py install for blobuploader 10:15:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:15:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:15:30 INFO - Running setup.py install for requests 10:15:30 INFO - Running setup.py install for docopt 10:15:30 INFO - Successfully installed blobuploader requests docopt 10:15:30 INFO - Cleaning up... 10:15:30 INFO - Return code: 0 10:15:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15: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')]} 10:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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')]} 10:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:30 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 0x7f746f135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a4790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a1930>, '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 0x27a2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:15:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:15:30 INFO - Using env: {'DISPLAY': ':0', 10:15:30 INFO - 'HOME': '/home/cltbld', 10:15:30 INFO - 'LANG': 'en_US.UTF-8', 10:15:30 INFO - 'LANGUAGE': 'en_US:en', 10:15:30 INFO - 'LOGNAME': 'cltbld', 10:15:30 INFO - 'MAIL': '/var/mail/cltbld', 10:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:30 INFO - 'MOZ_NO_REMOTE': '1', 10:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:30 INFO - 'NO_EM_RESTART': '1', 10:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:30 INFO - 'PWD': '/builds/slave/test', 10:15:30 INFO - 'SHELL': '/bin/bash', 10:15:30 INFO - 'SHLVL': '1', 10:15:30 INFO - 'TERM': 'linux', 10:15:30 INFO - 'TMOUT': '86400', 10:15:30 INFO - 'USER': 'cltbld', 10:15:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 10:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:30 INFO - '_': '/tools/buildbot/bin/python'} 10:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:15:30 INFO - Running setup.py (path:/tmp/pip-iVpZCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:15:30 INFO - Running setup.py (path:/tmp/pip-GlzLHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:15:30 INFO - Running setup.py (path:/tmp/pip-sxOHfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:15:31 INFO - Running setup.py (path:/tmp/pip-nuculr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:15:31 INFO - Running setup.py (path:/tmp/pip-vYofla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:15:31 INFO - Running setup.py (path:/tmp/pip-9WFGgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:15:31 INFO - Running setup.py (path:/tmp/pip-Ygb3UF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:15:31 INFO - Running setup.py (path:/tmp/pip-_BTwUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:15:31 INFO - Running setup.py (path:/tmp/pip-_vYapG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:15:31 INFO - Running setup.py (path:/tmp/pip-ILAyf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:15:31 INFO - Running setup.py (path:/tmp/pip-s1OZYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:15:31 INFO - Running setup.py (path:/tmp/pip-CqcYMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:15:31 INFO - Running setup.py (path:/tmp/pip-kll8kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:15:31 INFO - Running setup.py (path:/tmp/pip-jeCgC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:31 INFO - Running setup.py (path:/tmp/pip-Kbl8u4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:15:31 INFO - Running setup.py (path:/tmp/pip-5Y_375-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:15:32 INFO - Running setup.py (path:/tmp/pip-aZ_OAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:15:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:15:32 INFO - Running setup.py install for manifestparser 10:15:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:15:32 INFO - Running setup.py install for mozcrash 10:15:32 INFO - Running setup.py install for mozdebug 10:15:32 INFO - Running setup.py install for mozdevice 10:15:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:15:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:15:32 INFO - Running setup.py install for mozfile 10:15:32 INFO - Running setup.py install for mozhttpd 10:15:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:15:32 INFO - Running setup.py install for mozinfo 10:15:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:15:32 INFO - Running setup.py install for mozInstall 10:15:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:15:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:15:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:15:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:15:32 INFO - Running setup.py install for mozleak 10:15:32 INFO - Running setup.py install for mozlog 10:15:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:15:33 INFO - Running setup.py install for moznetwork 10:15:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:15:33 INFO - Running setup.py install for mozprocess 10:15:33 INFO - Running setup.py install for mozprofile 10:15:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:15:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:15:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:15:33 INFO - Running setup.py install for mozrunner 10:15:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:15:33 INFO - Running setup.py install for mozscreenshot 10:15:33 INFO - Running setup.py install for moztest 10:15:33 INFO - Running setup.py install for mozversion 10:15:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:15:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:15:33 INFO - Cleaning up... 10:15:33 INFO - Return code: 0 10:15:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:33 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 0x7f746f135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a4790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a1930>, '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 0x27a2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:15:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:15:33 INFO - Using env: {'DISPLAY': ':0', 10:15:33 INFO - 'HOME': '/home/cltbld', 10:15:33 INFO - 'LANG': 'en_US.UTF-8', 10:15:33 INFO - 'LANGUAGE': 'en_US:en', 10:15:33 INFO - 'LOGNAME': 'cltbld', 10:15:33 INFO - 'MAIL': '/var/mail/cltbld', 10:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:33 INFO - 'MOZ_NO_REMOTE': '1', 10:15:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:33 INFO - 'NO_EM_RESTART': '1', 10:15:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:33 INFO - 'PWD': '/builds/slave/test', 10:15:33 INFO - 'SHELL': '/bin/bash', 10:15:33 INFO - 'SHLVL': '1', 10:15:33 INFO - 'TERM': 'linux', 10:15:33 INFO - 'TMOUT': '86400', 10:15:33 INFO - 'USER': 'cltbld', 10:15:33 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 10:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:33 INFO - '_': '/tools/buildbot/bin/python'} 10:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:15:34 INFO - Running setup.py (path:/tmp/pip-3n8119-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:15:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:15:34 INFO - Running setup.py (path:/tmp/pip-gPkSqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:15:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:15:34 INFO - Running setup.py (path:/tmp/pip-qreoNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:15:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:15:34 INFO - Running setup.py (path:/tmp/pip-C0Mo3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:15:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:15:34 INFO - Running setup.py (path:/tmp/pip-mX9i0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:15:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:15:34 INFO - Running setup.py (path:/tmp/pip-7OO494-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:15:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:15:34 INFO - Running setup.py (path:/tmp/pip-B2BC48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:15:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:15:34 INFO - Running setup.py (path:/tmp/pip-U10rXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:15:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:15:34 INFO - Running setup.py (path:/tmp/pip-kfNhw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:15:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:15:34 INFO - Running setup.py (path:/tmp/pip-c6XQeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:15:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:15:34 INFO - Running setup.py (path:/tmp/pip-l7j8wX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:15:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:15:34 INFO - Running setup.py (path:/tmp/pip-VGpUEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:15:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:15:34 INFO - Running setup.py (path:/tmp/pip-S_Y5EC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:15:35 INFO - Running setup.py (path:/tmp/pip-EMxOb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:35 INFO - Running setup.py (path:/tmp/pip-DlccdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:15:35 INFO - Running setup.py (path:/tmp/pip-UzceOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:15:35 INFO - Running setup.py (path:/tmp/pip-PQ9_2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:15:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:37 INFO - Downloading blessings-1.6.tar.gz 10:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:15:37 INFO - Installing collected packages: blessings 10:15:37 INFO - Running setup.py install for blessings 10:15:37 INFO - Successfully installed blessings 10:15:37 INFO - Cleaning up... 10:15:37 INFO - Return code: 0 10:15:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:15:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:15:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:15:37 INFO - Reading from file tmpfile_stdout 10:15:37 INFO - Current package versions: 10:15:37 INFO - argparse == 1.2.1 10:15:37 INFO - blessings == 1.6 10:15:37 INFO - blobuploader == 1.2.4 10:15:37 INFO - docopt == 0.6.1 10:15:37 INFO - functools32 == 3.2.3-2 10:15:37 INFO - jsonschema == 2.5.1 10:15:37 INFO - manifestparser == 1.1 10:15:37 INFO - mozInstall == 1.12 10:15:37 INFO - mozcrash == 0.17 10:15:37 INFO - mozdebug == 0.1 10:15:37 INFO - mozdevice == 0.48 10:15:37 INFO - mozfile == 1.2 10:15:37 INFO - mozhttpd == 0.7 10:15:37 INFO - mozinfo == 0.9 10:15:37 INFO - mozleak == 0.1 10:15:37 INFO - mozlog == 3.4 10:15:37 INFO - moznetwork == 0.27 10:15:37 INFO - mozprocess == 0.23 10:15:37 INFO - mozprofile == 0.28 10:15:37 INFO - mozrunner == 6.12 10:15:37 INFO - mozscreenshot == 0.1 10:15:37 INFO - mozsystemmonitor == 0.3 10:15:37 INFO - moztest == 0.7 10:15:37 INFO - mozversion == 1.4 10:15:37 INFO - psutil == 3.1.1 10:15:37 INFO - requests == 1.2.3 10:15:37 INFO - wsgiref == 0.1.2 10:15:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:37 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 0x7f746f135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a4790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a1930>, '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 0x27a2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:15:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:15:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:15:37 INFO - Using env: {'DISPLAY': ':0', 10:15:37 INFO - 'HOME': '/home/cltbld', 10:15:37 INFO - 'LANG': 'en_US.UTF-8', 10:15:37 INFO - 'LANGUAGE': 'en_US:en', 10:15:37 INFO - 'LOGNAME': 'cltbld', 10:15:37 INFO - 'MAIL': '/var/mail/cltbld', 10:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:37 INFO - 'MOZ_NO_REMOTE': '1', 10:15:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:37 INFO - 'NO_EM_RESTART': '1', 10:15:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:37 INFO - 'PWD': '/builds/slave/test', 10:15:37 INFO - 'SHELL': '/bin/bash', 10:15:37 INFO - 'SHLVL': '1', 10:15:37 INFO - 'TERM': 'linux', 10:15:37 INFO - 'TMOUT': '86400', 10:15:37 INFO - 'USER': 'cltbld', 10:15:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 10:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:37 INFO - '_': '/tools/buildbot/bin/python'} 10:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:15:37 INFO - Cleaning up... 10:15:37 INFO - Return code: 0 10:15:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f746f135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a4790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a1930>, '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 0x27a2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:15:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:15:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:15:37 INFO - Using env: {'DISPLAY': ':0', 10:15:37 INFO - 'HOME': '/home/cltbld', 10:15:37 INFO - 'LANG': 'en_US.UTF-8', 10:15:37 INFO - 'LANGUAGE': 'en_US:en', 10:15:37 INFO - 'LOGNAME': 'cltbld', 10:15:37 INFO - 'MAIL': '/var/mail/cltbld', 10:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:37 INFO - 'MOZ_NO_REMOTE': '1', 10:15:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:37 INFO - 'NO_EM_RESTART': '1', 10:15:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:37 INFO - 'PWD': '/builds/slave/test', 10:15:37 INFO - 'SHELL': '/bin/bash', 10:15:37 INFO - 'SHLVL': '1', 10:15:37 INFO - 'TERM': 'linux', 10:15:37 INFO - 'TMOUT': '86400', 10:15:37 INFO - 'USER': 'cltbld', 10:15:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 10:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:37 INFO - '_': '/tools/buildbot/bin/python'} 10:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:15:38 INFO - Cleaning up... 10:15:38 INFO - Return code: 0 10:15:38 INFO - Running post-action listener: _resource_record_post_action 10:15:38 INFO - Running post-action listener: _start_resource_monitoring 10:15:38 INFO - Starting resource monitoring. 10:15:38 INFO - [mozharness: 2016-10-14 17:15:38.202883Z] Finished create-virtualenv step (success) 10:15:38 INFO - [mozharness: 2016-10-14 17:15:38.203343Z] Running install step. 10:15:38 INFO - Running pre-action listener: _resource_record_pre_action 10:15:38 INFO - Running main action method: install 10:15:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:15:38 INFO - Reading from file tmpfile_stdout 10:15:38 INFO - Detecting whether we're running mozinstall >=1.0... 10:15:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:15:38 INFO - Reading from file tmpfile_stdout 10:15:38 INFO - Output received: 10:15:38 INFO - Usage: mozinstall [options] installer 10:15:38 INFO - Options: 10:15:38 INFO - -h, --help show this help message and exit 10:15:38 INFO - -d DEST, --destination=DEST 10:15:38 INFO - Directory to install application into. [default: 10:15:38 INFO - "/builds/slave/test"] 10:15:38 INFO - --app=APP Application being installed. [default: firefox] 10:15:38 INFO - mkdir: /builds/slave/test/build/application 10:15:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:15:55 INFO - Reading from file tmpfile_stdout 10:15:55 INFO - Output received: 10:15:55 INFO - /builds/slave/test/build/application/firefox/firefox 10:15:55 INFO - Running post-action listener: _resource_record_post_action 10:15:55 INFO - [mozharness: 2016-10-14 17:15:55.561649Z] Finished install step (success) 10:15:55 INFO - [mozharness: 2016-10-14 17:15:55.561924Z] Running run-tests step. 10:15:55 INFO - Running pre-action listener: _resource_record_pre_action 10:15:55 INFO - Running main action method: run_tests 10:15:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:15:55 INFO - Python 2.7.3 10:15:55 INFO - Return code: 0 10:15:55 INFO - grabbing minidump binary from tooltool 10:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:55 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 0x27a1930>, '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 0x27a2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:15:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:15:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:15:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:15:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:15:55 INFO - Return code: 0 10:15:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:15:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:15:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:15:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:15:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:15:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:15:55 INFO - Using env: {'DISPLAY': ':0', 10:15:55 INFO - 'HOME': '/home/cltbld', 10:15:55 INFO - 'LANG': 'en_US.UTF-8', 10:15:55 INFO - 'LANGUAGE': 'en_US:en', 10:15:55 INFO - 'LOGNAME': 'cltbld', 10:15:55 INFO - 'MAIL': '/var/mail/cltbld', 10:15:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:15:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:55 INFO - 'MOZ_NO_REMOTE': '1', 10:15:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:15:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:55 INFO - 'NO_EM_RESTART': '1', 10:15:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:55 INFO - 'PWD': '/builds/slave/test', 10:15:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:15:55 INFO - 'SHELL': '/bin/bash', 10:15:55 INFO - 'SHLVL': '1', 10:15:55 INFO - 'TERM': 'linux', 10:15:55 INFO - 'TMOUT': '86400', 10:15:55 INFO - 'USER': 'cltbld', 10:15:55 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894', 10:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:55 INFO - '_': '/tools/buildbot/bin/python'} 10:15:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:15:55 INFO - mozversion application_buildid: 20161014063009 10:15:55 INFO - mozversion application_changeset: 68f7f7949d1770ea1a99b822dff2fd2122187672 10:15:55 INFO - mozversion application_display_name: Nightly 10:15:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:15:55 INFO - mozversion application_name: Firefox 10:15:55 INFO - mozversion application_remotingname: firefox 10:15:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 10:15:55 INFO - mozversion application_vendor: Mozilla 10:15:55 INFO - mozversion application_version: 52.0a1 10:15:55 INFO - mozversion platform_buildid: 20161014063009 10:15:55 INFO - mozversion platform_changeset: 68f7f7949d1770ea1a99b822dff2fd2122187672 10:15:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 10:15:55 INFO - mozversion platform_version: 52.0a1 10:15:55 INFO - using testdate: 1476465355 10:15:55 INFO - actual date: 1476465355 10:15:55 INFO - starting webserver on 'localhost:50780' 10:15:55 INFO - SUITE-START | Running 2 tests 10:15:55 INFO - TEST-START | dromaeo_css 10:15:55 INFO - operating with platform_type : linux_ 10:15:55 INFO - Initialising browser for dromaeo_css test... 10:15:55 INFO - TEST-INFO | started process 9430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIMoEkZ/profile http://localhost:50780/getInfo.html) 10:16:00 INFO - PROCESS | 9430 | __metrics Screen width/height:1600/1200 10:16:00 INFO - PROCESS | 9430 | colorDepth:24 10:16:00 INFO - PROCESS | 9430 | Browser inner width/height: 1024/697 10:16:00 INFO - PROCESS | 9430 | __metrics 10:16:00 INFO - PROCESS | 9430 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:16:00 INFO - PROCESS | 9430 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:16:01 INFO - PROCESS | 9430 | console.error: PushService: 10:16:01 INFO - PROCESS | 9430 | stateChangeProcessEnqueue: Error transitioning state 10:16:01 INFO - PROCESS | 9430 | UnknownError 10:16:02 INFO - TEST-INFO | 9430: exit 0 10:16:02 INFO - Browser initialized. 10:16:02 INFO - Running cycle 1/1 for dromaeo_css test... 10:16:02 INFO - TEST-INFO | started process 9515 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIMoEkZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:14 INFO - PROCESS | 9515 | RSS: Main: 171892736 10:16:14 INFO - PROCESS | 9515 | 10:17:06 INFO - PROCESS | 9515 | 1476465426112 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:19:16 INFO - PROCESS | 9515 | Cycle 1(1): loaded http://localhost:50780/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50780/tests/dromaeo/cssquery-ext.html) 10:19:18 INFO - PROCESS | 9515 | RSS: Main: 274464768 10:19:18 INFO - PROCESS | 9515 | 10:22:20 INFO - PROCESS | 9515 | Cycle 1(1): loaded http://localhost:50780/tests/dromaeo/cssquery-ext.html (next: http://localhost:50780/tests/dromaeo/cssquery-jquery.html) 10:22:21 INFO - PROCESS | 9515 | RSS: Main: 273752064 10:22:21 INFO - PROCESS | 9515 | 10:25:23 INFO - PROCESS | 9515 | Cycle 1(1): loaded http://localhost:50780/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50780/tests/dromaeo/cssquery-mootools.html) 10:25:23 INFO - PROCESS | 9515 | RSS: Main: 257613824 10:25:23 INFO - PROCESS | 9515 | 10:28:26 INFO - PROCESS | 9515 | Cycle 1(1): loaded http://localhost:50780/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50780/tests/dromaeo/cssquery-prototype.html) 10:28:26 INFO - PROCESS | 9515 | RSS: Main: 266567680 10:28:26 INFO - PROCESS | 9515 | 10:31:29 INFO - PROCESS | 9515 | Cycle 1(1): loaded http://localhost:50780/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50780/tests/dromaeo/cssquery-yui.html) 10:31:30 INFO - PROCESS | 9515 | RSS: Main: 215617536 10:31:30 INFO - PROCESS | 9515 | 10:34:32 INFO - PROCESS | 9515 | Cycle 1(1): loaded http://localhost:50780/tests/dromaeo/cssquery-yui.html (next: http://localhost:50780/tests/dromaeo/cssquery-dojo.html) 10:34:33 INFO - PROCESS | 9515 | RSS: Main: 302682112 10:34:33 INFO - PROCESS | 9515 | 10:34:33 INFO - PROCESS | 9515 | __start_tp_report 10:34:33 INFO - PROCESS | 9515 | _x_x_mozilla_page_load 10:34:33 INFO - PROCESS | 9515 | _x_x_mozilla_page_load_details 10:34:33 INFO - PROCESS | 9515 | |i|pagename|runs| 10:34:33 INFO - PROCESS | 9515 | |0;dojo.html;3005.744511716504;3046.8324242166686;3057.7859549831505;3081.9229519262003;3111.144435280298;5157.896842063156;5242.606804489659;5334.839954801358;5420.5392541633955;5447.400785913546;5294.285271488348;5398.163284690879;5413.106837371839;5434.402215756273;5441.129419292914;4870.391201099863;4905.583025442842;4935.679180853251;4952.3561936948145;5010.023045506127;4884.3644989128325;4996.500349964993;5004.599632029429;5065.290859279704;5124.641275110744;4973.676711013809;5015.648904576681;5052;5074.949250507503;5112.233165025239;4712.0811441768865;4739.668223224376;4743.0988112258565;4809.687370320918;4889.33993910821;4811.518848115195;4816.759162041884;4836;4945.950540494585;4959.429665588467;5308.867278318035;5367.677939323614;5380.354357477127;5389.083855744533;5437.211604317391;5579.721013949286;5642.322921249435;5717;5725.685087320196;5725.914111288293;5646.18130371098;5731.111677689964;5744.770209191627;5744.770209191627;5751.25233719618;5396;5400.891982160335;5402.945970540323;5403.5136837684795;5404.135338345845;5562.332520097614;5859.53123750099;5861.472467477862;5861.560382971209;5868.823935281948;5385.219143224211;5554.028045092093;5686.459786320293;5687.60186786921;5778.133280007948;5769.567282453832;5779.595428319977;5779.913301300484;5780.1907732917425;5781;5718.942810571924;5763.88472230553;5773.1051686988585;5775.249217601685;5864.824055278348;5517.531009864207;5587.078132108157;5589.664620122806;5668.971655141698;5674.858128546819;4356.695031347838;4370.912581748411;4380.8685739427865;4383.956160438354;4388.802503887333;3856.0745421099296;3889.4554762333296;3917.9421556179673;3973.48344715191;3979.7413168143976;5416.21464887597;5418.756155972991;5419.647722897999;5430.972845135828;5432.701201433959;5621.606487545832;5697.401772813878;5701.173329867146;5707.315122185364;5745.253117094751;5252.474752524793;5305.681659100466;5362.008028514737;5463.344398672185;5465.207544905967;5025.246213068069;5026.170681837529;5027.1956486962645;5027.547520723152;5073.086844368049;5994.160046560509;6032.969835150796;6039.124326972565;6039.305479869783;6039.939600604113;5591.552675785846;5654.547636189177;5684;5778.884422311614;5825.563082768725;6079.4603069406685;6080.813677378671;6090.318742873998;6093.847633972344;6133.7546498141355;5699.772009119589;5702;5706.343770466449;5711.514521265739;5778.306603207642;5550.417206193291;5611.410801865909;5682.176084467646;5797.101449275369;5801.6519008859605;5616;5633.549316054624;5650.915236271377;5718.456746609066;5736.368999410145;5637.830865074055;5638.971805140948;5654.886902262014;5655.915161272502;5666.15007748841;5388.2725832012175;5442.4285450028765;5622.156676498558;5627.380988091389;5640.32316122068;5451.127819548853;5550.666959982253;5562.749676264659;5622.016147174147;5675.148727690715;5455.208994695826;5464.316960379952;5464.726763661722;5470.261514695465;5493.7802487900035 10:34:33 INFO - PROCESS | 9515 | |1;ext.html;583.1777194156241;605.391581460632;628.403017133723;638.5274896576532;639.7057353617336;31690.841545792267;41801;42849;42882.57117428825;42996;44992.775036124855;45350;45422.318665219966;45481.772591137;45495.545044549624;8045.235702608243;8231.711890083849;8921.643134274622;9077.773055673628;9081.228095611881;10542.578296868154;10781.1375089993;10782.676519704382;11160.330380177214;11166.66500004997;10928.781424371507;11037.779244415107;11042.116630669567;11044.282121662107;11045.613403530879;10789.568417263301;10804.459777011118;10845;10854.185936054748;10854.891451085467;10671.19966002553;10704.946475267652;10729.785404291948;10732.497450356956;10734.302270352402;42091.1581768366;42241;42476.57523424757;42498.15003699909;42520.574794251974;3215.244417561871;3301.224212310105;3312.38720836646;3328.467445208755;3362.882299119519;32052.679473205204;32121.839390802896;32196;32702.836485817417;33795.493067604;4032.34651856136;4194.517630472505;4263.445752052245;4265.7014009019385;4322.481302243751;334011;335695;336525;336830;338514.30742846377;33307.500387494205;61168;61660.07509887355;61934.38065619286;61941.69029154915;34461.48307775385;36039.639603604155;36311;36609.08477288036;36618.81690591583;13091.541796037092;13189.934050329879;13200.933995329962;13204.735905281841;13206.669833254246;9781.755456113655;10036.698899033041;10209.234307426825;10660.307080039773;10715;8059.113497515269;8131.227533384319;8164.387670924704;8274.089850116483;8278.710245141512;3122.2350524121734;3168.419685755082;3171.9682803172136;3197.2326641606314;3203.727683146912;961.8653388525612;1066.1524088349781;1144.3420033480782;1151.3955173533793;1182.6215611004568;31623.36753264922;32320;32321.191970200463;32594.348113037606;32692;1013.6249587652616;1018.6180182431589;1022.5654097008742;1059.2055958031476;1102.2504696806088;15991.28039238237;16823.915880420518;16890.83109168917;16893.292119626465;17128.97226166434;503947;506423;506541;507151;507605;56261.437385626436;56952;56971;57023;57087.714561426925;1170.777552265067;1211.1642966353363;1228.8586812516496;1267.3853181207107;1316.0524422415845;28732.425351492435;31875.20311992126;33217.83391083029;34461;34842.82578587091;53248.4675153259;54291.72854135704;54358.45641543692;54441.183382248506;54464.72767636136;400363;403856;404645;406004;406344;23643.64534532018;24226.75773242245;26041;27354.179374618794;27680.86159569189;42516.36225456559;46732.766336168104;46892;47007.29489057735;47569;38983.87641901502;39100.608993910835;39793.20413591654;41072.589274108075;41472.170556589306;38941.2741108131;39106;39925.60074399335;40135.79932100321;41281;39106;39652.80173599229;40346.79826600848;40353.39469907895;40445;30735.846320768254;35815.82092089523;37050.25899482049;39289.21421571496;39915;28104.71895281021;28186.71813281841;28337.29156771097;28454.146375608765;28571.571426428203 10:34:33 INFO - PROCESS | 9515 | |2;jquery.html;371.46323562452267;380.0631443491793;385.1334497380893;402.04313733314706;410.5894105894106;17091;18886.33897813577;19567.41297761068;19764.802351976494;19774.20903163872;17674.911625441888;18158.364457244;18410.907945460287;18746.062696865138;18791.624167516675;5018.34761481007;5118.641695081336;5301.151815709487;5305.283786688806;5306.7611957462;5138.665986710852;5230.476952304777;5238.397584277819;5245.68525888446;5253.343332083489;5244.318238628973;5245.79016839326;5250.6324557281005;5251.527362537371;5262.184361423985;5553.250311207996;5610.747516361774;5645.745941432645;5646;5653.321601407857;4867.975660121677;4997.475265097149;5021.44764075955;5090.516400941905;5094.490550944913;13649.590512284647;13755.449782008807;13801.861981380158;13878.583642490741;13887.58337249884;2376.6316220985773;2396.628522579003;2788.9023884163958;2884.7115288471196;2935.412917416525;9407.858882116705;9795.314327997043;10410.947945260225;10425.218108641806;10442.425666588335;1842.4196378140978;1877.5493881468349;1879.755631767875;1896.2035944903173;1922.0485859499497;73901.6304918472;74101.62949185274;74437.25562744412;79414.60292698558;84470.57764711136;10499.527521261562;10532.420716860646;10651.414172220448;10818.24272300947;10821.188410869216;15315;15318.540443786704;15321.540353789404;15333.463328783662;15355.92322038405;7099.609521476368;7204.243554426815;7320.231375705581;7343.192248852622;7482.8877566836545;6613.933860661332;6614.933850661528;6887.827804304832;6922.826929326707;6927.376536111774;4530.909381812346;4551.749653769009;4632.884177895579;4635.397398338195;4707.6233901287815;1733.9393121240696;1843.3640394064028;1847.6027654054174;1852.666520026408;1904.3144467991513;850.1583432402001;930.4789317981952;960.2941837749248;1016.1464369929295;1067.9038886500252;18473;19097.331593394163;19314.806851931582;19477.90261048714;19591.902040489706;925.6251218256482;926.1063074133493;941.4210260689764;957.0477375011908;980.4656462228103;9792.363496372713;10458.477076146315;10658.092218390042;10683.14534837211;10688.091512221392;437528;444115.29660533095;444771;445868;449333;86651.56674216715;87607;87609;90003.54998224966;90337;982.29274922056;1033.452270296744;1040.6201736366172;1040.698197522725;1049.8477720730452;16066.43767468133;16218.513444596681;16491.505254842374;16714.665706686043;16914.577135571708;40381.59618403896;40709.389359159046;40885.740120629795;41080.38379424251;42913.35629965615;52211;52684;52763.472365275855;60310.698446507486;61874;8138.959305203436;8174.141715120065;8461.196186362286;8569.442986206126;8620.310375169845;11270.661880143609;12610.36948152607;12676;12921.160124592247;13105.67235819074;10355.94822025885;10464.581416743245;11010.50452729613;11053.613123540637;11573.826392603949;10767.515461804081;10892;11001.394923279297;11114.38870862078;11216.158788090763;11319.490622921823;11480.368579727861;11573;11729.003034741801;12494.500219991462;8360.916390836013;8453.66185352579;8665.826683466421;8686.565671716262;8704.129587041498;10715.678529644123;10969.286996345212;11002.559897604006;11253.66239012831;11496.425178741198 10:34:33 INFO - PROCESS | 9515 | |3;mootools.html;1369.9452021919124;1480.3560451203723;1516.0903457925242;1629.7962754655669;1814.1020195003475;7608.391328693705;8420.915790842097;8716.782080448;8785.60464779085;9007.504587247699;8835.779105522364;8881.555922203896;8902.599383027764;8907.376483646147;8913;2180.738311402634;2215.6565732311437;2216.434809123671;2217.301550011749;2223.132978138527;2180.465785882453;2217.3126330837413;2222.75549689534;2224.4883676754357;2233.832462565306;2204.437868343578;2216.213244298275;2217.5675743230076;2220.9333719988426;2264.3546589222074;2180.2478145039936;2195.2645863635703;2202.8347873909443;2203.173809821317;2209.2046863129262;2154.3213887625348;2177.150911144655;2191.7808219178114;2194.6049711052005;2201.3506015725397;8713.69502067431;8764.123587641248;8765.517896515688;8774.956125219396;8779.604917778715;5139;5306.946930530684;5321.467853214686;5344.839654810362;5347.385050719178;3207.5349074384317;3356.16095976006;3437.4671925851535;3438.157651375404;3446.827658617084;1006.099540910888;1050.5902697947806;1064.984025239622;1071.539238127605;1077.439731339699;12161.574344897974;12244.571439999558;12290.508379664803;12339.876601233962;12380.690482738004;4330.328799036154;4507.256302710016;4600.35595016698;4664.906701865943;4684.695494792828;9614.807703845883;9634.03659634031;9635.662751803653;9644.276679249084;9645.08371704687;5207.505286997805;5220.660657057279;5231.581473482112;5248.6588371755715;5250.3962044364625;3977.5624681285035;4204.684648651363;4300;4887.535684110004;4912.091263116335;3602.189507360823;3690.6493883081066;3697.131174174067;3765.1904840458883;3783.508143941325;1158.9652310430702;1162.2271189658952;1182.1606659272013;1183.4792691215837;1185.4428418643224;910.9590068446936;924.6763632728625;938.9342746007713;947.6114792934864;969.1665167955553;5649.971750141223;5673.042800233913;5769.480746732815;5904.763809447574;5976.9402305977255;883.8055627762011;947.313197931508;958.1951161024773;980.3725615606018;982.3172894838019;3722.664960153545;3796.886093417202;3909.139989202371;3910.178862438863;4012.61880121388;10544.841827372595;10995.670129896116;10998.780024399468;11024.50389732464;11029.227954043301;10646.201534884915;10774.138068954464;10918.1811364148;10926.945365273281;10946.781064378667;7997.6800927963395;8086.919130808734;8090.231428014447;8105.918940810634;8108.716194933031;5555.583331250254;5570.080936645571;5590.720463976866;5679.290088738908;5720.628159169641;9697.127258546765;9747.415155090433;9808.607655693977;9882.802343952937;9995.350302230332;8975.192232698828;9642.373245739005;10049.849252261369;10176.592936282466;10219.335743176669;6627.734890604322;7149.714011439484;7422.96288518554;7424.406047516294;7573.962130189314;8274.917250827415;8353.457025293337;8373.665053397795;8544.18830211129;8622.78443038929;7579.924200757921;7683.078030636136;7695.92304076952;7710.383169346551;7762.8447431049935;7390.076240469942;7415.184329723834;7471.551706897603;7527.473076884566;7744.1094274159195;6601.33986601336;6782.287859774653;6829.351211634887;6846.760363387258;6864.279250678607;4961.925571116364;4983.551480366785;5026.120428924996;5027.673201241908;5064.189729643387;5059.215821547666;5152.381714194321;5213.817516386908;5249.055170069424;5267.656747529356 10:34:33 INFO - PROCESS | 9515 | |4;prototype.html;317.9920501987451;319.1351437604093;329.6522169111587;337.0864955969323;338.08042125418854;5217.643412712703;5250.291210686556;5256.106461901476;5295.6028297877665;5314.415414304423;5209.687418754868;5234.18870075138;5244.737763111839;5254.8686282842855;5267.894642107156;4061.512618485786;4066.9186616267657;4069.125138095309;4069.857554985576;4089.5910408959016;3809.3904975203836;3861.4940173332425;3903;4020.8994775130564;4103.343465045593;4028.5769994150633;4045.37296719009;4047.7773722445254;4050.392441133839;4071.4707088078508;4021.4369988201674;4036.7174297799165;4043.939340909889;4048.8380464781667;4053.2906741320444;3365.4278772608714;3477.547918770569;3572.964270357289;3576.910577235564;3596.8381422836037;4942.703437793743;5087.516685914869;5089.796408143669;5109.054824857413;5127.7948882044675;4568.908621827578;4577.267637178035;4605.815767369301;4612.238980568236;4655.441347038377;5170.508801663836;5441.782328706847;5453.4273901240595;5467.753951072172;5495.6427832191175;3920.3335432976464;3924.7056470764524;3925.60743925608;3927.9410808837893;3949.8420063197436;5377.085895397752;5589.46900044491;5636.577256705723;5660.971695141539;5686.516646085088;3805.372113601225;3899.5710471848074;3911.6283953024417;3929.7052721046034;3933.9213215735526;3960.4653371795016;3961.980190099031;3967.8016099194924;4001.2597669430666;4008.3386241270446;4544.88637784058;4587.770611469413;4631.235846085426;4631.606313463393;4653.7207767534055;5236.450172731885;5422.864428389243;5434.3207099112615;5446.1558458439;5456;1378.855549893586;1395.6580637743818;1396.8393634731933;1397.699494608664;1406.542873566095;817.9345652347798;852.5012867472598;888.8000199955088;897.3583887520455;899.7030979776658;4728.935989402426;4742.241241401359;4753.215719406328;4753.786079626425;4755.690880092852;4957.529034741694;4958.355413796184;4965.230389289666;4965.751712414365;5024.346834911438;4735.739534325577;4750.643701722384;4756.619470442356;4804.615630749532;4967.5032496750755;2958.8668509917106;2978.9702102978695;2981.567672687448;3001.3792552021664;3010.9548356774667;5840.561957853178;5846.386129456431;5851.268591426072;5912.733926973297;5918.319393269743;5545.805896793593;5672.205891175238;5674.659520428788;5731.598788084877;5766.365699773021;5694.829155125353;5712.200291959129;5734.623690314294;5768.3654797972185;5786.942130578725;5383.703896285742;5532.2254884315425;5569.944300557105;5597.216389705526;5651.406602306863;5489.231507588861;5511.476409741068;5518.392976772632;5523.33719953592;5542.889142217053;5522.542468601594;5693.459121383462;5698.686572238566;5823.563232757476;5836.358000619844;3969.3649016158433;3989.401589761443;3990.062335351132;4002.4396584477613;4016.9799151005227;5623.718814059363;5625.76233228689;5645.181448689999;5646.927083854054;5668.858278543069;5320.494553017457;5476.342838859362;5494.450554944474;5517.2551705519245;5517.779288828402;5488.506034456918;5507.779688812563;5524.171374293888;5524.723763811874;5535.169724541351;5331.120365139708;5444.8094316698725;5462.49781310127;5471.644343117685;5485.149801780731;5504.2203687137735;5555;5566.638168519034;5567.972160139173;5576.275084239023;5425.077736784677;5436.184572314184;5454.836354909359;5466;5466.890662186814 10:34:33 INFO - PROCESS | 9515 | |5;yui.html;758.7799538133942;790.5217343507178;829.232959512451;833.2917020532544;837.8617528107862;13737.24445155516;14295;14348.641283967907;14484.49304274348;16140.677186456263;14692;15011.624709382271;15018.174000429972;15019.32413041413;15025.774613380809;664.7008846019287;813.8941937548125;830.7839961609994;831.8627426474625;833.4291010657688;682.9726810927557;693.414065114977;695.1484431571309;696.3210869402343;788.2708494642461;865.6061492021115;868.682930730282;876.1545108969843;876.242050626207;876.3120950054209;862.8360611483798;864.3517361978517;864.4985908173245;864.5979619476942;865.5888452984844;512.6437126197294;529.9947000529984;639.0222958872932;642.4828013449171;647.2459584583954;14335.78496322556;14696.706065878623;14817.851821481754;15449.459268925646;15449.613759655986;14946.62633434162;15529;15632.687346253126;15852.60368490797;15983.600409989727;11889.881101188965;12014.399280035963;12108.101671537173;12171.391430428443;12218.938905305506;3854.8458061677497;3855.132595166065;3883.4951456310782;3943.132510847609;3959.326914424526;81172;83278.16721832765;83311;83608;86467.56766216128;11798.41007949599;11948;11986.220895641756;12036.157468977262;12215.633530993906;22835.200767973372;23078.884605576866;23154.884225578764;23192.304230873102;23892.641610375857;8334.12491688364;8668;8697.521636310064;8749.387542871938;8903.955480222558;4687.906241875144;4704.1062198182235;4768.856934291976;4782.856514304576;4859.611231101503;3502.7898326100517;3590.8563657453933;3624.655657712513;3631.654992775682;3632.9636703632627;636.1570918532963;641.8959389849451;650.222983534681;658.7976942080721;682.0247046723233;522.4931816138339;589.5902347868276;593.6972144206486;663.1776597019757;667.2693400726197;9074.228690561244;9571.425714457155;9571.760705982406;9577.23382129428;9799.412035277763;600.9879802404015;631.0880777276883;640.6316368088368;668.6322522612544;701.4633805139073;4379.802908869108;4645.558671926162;4666.440027196758;4722.929156062662;4822.474286455375;88894.55552722195;117871.41064294624;127340;128533;129477;103002.48498757608;106905.46547267369;107894.57897578354;109875.45062274797;111227;57983;92271.5386423077;93213;95661;97265.99999999859;9019.864702029607;9087.909120908971;9113.074222493691;9175.128362805523;9394.389364691273;53711;53884;54444.455555443936;54873.1769023457;55384.44615553954;46158.30762538632;46333.305000425695;79091;80288.59855700684;81160.59419702864;11168.162387820783;11381.715457113638;11549.82675259855;11952.58165964187;12186.451609677408;12958.629959675336;13087.41106650184;13234.139780914209;13572;13656.863431365558;11208.27146235492;11711.1802173847;11966.278746474763;12548.18436801605;12571.26397965864;11656;12017.038636908852;13295.80056299137;13328.533501327407;13345.66635834073;12867.22796632205;13017.303999124337;13075.542356017875;13435.529756458476;13553.79669304981;10449.843252351373;10974.176936729618;11231;11383;11470.139739519736;11201.88798112041;11409.54361825551;11548.653540393801;11556.364399958084;11750.88249117532 10:34:33 INFO - PROCESS | 9515 | __end_tp_report 10:34:33 INFO - PROCESS | 9515 | __start_cc_report 10:34:33 INFO - PROCESS | 9515 | _x_x_mozilla_cycle_collect,1054 10:34:33 INFO - PROCESS | 9515 | __end_cc_report 10:34:33 INFO - PROCESS | 9515 | __startTimestamp1476466473193__endTimestamp 10:34:33 INFO - PROCESS | 9515 | 10:34:33 INFO - PROCESS | 9515 | ------- Summary: start ------- 10:34:33 INFO - PROCESS | 9515 | Number of tests: 6 10:34:33 INFO - PROCESS | 9515 | 10:34:33 INFO - PROCESS | 9515 | [#0] dojo.html Cycles:165 Average:5338.26 Median:5470.26 stddev:608.85 (11.1%) stddev-sans-first:582.57 10:34:33 INFO - PROCESS | 9515 | Values: 3005.7 3046.8 3057.8 3081.9 3111.1 5157.9 5242.6 5334.8 5420.5 5447.4 5294.3 5398.2 5413.1 5434.4 5441.1 4870.4 4905.6 4935.7 4952.4 5010.0 4884.4 4996.5 5004.6 5065.3 5124.6 4973.7 5015.6 5052.0 5074.9 5112.2 4712.1 4739.7 4743.1 4809.7 4889.3 4811.5 4816.8 4836.0 4946.0 4959.4 5308.9 5367.7 5380.4 5389.1 5437.2 5579.7 5642.3 5717.0 5725.7 5725.9 5646.2 5731.1 5744.8 5744.8 5751.3 5396.0 5400.9 5402.9 5403.5 5404.1 5562.3 5859.5 5861.5 5861.6 5868.8 5385.2 5554.0 5686.5 5687.6 5778.1 5769.6 5779.6 5779.9 5780.2 5781.0 5718.9 5763.9 5773.1 5775.2 5864.8 5517.5 5587.1 5589.7 5669.0 5674.9 4356.7 4370.9 4380.9 4384.0 4388.8 3856.1 3889.5 3917.9 3973.5 3979.7 5416.2 5418.8 5419.6 5431.0 5432.7 5621.6 5697.4 5701.2 5707.3 5745.3 5252.5 5305.7 5362.0 5463.3 5465.2 5025.2 5026.2 5027.2 5027.5 5073.1 5994.2 6033.0 6039.1 6039.3 6039.9 5591.6 5654.5 5684.0 5778.9 5825.6 6079.5 6080.8 6090.3 6093.8 6133.8 5699.8 5702.0 5706.3 5711.5 5778.3 5550.4 5611.4 5682.2 5797.1 5801.7 5616.0 5633.5 5650.9 5718.5 5736.4 5637.8 5639.0 5654.9 5655.9 5666.2 5388.3 5442.4 5622.2 5627.4 5640.3 5451.1 5550.7 5562.7 5622.0 5675.1 5455.2 5464.3 5464.7 5470.3 5493.8 10:34:33 INFO - PROCESS | 9515 | 10:34:33 INFO - PROCESS | 9515 | [#1] ext.html Cycles:180 Average:56876.68 Median:34652.15 stddev:111718.28 (322.4%) stddev-sans-first:111951.72 10:34:33 INFO - PROCESS | 9515 | Values: 583.2 605.4 628.4 638.5 639.7 31690.8 41801.0 42849.0 42882.6 42996.0 44992.8 45350.0 45422.3 45481.8 45495.5 8045.2 8231.7 8921.6 9077.8 9081.2 10542.6 10781.1 10782.7 11160.3 11166.7 10928.8 11037.8 11042.1 11044.3 11045.6 10789.6 10804.5 10845.0 10854.2 10854.9 10671.2 10704.9 10729.8 10732.5 10734.3 42091.2 42241.0 42476.6 42498.2 42520.6 3215.2 3301.2 3312.4 3328.5 3362.9 32052.7 32121.8 32196.0 32702.8 33795.5 4032.3 4194.5 4263.4 4265.7 4322.5 334011.0 335695.0 336525.0 336830.0 338514.3 33307.5 61168.0 61660.1 61934.4 61941.7 34461.5 36039.6 36311.0 36609.1 36618.8 13091.5 13189.9 13200.9 13204.7 13206.7 9781.8 10036.7 10209.2 10660.3 10715.0 8059.1 8131.2 8164.4 8274.1 8278.7 3122.2 3168.4 3172.0 3197.2 3203.7 961.9 1066.2 1144.3 1151.4 1182.6 31623.4 32320.0 32321.2 32594.3 32692.0 1013.6 1018.6 1022.6 1059.2 1102.3 15991.3 16823.9 16890.8 16893.3 17129.0 503947.0 506423.0 506541.0 507151.0 507605.0 56261.4 56952.0 56971.0 57023.0 57087.7 1170.8 1211.2 1228.9 1267.4 1316.1 28732.4 31875.2 33217.8 34461.0 34842.8 53248.5 54291.7 54358.5 54441.2 54464.7 400363.0 403856.0 404645.0 406004.0 406344.0 23643.6 24226.8 26041.0 27354.2 27680.9 42516.4 46732.8 46892.0 47007.3 47569.0 38983.9 39100.6 39793.2 41072.6 41472.2 38941.3 39106.0 39925.6 40135.8 41281.0 39106.0 39652.8 40346.8 40353.4 40445.0 30735.8 35815.8 37050.3 39289.2 39915.0 28104.7 28186.7 28337.3 28454.1 28571.6 10:34:33 INFO - PROCESS | 9515 | 10:34:33 INFO - PROCESS | 9515 | [#2] jquery.html Cycles:180 Average:26930.53 Median:393.59 stddev:73453.57 (18662.5%) stddev-sans-first:73632.56 10:34:33 INFO - PROCESS | 9515 | Values: 371.5 380.1 385.1 402.0 410.6 17091.0 18886.3 19567.4 19764.8 19774.2 17674.9 18158.4 18410.9 18746.1 18791.6 5018.3 5118.6 5301.2 5305.3 5306.8 5138.7 5230.5 5238.4 5245.7 5253.3 5244.3 5245.8 5250.6 5251.5 5262.2 5553.3 5610.7 5645.7 5646.0 5653.3 4868.0 4997.5 5021.4 5090.5 5094.5 13649.6 13755.4 13801.9 13878.6 13887.6 2376.6 2396.6 2788.9 2884.7 2935.4 9407.9 9795.3 10410.9 10425.2 10442.4 1842.4 1877.5 1879.8 1896.2 1922.0 73901.6 74101.6 74437.3 79414.6 84470.6 10499.5 10532.4 10651.4 10818.2 10821.2 15315.0 15318.5 15321.5 15333.5 15355.9 7099.6 7204.2 7320.2 7343.2 7482.9 6613.9 6614.9 6887.8 6922.8 6927.4 4530.9 4551.7 4632.9 4635.4 4707.6 1733.9 1843.4 1847.6 1852.7 1904.3 850.2 930.5 960.3 1016.1 1067.9 18473.0 19097.3 19314.8 19477.9 19591.9 925.6 926.1 941.4 957.0 980.5 9792.4 10458.5 10658.1 10683.1 10688.1 437528.0 444115.3 444771.0 445868.0 449333.0 86651.6 87607.0 87609.0 90003.5 90337.0 982.3 1033.5 1040.6 1040.7 1049.8 16066.4 16218.5 16491.5 16714.7 16914.6 40381.6 40709.4 40885.7 41080.4 42913.4 52211.0 52684.0 52763.5 60310.7 61874.0 8139.0 8174.1 8461.2 8569.4 8620.3 11270.7 12610.4 12676.0 12921.2 13105.7 10355.9 10464.6 11010.5 11053.6 11573.8 10767.5 10892.0 11001.4 11114.4 11216.2 11319.5 11480.4 11573.0 11729.0 12494.5 8360.9 8453.7 8665.8 8686.6 8704.1 10715.7 10969.3 11002.6 11253.7 11496.4 10:34:33 INFO - PROCESS | 9515 | 10:34:33 INFO - PROCESS | 9515 | [#3] mootools.html Cycles:180 Average:5667.51 Median:5179.94 stddev:3261.30 (63.0%) stddev-sans-first:3254.45 10:34:33 INFO - PROCESS | 9515 | Values: 1369.9 1480.4 1516.1 1629.8 1814.1 7608.4 8420.9 8716.8 8785.6 9007.5 8835.8 8881.6 8902.6 8907.4 8913.0 2180.7 2215.7 2216.4 2217.3 2223.1 2180.5 2217.3 2222.8 2224.5 2233.8 2204.4 2216.2 2217.6 2220.9 2264.4 2180.2 2195.3 2202.8 2203.2 2209.2 2154.3 2177.2 2191.8 2194.6 2201.4 8713.7 8764.1 8765.5 8775.0 8779.6 5139.0 5306.9 5321.5 5344.8 5347.4 3207.5 3356.2 3437.5 3438.2 3446.8 1006.1 1050.6 1065.0 1071.5 1077.4 12161.6 12244.6 12290.5 12339.9 12380.7 4330.3 4507.3 4600.4 4664.9 4684.7 9614.8 9634.0 9635.7 9644.3 9645.1 5207.5 5220.7 5231.6 5248.7 5250.4 3977.6 4204.7 4300.0 4887.5 4912.1 3602.2 3690.6 3697.1 3765.2 3783.5 1159.0 1162.2 1182.2 1183.5 1185.4 911.0 924.7 938.9 947.6 969.2 5650.0 5673.0 5769.5 5904.8 5976.9 883.8 947.3 958.2 980.4 982.3 3722.7 3796.9 3909.1 3910.2 4012.6 10544.8 10995.7 10998.8 11024.5 11029.2 10646.2 10774.1 10918.2 10926.9 10946.8 7997.7 8086.9 8090.2 8105.9 8108.7 5555.6 5570.1 5590.7 5679.3 5720.6 9697.1 9747.4 9808.6 9882.8 9995.4 8975.2 9642.4 10049.8 10176.6 10219.3 6627.7 7149.7 7423.0 7424.4 7574.0 8274.9 8353.5 8373.7 8544.2 8622.8 7579.9 7683.1 7695.9 7710.4 7762.8 7390.1 7415.2 7471.6 7527.5 7744.1 6601.3 6782.3 6829.4 6846.8 6864.3 4961.9 4983.6 5026.1 5027.7 5064.2 5059.2 5152.4 5213.8 5249.1 5267.7 10:34:33 INFO - PROCESS | 9515 | 10:34:33 INFO - PROCESS | 9515 | [#4] prototype.html Cycles:180 Average:4551.36 Median:5190.10 stddev:1346.19 (25.9%) stddev-sans-first:1311.93 10:34:33 INFO - PROCESS | 9515 | Values: 318.0 319.1 329.7 337.1 338.1 5217.6 5250.3 5256.1 5295.6 5314.4 5209.7 5234.2 5244.7 5254.9 5267.9 4061.5 4066.9 4069.1 4069.9 4089.6 3809.4 3861.5 3903.0 4020.9 4103.3 4028.6 4045.4 4047.8 4050.4 4071.5 4021.4 4036.7 4043.9 4048.8 4053.3 3365.4 3477.5 3573.0 3576.9 3596.8 4942.7 5087.5 5089.8 5109.1 5127.8 4568.9 4577.3 4605.8 4612.2 4655.4 5170.5 5441.8 5453.4 5467.8 5495.6 3920.3 3924.7 3925.6 3927.9 3949.8 5377.1 5589.5 5636.6 5661.0 5686.5 3805.4 3899.6 3911.6 3929.7 3933.9 3960.5 3962.0 3967.8 4001.3 4008.3 4544.9 4587.8 4631.2 4631.6 4653.7 5236.5 5422.9 5434.3 5446.2 5456.0 1378.9 1395.7 1396.8 1397.7 1406.5 817.9 852.5 888.8 897.4 899.7 4728.9 4742.2 4753.2 4753.8 4755.7 4957.5 4958.4 4965.2 4965.8 5024.3 4735.7 4750.6 4756.6 4804.6 4967.5 2958.9 2979.0 2981.6 3001.4 3011.0 5840.6 5846.4 5851.3 5912.7 5918.3 5545.8 5672.2 5674.7 5731.6 5766.4 5694.8 5712.2 5734.6 5768.4 5786.9 5383.7 5532.2 5569.9 5597.2 5651.4 5489.2 5511.5 5518.4 5523.3 5542.9 5522.5 5693.5 5698.7 5823.6 5836.4 3969.4 3989.4 3990.1 4002.4 4017.0 5623.7 5625.8 5645.2 5646.9 5668.9 5320.5 5476.3 5494.5 5517.3 5517.8 5488.5 5507.8 5524.2 5524.7 5535.2 5331.1 5444.8 5462.5 5471.6 5485.1 5504.2 5555.0 5566.6 5568.0 5576.3 5425.1 5436.2 5454.8 5466.0 5466.9 10:34:33 INFO - PROCESS | 9515 | 10:34:33 INFO - PROCESS | 9515 | [#5] yui.html Cycles:180 Average:21160.84 Median:46245.81 stddev:31434.62 (68.0%) stddev-sans-first:31485.48 10:34:33 INFO - PROCESS | 9515 | Values: 758.8 790.5 829.2 833.3 837.9 13737.2 14295.0 14348.6 14484.5 16140.7 14692.0 15011.6 15018.2 15019.3 15025.8 664.7 813.9 830.8 831.9 833.4 683.0 693.4 695.1 696.3 788.3 865.6 868.7 876.2 876.2 876.3 862.8 864.4 864.5 864.6 865.6 512.6 530.0 639.0 642.5 647.2 14335.8 14696.7 14817.9 15449.5 15449.6 14946.6 15529.0 15632.7 15852.6 15983.6 11889.9 12014.4 12108.1 12171.4 12218.9 3854.8 3855.1 3883.5 3943.1 3959.3 81172.0 83278.2 83311.0 83608.0 86467.6 11798.4 11948.0 11986.2 12036.2 12215.6 22835.2 23078.9 23154.9 23192.3 23892.6 8334.1 8668.0 8697.5 8749.4 8904.0 4687.9 4704.1 4768.9 4782.9 4859.6 3502.8 3590.9 3624.7 3631.7 3633.0 636.2 641.9 650.2 658.8 682.0 522.5 589.6 593.7 663.2 667.3 9074.2 9571.4 9571.8 9577.2 9799.4 601.0 631.1 640.6 668.6 701.5 4379.8 4645.6 4666.4 4722.9 4822.5 88894.6 117871.4 127340.0 128533.0 129477.0 103002.5 106905.5 107894.6 109875.5 111227.0 57983.0 92271.5 93213.0 95661.0 97266.0 9019.9 9087.9 9113.1 9175.1 9394.4 53711.0 53884.0 54444.5 54873.2 55384.4 46158.3 46333.3 79091.0 80288.6 81160.6 11168.2 11381.7 11549.8 11952.6 12186.5 12958.6 13087.4 13234.1 13572.0 13656.9 11208.3 11711.2 11966.3 12548.2 12571.3 11656.0 12017.0 13295.8 13328.5 13345.7 12867.2 13017.3 13075.5 13435.5 13553.8 10449.8 10974.2 11231.0 11383.0 11470.1 11201.9 11409.5 11548.7 11556.4 11750.9 10:34:33 INFO - PROCESS | 9515 | -------- Summary: end -------- 10:34:33 INFO - PROCESS | 9515 | 10:34:34 INFO - TEST-INFO | 9515: exit 0 10:34:34 INFO - TEST-OK | dromaeo_css | took 1118347ms 10:34:34 INFO - TEST-START | kraken 10:34:34 INFO - operating with platform_type : linux_ 10:34:34 INFO - Initialising browser for kraken test... 10:34:34 INFO - TEST-INFO | started process 9826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiN9Up7/profile http://localhost:50780/getInfo.html) 10:34:38 INFO - PROCESS | 9826 | __metrics Screen width/height:1600/1200 10:34:38 INFO - PROCESS | 9826 | colorDepth:24 10:34:38 INFO - PROCESS | 9826 | Browser inner width/height: 1024/697 10:34:38 INFO - PROCESS | 9826 | __metrics 10:34:38 INFO - PROCESS | 9826 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:34:38 INFO - PROCESS | 9826 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:34:39 INFO - PROCESS | 9826 | console.error: PushService: 10:34:39 INFO - PROCESS | 9826 | stateChangeProcessEnqueue: Error transitioning state 10:34:39 INFO - PROCESS | 9826 | UnknownError 10:34:40 INFO - TEST-INFO | 9826: exit 0 10:34:40 INFO - Browser initialized. 10:34:40 INFO - Running cycle 1/1 for kraken test... 10:34:40 INFO - TEST-INFO | started process 9910 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiN9Up7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:34:52 INFO - PROCESS | 9910 | RSS: Main: 172199936 10:34:52 INFO - PROCESS | 9910 | 10:34:54 INFO - PROCESS | 9910 | Cycle 1(1): loaded http://localhost:50780/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50780/tests/kraken/driver.html?testName=audio-beat-detection) 10:34:55 INFO - PROCESS | 9910 | RSS: Main: 229249024 10:34:55 INFO - PROCESS | 9910 | 10:34:58 INFO - PROCESS | 9910 | Cycle 1(1): loaded http://localhost:50780/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50780/tests/kraken/driver.html?testName=audio-dft) 10:34:59 INFO - PROCESS | 9910 | RSS: Main: 215896064 10:34:59 INFO - PROCESS | 9910 | 10:35:02 INFO - PROCESS | 9910 | Cycle 1(1): loaded http://localhost:50780/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50780/tests/kraken/driver.html?testName=audio-fft) 10:35:02 INFO - PROCESS | 9910 | RSS: Main: 298156032 10:35:02 INFO - PROCESS | 9910 | 10:35:04 INFO - PROCESS | 9910 | Cycle 1(1): loaded http://localhost:50780/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50780/tests/kraken/driver.html?testName=audio-oscillator) 10:35:05 INFO - PROCESS | 9910 | RSS: Main: 209092608 10:35:05 INFO - PROCESS | 9910 | 10:35:07 INFO - PROCESS | 9910 | Cycle 1(1): loaded http://localhost:50780/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50780/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:35:08 INFO - PROCESS | 9910 | RSS: Main: 212070400 10:35:08 INFO - PROCESS | 9910 | 10:35:11 INFO - PROCESS | 9910 | Cycle 1(1): loaded http://localhost:50780/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50780/tests/kraken/driver.html?testName=imaging-darkroom) 10:35:11 INFO - PROCESS | 9910 | RSS: Main: 248389632 10:35:11 INFO - PROCESS | 9910 | 10:35:15 INFO - PROCESS | 9910 | Cycle 1(1): loaded http://localhost:50780/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50780/tests/kraken/driver.html?testName=imaging-desaturate) 10:35:15 INFO - PROCESS | 9910 | RSS: Main: 246919168 10:35:15 INFO - PROCESS | 9910 | 10:35:18 INFO - PROCESS | 9910 | Cycle 1(1): loaded http://localhost:50780/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50780/tests/kraken/driver.html?testName=json-parse-financial) 10:35:19 INFO - PROCESS | 9910 | RSS: Main: 247296000 10:35:19 INFO - PROCESS | 9910 | 10:35:20 INFO - PROCESS | 9910 | Cycle 1(1): loaded http://localhost:50780/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50780/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:35:21 INFO - PROCESS | 9910 | RSS: Main: 208809984 10:35:21 INFO - PROCESS | 9910 | 10:35:22 INFO - PROCESS | 9910 | Cycle 1(1): loaded http://localhost:50780/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50780/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:35:23 INFO - PROCESS | 9910 | RSS: Main: 216264704 10:35:23 INFO - PROCESS | 9910 | 10:35:25 INFO - PROCESS | 9910 | Cycle 1(1): loaded http://localhost:50780/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50780/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:35:26 INFO - PROCESS | 9910 | RSS: Main: 225681408 10:35:26 INFO - PROCESS | 9910 | 10:35:28 INFO - PROCESS | 9910 | Cycle 1(1): loaded http://localhost:50780/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50780/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:35:29 INFO - PROCESS | 9910 | RSS: Main: 234250240 10:35:29 INFO - PROCESS | 9910 | 10:35:32 INFO - PROCESS | 9910 | Cycle 1(1): loaded http://localhost:50780/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50780/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:35:32 INFO - PROCESS | 9910 | RSS: Main: 231952384 10:35:32 INFO - PROCESS | 9910 | 10:35:34 INFO - PROCESS | 9910 | Cycle 1(1): loaded http://localhost:50780/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50780/tests/kraken/driver.html?testName=ai-astar) 10:35:34 INFO - PROCESS | 9910 | RSS: Main: 281640960 10:35:34 INFO - PROCESS | 9910 | 10:35:34 INFO - PROCESS | 9910 | __start_tp_report 10:35:34 INFO - PROCESS | 9910 | _x_x_mozilla_page_load 10:35:34 INFO - PROCESS | 9910 | _x_x_mozilla_page_load_details 10:35:34 INFO - PROCESS | 9910 | |i|pagename|runs| 10:35:34 INFO - PROCESS | 9910 | |0;ai-astar;104;110;111;112;111;113;111;111;114;110 10:35:34 INFO - PROCESS | 9910 | |1;audio-beat-detection;148;120;123;170;123;125;126;124;153;122 10:35:34 INFO - PROCESS | 9910 | |2;audio-dft;163;162;161;160;164;160;162;161;160;160 10:35:34 INFO - PROCESS | 9910 | |3;audio-fft;75;77;78;102;77;77;85;76;97;75 10:35:34 INFO - PROCESS | 9910 | |4;audio-oscillator;83;83;122;82;82;85;115;82;83;115 10:35:34 INFO - PROCESS | 9910 | |5;imaging-gaussian-blur;117;117;117;116;116;116;117;117;117;117 10:35:34 INFO - PROCESS | 9910 | |6;imaging-darkroom;147;147;147;147;146;147;147;147;147;148 10:35:34 INFO - PROCESS | 9910 | |7;imaging-desaturate;84;84;85;86;85;85;86;85;85;86 10:35:34 INFO - PROCESS | 9910 | |8;json-parse-financial;53;52;53;52;52;54;54;54;53;54 10:35:34 INFO - PROCESS | 9910 | |9;json-stringify-tinderbox;60;60;60;60;61;60;60;61;60;60 10:35:34 INFO - PROCESS | 9910 | |10;stanford-crypto-aes;96;84;81;80;84;88;90;83;80;79 10:35:34 INFO - PROCESS | 9910 | |11;stanford-crypto-ccm;139;132;134;134;130;135;131;135;172;130 10:35:34 INFO - PROCESS | 9910 | |12;stanford-crypto-pbkdf2;171;167;168;168;178;166;169;167;166;167 10:35:34 INFO - PROCESS | 9910 | |13;stanford-crypto-sha256-iterative;70;69;72;76;66;66;65;65;66;64 10:35:34 INFO - PROCESS | 9910 | __end_tp_report 10:35:34 INFO - PROCESS | 9910 | __start_cc_report 10:35:34 INFO - PROCESS | 9910 | _x_x_mozilla_cycle_collect,1700 10:35:34 INFO - PROCESS | 9910 | __end_cc_report 10:35:34 INFO - PROCESS | 9910 | __startTimestamp1476466534886__endTimestamp 10:35:34 INFO - PROCESS | 9910 | 10:35:34 INFO - PROCESS | 9910 | ------- Summary: start ------- 10:35:34 INFO - PROCESS | 9910 | Number of tests: 14 10:35:34 INFO - PROCESS | 9910 | 10:35:34 INFO - PROCESS | 9910 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:2.67 (2.4%) stddev-sans-first:1.33 10:35:34 INFO - PROCESS | 9910 | Values: 104.0 110.0 111.0 112.0 111.0 113.0 111.0 111.0 114.0 110.0 10:35:34 INFO - PROCESS | 9910 | 10:35:34 INFO - PROCESS | 9910 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:125.50 stddev:17.24 (13.7%) stddev-sans-first:17.46 10:35:34 INFO - PROCESS | 9910 | Values: 148.0 120.0 123.0 170.0 123.0 125.0 126.0 124.0 153.0 122.0 10:35:34 INFO - PROCESS | 9910 | 10:35:34 INFO - PROCESS | 9910 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.42 (0.9%) stddev-sans-first:1.36 10:35:34 INFO - PROCESS | 9910 | Values: 163.0 162.0 161.0 160.0 164.0 160.0 162.0 161.0 160.0 160.0 10:35:34 INFO - PROCESS | 9910 | 10:35:34 INFO - PROCESS | 9910 | [#3] audio-fft Cycles:10 Average:81.90 Median:77.00 stddev:9.77 (12.7%) stddev-sans-first:10.04 10:35:34 INFO - PROCESS | 9910 | Values: 75.0 77.0 78.0 102.0 77.0 77.0 85.0 76.0 97.0 75.0 10:35:34 INFO - PROCESS | 9910 | 10:35:34 INFO - PROCESS | 9910 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:82.50 stddev:16.78 (20.3%) stddev-sans-first:17.39 10:35:34 INFO - PROCESS | 9910 | Values: 83.0 83.0 122.0 82.0 82.0 85.0 115.0 82.0 83.0 115.0 10:35:34 INFO - PROCESS | 9910 | 10:35:34 INFO - PROCESS | 9910 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:35:34 INFO - PROCESS | 9910 | Values: 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 10:35:34 INFO - PROCESS | 9910 | 10:35:34 INFO - PROCESS | 9910 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 10:35:34 INFO - PROCESS | 9910 | Values: 147.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 148.0 10:35:34 INFO - PROCESS | 9910 | 10:35:34 INFO - PROCESS | 9910 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.74 (0.9%) stddev-sans-first:0.67 10:35:34 INFO - PROCESS | 9910 | Values: 84.0 84.0 85.0 86.0 85.0 85.0 86.0 85.0 85.0 86.0 10:35:34 INFO - PROCESS | 9910 | 10:35:34 INFO - PROCESS | 9910 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.50 stddev:0.88 (1.6%) stddev-sans-first:0.93 10:35:34 INFO - PROCESS | 9910 | Values: 53.0 52.0 53.0 52.0 52.0 54.0 54.0 54.0 53.0 54.0 10:35:34 INFO - PROCESS | 9910 | 10:35:34 INFO - PROCESS | 9910 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 10:35:34 INFO - PROCESS | 9910 | Values: 60.0 60.0 60.0 60.0 61.0 60.0 60.0 61.0 60.0 60.0 10:35:34 INFO - PROCESS | 9910 | 10:35:34 INFO - PROCESS | 9910 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:5.38 (6.4%) stddev-sans-first:3.77 10:35:34 INFO - PROCESS | 9910 | Values: 96.0 84.0 81.0 80.0 84.0 88.0 90.0 83.0 80.0 79.0 10:35:34 INFO - PROCESS | 9910 | 10:35:34 INFO - PROCESS | 9910 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:134.50 stddev:12.53 (9.3%) stddev-sans-first:13.28 10:35:34 INFO - PROCESS | 9910 | Values: 139.0 132.0 134.0 134.0 130.0 135.0 131.0 135.0 172.0 130.0 10:35:34 INFO - PROCESS | 9910 | 10:35:34 INFO - PROCESS | 9910 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.70 Median:168.00 stddev:3.59 (2.1%) stddev-sans-first:3.71 10:35:34 INFO - PROCESS | 9910 | Values: 171.0 167.0 168.0 168.0 178.0 166.0 169.0 167.0 166.0 167.0 10:35:34 INFO - PROCESS | 9910 | 10:35:34 INFO - PROCESS | 9910 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.50 stddev:3.81 (5.6%) stddev-sans-first:3.97 10:35:34 INFO - PROCESS | 9910 | Values: 70.0 69.0 72.0 76.0 66.0 66.0 65.0 65.0 66.0 64.0 10:35:34 INFO - PROCESS | 9910 | -------- Summary: end -------- 10:35:34 INFO - PROCESS | 9910 | 10:35:36 INFO - TEST-INFO | 9910: exit 0 10:35:36 INFO - TEST-OK | kraken | took 62013ms 10:35:36 INFO - SUITE-END | took 1180s 10:35:36 INFO - Completed test suite (00:19:40) 10:35:36 INFO - javascript benchmark 10:35:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3005.744511716504, 3046.8324242166686, 3057.7859549831505, 3081.9229519262003, 3111.144435280298, 5157.896842063156, 5242.606804489659, 5334.839954801358, 5420.5392541633955, 5447.400785913546, 5294.285271488348, 5398.163284690879, 5413.106837371839, 5434.402215756273, 5441.129419292914, 4870.391201099863, 4905.583025442842, 4935.679180853251, 4952.3561936948145, 5010.023045506127, 4884.3644989128325, 4996.500349964993, 5004.599632029429, 5065.290859279704, 5124.641275110744, 4973.676711013809, 5015.648904576681, 5052.0, 5074.949250507503, 5112.233165025239, 4712.0811441768865, 4739.668223224376, 4743.0988112258565, 4809.687370320918, 4889.33993910821, 4811.518848115195, 4816.759162041884, 4836.0, 4945.950540494585, 4959.429665588467, 5308.867278318035, 5367.677939323614, 5380.354357477127, 5389.083855744533, 5437.211604317391, 5579.721013949286, 5642.322921249435, 5717.0, 5725.685087320196, 5725.914111288293, 5646.18130371098, 5731.111677689964, 5744.770209191627, 5744.770209191627, 5751.25233719618, 5396.0, 5400.891982160335, 5402.945970540323, 5403.5136837684795, 5404.135338345845, 5562.332520097614, 5859.53123750099, 5861.472467477862, 5861.560382971209, 5868.823935281948, 5385.219143224211, 5554.028045092093, 5686.459786320293, 5687.60186786921, 5778.133280007948, 5769.567282453832, 5779.595428319977, 5779.913301300484, 5780.1907732917425, 5781.0, 5718.942810571924, 5763.88472230553, 5773.1051686988585, 5775.249217601685, 5864.824055278348, 5517.531009864207, 5587.078132108157, 5589.664620122806, 5668.971655141698, 5674.858128546819, 4356.695031347838, 4370.912581748411, 4380.8685739427865, 4383.956160438354, 4388.802503887333, 3856.0745421099296, 3889.4554762333296, 3917.9421556179673, 3973.48344715191, 3979.7413168143976, 5416.21464887597, 5418.756155972991, 5419.647722897999, 5430.972845135828, 5432.701201433959, 5621.606487545832, 5697.401772813878, 5701.173329867146, 5707.315122185364, 5745.253117094751, 5252.474752524793, 5305.681659100466, 5362.008028514737, 5463.344398672185, 5465.207544905967, 5025.246213068069, 5026.170681837529, 5027.1956486962645, 5027.547520723152, 5073.086844368049, 5994.160046560509, 6032.969835150796, 6039.124326972565, 6039.305479869783, 6039.939600604113, 5591.552675785846, 5654.547636189177, 5684.0, 5778.884422311614, 5825.563082768725, 6079.4603069406685, 6080.813677378671, 6090.318742873998, 6093.847633972344, 6133.7546498141355, 5699.772009119589, 5702.0, 5706.343770466449, 5711.514521265739, 5778.306603207642, 5550.417206193291, 5611.410801865909, 5682.176084467646, 5797.101449275369, 5801.6519008859605, 5616.0, 5633.549316054624, 5650.915236271377, 5718.456746609066, 5736.368999410145, 5637.830865074055, 5638.971805140948, 5654.886902262014, 5655.915161272502, 5666.15007748841, 5388.2725832012175, 5442.4285450028765, 5622.156676498558, 5627.380988091389, 5640.32316122068, 5451.127819548853, 5550.666959982253, 5562.749676264659, 5622.016147174147, 5675.148727690715, 5455.208994695826, 5464.316960379952, 5464.726763661722, 5470.261514695465, 5493.7802487900035], "value": 5296.747847836382, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.1777194156241, 605.391581460632, 628.403017133723, 638.5274896576532, 639.7057353617336, 31690.841545792267, 41801.0, 42849.0, 42882.57117428825, 42996.0, 44992.775036124855, 45350.0, 45422.318665219966, 45481.772591137, 45495.545044549624, 8045.235702608243, 8231.711890083849, 8921.643134274622, 9077.773055673628, 9081.228095611881, 10542.578296868154, 10781.1375089993, 10782.676519704382, 11160.330380177214, 11166.66500004997, 10928.781424371507, 11037.779244415107, 11042.116630669567, 11044.282121662107, 11045.613403530879, 10789.568417263301, 10804.459777011118, 10845.0, 10854.185936054748, 10854.891451085467, 10671.19966002553, 10704.946475267652, 10729.785404291948, 10732.497450356956, 10734.302270352402, 42091.1581768366, 42241.0, 42476.57523424757, 42498.15003699909, 42520.574794251974, 3215.244417561871, 3301.224212310105, 3312.38720836646, 3328.467445208755, 3362.882299119519, 32052.679473205204, 32121.839390802896, 32196.0, 32702.836485817417, 33795.493067604, 4032.34651856136, 4194.517630472505, 4263.445752052245, 4265.7014009019385, 4322.481302243751, 334011.0, 335695.0, 336525.0, 336830.0, 338514.30742846377, 33307.500387494205, 61168.0, 61660.07509887355, 61934.38065619286, 61941.69029154915, 34461.48307775385, 36039.639603604155, 36311.0, 36609.08477288036, 36618.81690591583, 13091.541796037092, 13189.934050329879, 13200.933995329962, 13204.735905281841, 13206.669833254246, 9781.755456113655, 10036.698899033041, 10209.234307426825, 10660.307080039773, 10715.0, 8059.113497515269, 8131.227533384319, 8164.387670924704, 8274.089850116483, 8278.710245141512, 3122.2350524121734, 3168.419685755082, 3171.9682803172136, 3197.2326641606314, 3203.727683146912, 961.8653388525612, 1066.1524088349781, 1144.3420033480782, 1151.3955173533793, 1182.6215611004568, 31623.36753264922, 32320.0, 32321.191970200463, 32594.348113037606, 32692.0, 1013.6249587652616, 1018.6180182431589, 1022.5654097008742, 1059.2055958031476, 1102.2504696806088, 15991.28039238237, 16823.915880420518, 16890.83109168917, 16893.292119626465, 17128.97226166434, 503947.0, 506423.0, 506541.0, 507151.0, 507605.0, 56261.437385626436, 56952.0, 56971.0, 57023.0, 57087.714561426925, 1170.777552265067, 1211.1642966353363, 1228.8586812516496, 1267.3853181207107, 1316.0524422415845, 28732.425351492435, 31875.20311992126, 33217.83391083029, 34461.0, 34842.82578587091, 53248.4675153259, 54291.72854135704, 54358.45641543692, 54441.183382248506, 54464.72767636136, 400363.0, 403856.0, 404645.0, 406004.0, 406344.0, 23643.64534532018, 24226.75773242245, 26041.0, 27354.179374618794, 27680.86159569189, 42516.36225456559, 46732.766336168104, 46892.0, 47007.29489057735, 47569.0, 38983.87641901502, 39100.608993910835, 39793.20413591654, 41072.589274108075, 41472.170556589306, 38941.2741108131, 39106.0, 39925.60074399335, 40135.79932100321, 41281.0, 39106.0, 39652.80173599229, 40346.79826600848, 40353.39469907895, 40445.0, 30735.846320768254, 35815.82092089523, 37050.25899482049, 39289.21421571496, 39915.0, 28104.71895281021, 28186.71813281841, 28337.29156771097, 28454.146375608765, 28571.571426428203], "value": 18831.927431398904, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.46323562452267, 380.0631443491793, 385.1334497380893, 402.04313733314706, 410.5894105894106, 17091.0, 18886.33897813577, 19567.41297761068, 19764.802351976494, 19774.20903163872, 17674.911625441888, 18158.364457244, 18410.907945460287, 18746.062696865138, 18791.624167516675, 5018.34761481007, 5118.641695081336, 5301.151815709487, 5305.283786688806, 5306.7611957462, 5138.665986710852, 5230.476952304777, 5238.397584277819, 5245.68525888446, 5253.343332083489, 5244.318238628973, 5245.79016839326, 5250.6324557281005, 5251.527362537371, 5262.184361423985, 5553.250311207996, 5610.747516361774, 5645.745941432645, 5646.0, 5653.321601407857, 4867.975660121677, 4997.475265097149, 5021.44764075955, 5090.516400941905, 5094.490550944913, 13649.590512284647, 13755.449782008807, 13801.861981380158, 13878.583642490741, 13887.58337249884, 2376.6316220985773, 2396.628522579003, 2788.9023884163958, 2884.7115288471196, 2935.412917416525, 9407.858882116705, 9795.314327997043, 10410.947945260225, 10425.218108641806, 10442.425666588335, 1842.4196378140978, 1877.5493881468349, 1879.755631767875, 1896.2035944903173, 1922.0485859499497, 73901.6304918472, 74101.62949185274, 74437.25562744412, 79414.60292698558, 84470.57764711136, 10499.527521261562, 10532.420716860646, 10651.414172220448, 10818.24272300947, 10821.188410869216, 15315.0, 15318.540443786704, 15321.540353789404, 15333.463328783662, 15355.92322038405, 7099.609521476368, 7204.243554426815, 7320.231375705581, 7343.192248852622, 7482.8877566836545, 6613.933860661332, 6614.933850661528, 6887.827804304832, 6922.826929326707, 6927.376536111774, 4530.909381812346, 4551.749653769009, 4632.884177895579, 4635.397398338195, 4707.6233901287815, 1733.9393121240696, 1843.3640394064028, 1847.6027654054174, 1852.666520026408, 1904.3144467991513, 850.1583432402001, 930.4789317981952, 960.2941837749248, 1016.1464369929295, 1067.9038886500252, 18473.0, 19097.331593394163, 19314.806851931582, 19477.90261048714, 19591.902040489706, 925.6251218256482, 926.1063074133493, 941.4210260689764, 957.0477375011908, 980.4656462228103, 9792.363496372713, 10458.477076146315, 10658.092218390042, 10683.14534837211, 10688.091512221392, 437528.0, 444115.29660533095, 444771.0, 445868.0, 449333.0, 86651.56674216715, 87607.0, 87609.0, 90003.54998224966, 90337.0, 982.29274922056, 1033.452270296744, 1040.6201736366172, 1040.698197522725, 1049.8477720730452, 16066.43767468133, 16218.513444596681, 16491.505254842374, 16714.665706686043, 16914.577135571708, 40381.59618403896, 40709.389359159046, 40885.740120629795, 41080.38379424251, 42913.35629965615, 52211.0, 52684.0, 52763.472365275855, 60310.698446507486, 61874.0, 8138.959305203436, 8174.141715120065, 8461.196186362286, 8569.442986206126, 8620.310375169845, 11270.661880143609, 12610.36948152607, 12676.0, 12921.160124592247, 13105.67235819074, 10355.94822025885, 10464.581416743245, 11010.50452729613, 11053.613123540637, 11573.826392603949, 10767.515461804081, 10892.0, 11001.394923279297, 11114.38870862078, 11216.158788090763, 11319.490622921823, 11480.368579727861, 11573.0, 11729.003034741801, 12494.500219991462, 8360.916390836013, 8453.66185352579, 8665.826683466421, 8686.565671716262, 8704.129587041498, 10715.678529644123, 10969.286996345212, 11002.559897604006, 11253.66239012831, 11496.425178741198], "value": 8747.703910866023, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.9452021919124, 1480.3560451203723, 1516.0903457925242, 1629.7962754655669, 1814.1020195003475, 7608.391328693705, 8420.915790842097, 8716.782080448, 8785.60464779085, 9007.504587247699, 8835.779105522364, 8881.555922203896, 8902.599383027764, 8907.376483646147, 8913.0, 2180.738311402634, 2215.6565732311437, 2216.434809123671, 2217.301550011749, 2223.132978138527, 2180.465785882453, 2217.3126330837413, 2222.75549689534, 2224.4883676754357, 2233.832462565306, 2204.437868343578, 2216.213244298275, 2217.5675743230076, 2220.9333719988426, 2264.3546589222074, 2180.2478145039936, 2195.2645863635703, 2202.8347873909443, 2203.173809821317, 2209.2046863129262, 2154.3213887625348, 2177.150911144655, 2191.7808219178114, 2194.6049711052005, 2201.3506015725397, 8713.69502067431, 8764.123587641248, 8765.517896515688, 8774.956125219396, 8779.604917778715, 5139.0, 5306.946930530684, 5321.467853214686, 5344.839654810362, 5347.385050719178, 3207.5349074384317, 3356.16095976006, 3437.4671925851535, 3438.157651375404, 3446.827658617084, 1006.099540910888, 1050.5902697947806, 1064.984025239622, 1071.539238127605, 1077.439731339699, 12161.574344897974, 12244.571439999558, 12290.508379664803, 12339.876601233962, 12380.690482738004, 4330.328799036154, 4507.256302710016, 4600.35595016698, 4664.906701865943, 4684.695494792828, 9614.807703845883, 9634.03659634031, 9635.662751803653, 9644.276679249084, 9645.08371704687, 5207.505286997805, 5220.660657057279, 5231.581473482112, 5248.6588371755715, 5250.3962044364625, 3977.5624681285035, 4204.684648651363, 4300.0, 4887.535684110004, 4912.091263116335, 3602.189507360823, 3690.6493883081066, 3697.131174174067, 3765.1904840458883, 3783.508143941325, 1158.9652310430702, 1162.2271189658952, 1182.1606659272013, 1183.4792691215837, 1185.4428418643224, 910.9590068446936, 924.6763632728625, 938.9342746007713, 947.6114792934864, 969.1665167955553, 5649.971750141223, 5673.042800233913, 5769.480746732815, 5904.763809447574, 5976.9402305977255, 883.8055627762011, 947.313197931508, 958.1951161024773, 980.3725615606018, 982.3172894838019, 3722.664960153545, 3796.886093417202, 3909.139989202371, 3910.178862438863, 4012.61880121388, 10544.841827372595, 10995.670129896116, 10998.780024399468, 11024.50389732464, 11029.227954043301, 10646.201534884915, 10774.138068954464, 10918.1811364148, 10926.945365273281, 10946.781064378667, 7997.6800927963395, 8086.919130808734, 8090.231428014447, 8105.918940810634, 8108.716194933031, 5555.583331250254, 5570.080936645571, 5590.720463976866, 5679.290088738908, 5720.628159169641, 9697.127258546765, 9747.415155090433, 9808.607655693977, 9882.802343952937, 9995.350302230332, 8975.192232698828, 9642.373245739005, 10049.849252261369, 10176.592936282466, 10219.335743176669, 6627.734890604322, 7149.714011439484, 7422.96288518554, 7424.406047516294, 7573.962130189314, 8274.917250827415, 8353.457025293337, 8373.665053397795, 8544.18830211129, 8622.78443038929, 7579.924200757921, 7683.078030636136, 7695.92304076952, 7710.383169346551, 7762.8447431049935, 7390.076240469942, 7415.184329723834, 7471.551706897603, 7527.473076884566, 7744.1094274159195, 6601.33986601336, 6782.287859774653, 6829.351211634887, 6846.760363387258, 6864.279250678607, 4961.925571116364, 4983.551480366785, 5026.120428924996, 5027.673201241908, 5064.189729643387, 5059.215821547666, 5152.381714194321, 5213.817516386908, 5249.055170069424, 5267.656747529356], "value": 4512.126528418549, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.9920501987451, 319.1351437604093, 329.6522169111587, 337.0864955969323, 338.08042125418854, 5217.643412712703, 5250.291210686556, 5256.106461901476, 5295.6028297877665, 5314.415414304423, 5209.687418754868, 5234.18870075138, 5244.737763111839, 5254.8686282842855, 5267.894642107156, 4061.512618485786, 4066.9186616267657, 4069.125138095309, 4069.857554985576, 4089.5910408959016, 3809.3904975203836, 3861.4940173332425, 3903.0, 4020.8994775130564, 4103.343465045593, 4028.5769994150633, 4045.37296719009, 4047.7773722445254, 4050.392441133839, 4071.4707088078508, 4021.4369988201674, 4036.7174297799165, 4043.939340909889, 4048.8380464781667, 4053.2906741320444, 3365.4278772608714, 3477.547918770569, 3572.964270357289, 3576.910577235564, 3596.8381422836037, 4942.703437793743, 5087.516685914869, 5089.796408143669, 5109.054824857413, 5127.7948882044675, 4568.908621827578, 4577.267637178035, 4605.815767369301, 4612.238980568236, 4655.441347038377, 5170.508801663836, 5441.782328706847, 5453.4273901240595, 5467.753951072172, 5495.6427832191175, 3920.3335432976464, 3924.7056470764524, 3925.60743925608, 3927.9410808837893, 3949.8420063197436, 5377.085895397752, 5589.46900044491, 5636.577256705723, 5660.971695141539, 5686.516646085088, 3805.372113601225, 3899.5710471848074, 3911.6283953024417, 3929.7052721046034, 3933.9213215735526, 3960.4653371795016, 3961.980190099031, 3967.8016099194924, 4001.2597669430666, 4008.3386241270446, 4544.88637784058, 4587.770611469413, 4631.235846085426, 4631.606313463393, 4653.7207767534055, 5236.450172731885, 5422.864428389243, 5434.3207099112615, 5446.1558458439, 5456.0, 1378.855549893586, 1395.6580637743818, 1396.8393634731933, 1397.699494608664, 1406.542873566095, 817.9345652347798, 852.5012867472598, 888.8000199955088, 897.3583887520455, 899.7030979776658, 4728.935989402426, 4742.241241401359, 4753.215719406328, 4753.786079626425, 4755.690880092852, 4957.529034741694, 4958.355413796184, 4965.230389289666, 4965.751712414365, 5024.346834911438, 4735.739534325577, 4750.643701722384, 4756.619470442356, 4804.615630749532, 4967.5032496750755, 2958.8668509917106, 2978.9702102978695, 2981.567672687448, 3001.3792552021664, 3010.9548356774667, 5840.561957853178, 5846.386129456431, 5851.268591426072, 5912.733926973297, 5918.319393269743, 5545.805896793593, 5672.205891175238, 5674.659520428788, 5731.598788084877, 5766.365699773021, 5694.829155125353, 5712.200291959129, 5734.623690314294, 5768.3654797972185, 5786.942130578725, 5383.703896285742, 5532.2254884315425, 5569.944300557105, 5597.216389705526, 5651.406602306863, 5489.231507588861, 5511.476409741068, 5518.392976772632, 5523.33719953592, 5542.889142217053, 5522.542468601594, 5693.459121383462, 5698.686572238566, 5823.563232757476, 5836.358000619844, 3969.3649016158433, 3989.401589761443, 3990.062335351132, 4002.4396584477613, 4016.9799151005227, 5623.718814059363, 5625.76233228689, 5645.181448689999, 5646.927083854054, 5668.858278543069, 5320.494553017457, 5476.342838859362, 5494.450554944474, 5517.2551705519245, 5517.779288828402, 5488.506034456918, 5507.779688812563, 5524.171374293888, 5524.723763811874, 5535.169724541351, 5331.120365139708, 5444.8094316698725, 5462.49781310127, 5471.644343117685, 5485.149801780731, 5504.2203687137735, 5555.0, 5566.638168519034, 5567.972160139173, 5576.275084239023, 5425.077736784677, 5436.184572314184, 5454.836354909359, 5466.0, 5466.890662186814], "value": 4121.334773398158, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.7799538133942, 790.5217343507178, 829.232959512451, 833.2917020532544, 837.8617528107862, 13737.24445155516, 14295.0, 14348.641283967907, 14484.49304274348, 16140.677186456263, 14692.0, 15011.624709382271, 15018.174000429972, 15019.32413041413, 15025.774613380809, 664.7008846019287, 813.8941937548125, 830.7839961609994, 831.8627426474625, 833.4291010657688, 682.9726810927557, 693.414065114977, 695.1484431571309, 696.3210869402343, 788.2708494642461, 865.6061492021115, 868.682930730282, 876.1545108969843, 876.242050626207, 876.3120950054209, 862.8360611483798, 864.3517361978517, 864.4985908173245, 864.5979619476942, 865.5888452984844, 512.6437126197294, 529.9947000529984, 639.0222958872932, 642.4828013449171, 647.2459584583954, 14335.78496322556, 14696.706065878623, 14817.851821481754, 15449.459268925646, 15449.613759655986, 14946.62633434162, 15529.0, 15632.687346253126, 15852.60368490797, 15983.600409989727, 11889.881101188965, 12014.399280035963, 12108.101671537173, 12171.391430428443, 12218.938905305506, 3854.8458061677497, 3855.132595166065, 3883.4951456310782, 3943.132510847609, 3959.326914424526, 81172.0, 83278.16721832765, 83311.0, 83608.0, 86467.56766216128, 11798.41007949599, 11948.0, 11986.220895641756, 12036.157468977262, 12215.633530993906, 22835.200767973372, 23078.884605576866, 23154.884225578764, 23192.304230873102, 23892.641610375857, 8334.12491688364, 8668.0, 8697.521636310064, 8749.387542871938, 8903.955480222558, 4687.906241875144, 4704.1062198182235, 4768.856934291976, 4782.856514304576, 4859.611231101503, 3502.7898326100517, 3590.8563657453933, 3624.655657712513, 3631.654992775682, 3632.9636703632627, 636.1570918532963, 641.8959389849451, 650.222983534681, 658.7976942080721, 682.0247046723233, 522.4931816138339, 589.5902347868276, 593.6972144206486, 663.1776597019757, 667.2693400726197, 9074.228690561244, 9571.425714457155, 9571.760705982406, 9577.23382129428, 9799.412035277763, 600.9879802404015, 631.0880777276883, 640.6316368088368, 668.6322522612544, 701.4633805139073, 4379.802908869108, 4645.558671926162, 4666.440027196758, 4722.929156062662, 4822.474286455375, 88894.55552722195, 117871.41064294624, 127340.0, 128533.0, 129477.0, 103002.48498757608, 106905.46547267369, 107894.57897578354, 109875.45062274797, 111227.0, 57983.0, 92271.5386423077, 93213.0, 95661.0, 97265.99999999859, 9019.864702029607, 9087.909120908971, 9113.074222493691, 9175.128362805523, 9394.389364691273, 53711.0, 53884.0, 54444.455555443936, 54873.1769023457, 55384.44615553954, 46158.30762538632, 46333.305000425695, 79091.0, 80288.59855700684, 81160.59419702864, 11168.162387820783, 11381.715457113638, 11549.82675259855, 11952.58165964187, 12186.451609677408, 12958.629959675336, 13087.41106650184, 13234.139780914209, 13572.0, 13656.863431365558, 11208.27146235492, 11711.1802173847, 11966.278746474763, 12548.18436801605, 12571.26397965864, 11656.0, 12017.038636908852, 13295.80056299137, 13328.533501327407, 13345.66635834073, 12867.22796632205, 13017.303999124337, 13075.542356017875, 13435.529756458476, 13553.79669304981, 10449.843252351373, 10974.176936729618, 11231.0, 11383.0, 11470.139739519736, 11201.88798112041, 11409.54361825551, 11548.653540393801, 11556.364399958084, 11750.88249117532], "value": 7479.88843875662, "unit": "score"}], "name": "dromaeo_css", "value": 7036.544112855305, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 111.0, 112.0, 111.0, 113.0, 111.0, 111.0, 114.0, 110.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 120.0, 123.0, 170.0, 123.0, 125.0, 126.0, 124.0, 153.0, 122.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 160.0, 164.0, 160.0, 162.0, 161.0, 160.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 78.0, 102.0, 77.0, 77.0, 85.0, 76.0, 97.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 122.0, 82.0, 82.0, 85.0, 115.0, 82.0, 83.0, 115.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 148.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 86.0, 85.0, 85.0, 86.0, 85.0, 85.0, 86.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 52.0, 52.0, 54.0, 54.0, 54.0, 53.0, 54.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 84.0, 81.0, 80.0, 84.0, 88.0, 90.0, 83.0, 80.0, 79.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 132.0, 134.0, 134.0, 130.0, 135.0, 131.0, 135.0, 172.0, 130.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 167.0, 168.0, 168.0, 178.0, 166.0, 169.0, 167.0, 166.0, 167.0], "value": 168.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 72.0, 76.0, 66.0, 66.0, 65.0, 65.0, 66.0, 64.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1500.9000000000003, "alertThreshold": 2.0}]} 10:35:36 INFO - Return code: 0 10:35:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:35:36 INFO - # TBPL SUCCESS # 10:35:36 INFO - Running post-action listener: _resource_record_post_action 10:35:36 INFO - [mozharness: 2016-10-14 17:35:36.708787Z] Finished run-tests step (success) 10:35:36 INFO - Running post-run listener: _resource_record_post_run 10:35:36 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393400320; Read time: 12; Write time: 363688 10:35:36 INFO - TinderboxPrint: CPU usage
13.1% 10:35:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:35:36 INFO - TinderboxPrint: I/O write bytes / time
393,400,320 / 363,688 10:35:36 INFO - TinderboxPrint: CPU idle
8,306.3 (86.9%) 10:35:36 INFO - TinderboxPrint: CPU user
1,200.6 (12.6%) 10:35:36 INFO - TinderboxPrint: Swap in / out
0 / 0 10:35:36 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 105713664; Read time: 0; Write time: 93972 10:35:36 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 287686656; Read time: 0; Write time: 269716 10:35:37 INFO - Running post-run listener: _upload_blobber_files 10:35:37 INFO - Blob upload gear active. 10:35:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:35:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:35:37 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:35:37 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:35:37 INFO - (blobuploader) - INFO - Open directory for files ... 10:35:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:35:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:35:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:41 INFO - (blobuploader) - INFO - Done attempting. 10:35:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:35:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:35:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:43 INFO - (blobuploader) - INFO - Done attempting. 10:35:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:35:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:35:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:44 INFO - (blobuploader) - INFO - Done attempting. 10:35:44 INFO - (blobuploader) - INFO - Iteration through files over. 10:35:44 INFO - Return code: 0 10:35:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:35:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:35:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/59779fec3fec4762accc120d0a2a9195c7e88d03b925c3d54eeba9b955afb76c7c9464a31b37b61dc2d64d37f35c29a1352859502ece12ffb3578bee64ffa1d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a514191bfe14e1d81143b9053c51723ed7acf72fc1ff5fca3c884d8e9c2de39aafed5d753b63a875bbb837eaff9a4960050ac0d82d5d33d85fc4416f1c14d4f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ff9129cb5986f46158a8f3febe8907e86acea246aa186af10de89131d743c93d94715864ff918dacfd259b8ca0630037219b70689000939a3b20146675b99efa"} 10:35:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:35:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:35:44 INFO - Contents: 10:35:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/59779fec3fec4762accc120d0a2a9195c7e88d03b925c3d54eeba9b955afb76c7c9464a31b37b61dc2d64d37f35c29a1352859502ece12ffb3578bee64ffa1d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a514191bfe14e1d81143b9053c51723ed7acf72fc1ff5fca3c884d8e9c2de39aafed5d753b63a875bbb837eaff9a4960050ac0d82d5d33d85fc4416f1c14d4f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ff9129cb5986f46158a8f3febe8907e86acea246aa186af10de89131d743c93d94715864ff918dacfd259b8ca0630037219b70689000939a3b20146675b99efa"} 10:35:44 INFO - Running post-run listener: copy_logs_to_upload_dir 10:35:44 INFO - Copying logs to upload dir... 10:35:44 INFO - mkdir: /builds/slave/test/build/upload/logs 10:35:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.878242 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-14 10:35:44.386888) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 10:35:44.390870) ========= 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=af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/59779fec3fec4762accc120d0a2a9195c7e88d03b925c3d54eeba9b955afb76c7c9464a31b37b61dc2d64d37f35c29a1352859502ece12ffb3578bee64ffa1d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a514191bfe14e1d81143b9053c51723ed7acf72fc1ff5fca3c884d8e9c2de39aafed5d753b63a875bbb837eaff9a4960050ac0d82d5d33d85fc4416f1c14d4f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ff9129cb5986f46158a8f3febe8907e86acea246aa186af10de89131d743c93d94715864ff918dacfd259b8ca0630037219b70689000939a3b20146675b99efa"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011393 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476451809/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/59779fec3fec4762accc120d0a2a9195c7e88d03b925c3d54eeba9b955afb76c7c9464a31b37b61dc2d64d37f35c29a1352859502ece12ffb3578bee64ffa1d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a514191bfe14e1d81143b9053c51723ed7acf72fc1ff5fca3c884d8e9c2de39aafed5d753b63a875bbb837eaff9a4960050ac0d82d5d33d85fc4416f1c14d4f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ff9129cb5986f46158a8f3febe8907e86acea246aa186af10de89131d743c93d94715864ff918dacfd259b8ca0630037219b70689000939a3b20146675b99efa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 10:35:44.419574) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:35:44.420199) ========= 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=af724c981e2a0f424dbabf99000001e7-1476465298.917860-244567894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:35:44.503519) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 10:35:44.503860) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 10:35:44.504386) ========= ========= Total master_lag: 0.18 =========