builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1476753726.71 results: success (0) buildid: 20161017182149 builduid: f4f0e49a63034fdfb3d46b5cd80ac24d revision: 7ef1bb3238671037ae8ef82e05ba665ddb14f592 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:06.705443) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:06.705956) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:06.706264) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:06.731918) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:06.732300) ========= 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=03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-17 18:22:06-- 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% 110M=0s 2016-10-17 18:22:07 (110 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132400 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:06.889648) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:06.889991) ========= 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=03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020392 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:06.940661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:06.941021) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 7ef1bb3238671037ae8ef82e05ba665ddb14f592 --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 7ef1bb3238671037ae8ef82e05ba665ddb14f592 --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=03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-17 18:22:07,181 truncating revision to first 12 chars 2016-10-17 18:22:07,181 Setting DEBUG logging. 2016-10-17 18:22:07,181 attempt 1/10 2016-10-17 18:22:07,181 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/7ef1bb323867?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 18:22:07,574 unpacking tar archive at: autoland-7ef1bb323867/testing/mozharness/ program finished with exit code 0 elapsedTime=0.715813 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:07.672683) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:07.673027) ========= script_repo_revision: 7ef1bb3238671037ae8ef82e05ba665ddb14f592 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:07.673619) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:07.673996) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:07.684329) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-17 18:22:07.684795) ========= /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=03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:22:08 INFO - MultiFileLogger online at 20161017 18:22:08 in /builds/slave/test 18:22:08 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 18:22:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:22:08 INFO - {'append_to_log': False, 18:22:08 INFO - 'base_work_dir': '/builds/slave/test', 18:22:08 INFO - 'blob_upload_branch': 'Autoland', 18:22:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:22:08 INFO - 'branch': 'Autoland', 18:22:08 INFO - 'buildbot_json_path': 'buildprops.json', 18:22:08 INFO - 'config_files': ('talos/linux_config.py',), 18:22:08 INFO - 'default_actions': ('clobber', 18:22:08 INFO - 'read-buildbot-config', 18:22:08 INFO - 'download-and-extract', 18:22:08 INFO - 'populate-webroot', 18:22:08 INFO - 'create-virtualenv', 18:22:08 INFO - 'install', 18:22:08 INFO - 'run-tests'), 18:22:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:22:08 INFO - 'download_minidump_stackwalk': True, 18:22:08 INFO - 'download_symbols': 'ondemand', 18:22:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:22:08 INFO - 'tooltool.py': '/tools/tooltool.py', 18:22:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:22:08 INFO - '/tools/misc-python/virtualenv.py')}, 18:22:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:22:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:22:08 INFO - 'installer_path': 'installer.exe', 18:22:08 INFO - 'log_level': 'info', 18:22:08 INFO - 'log_name': 'talos', 18:22:08 INFO - 'log_to_console': True, 18:22:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:22:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:22:08 INFO - 'opt_config_files': (), 18:22:08 INFO - 'pip_index': False, 18:22:08 INFO - 'sps_profile': False, 18:22:08 INFO - 'sps_profile_interval': 0, 18:22:08 INFO - 'suite': 'dromaeojs', 18:22:08 INFO - 'system_bits': '32', 18:22:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:22:08 INFO - 'title': 'talos-linux64-ix-047', 18:22:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:22:08 INFO - 'use_talos_json': True, 18:22:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:22:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:22:08 INFO - 'work_dir': 'build'} 18:22:08 INFO - [mozharness: 2016-10-18 01:22:08.030014Z] Running clobber step. 18:22:08 INFO - Running pre-action listener: _resource_record_pre_action 18:22:08 INFO - Running main action method: clobber 18:22:08 INFO - rmtree: /builds/slave/test/build 18:22:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:22:08 INFO - Running post-action listener: _resource_record_post_action 18:22:08 INFO - [mozharness: 2016-10-18 01:22:08.509985Z] Finished clobber step (success) 18:22:08 INFO - [mozharness: 2016-10-18 01:22:08.510088Z] Running read-buildbot-config step. 18:22:08 INFO - Running pre-action listener: _resource_record_pre_action 18:22:08 INFO - Running main action method: read_buildbot_config 18:22:08 INFO - Using buildbot properties: 18:22:08 INFO - { 18:22:08 INFO - "project": "", 18:22:08 INFO - "product": "firefox", 18:22:08 INFO - "script_repo_revision": "production", 18:22:08 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 18:22:08 INFO - "repository": "", 18:22:08 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 18:22:08 INFO - "buildid": "20161017182149", 18:22:08 INFO - "stage_platform": "linux64-pgo", 18:22:08 INFO - "basedir": "/builds/slave/test", 18:22:08 INFO - "buildnumber": 365, 18:22:08 INFO - "platform": "ubuntu64_hw", 18:22:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:22:08 INFO - "slavebuilddir": "test", 18:22:08 INFO - "branch": "autoland", 18:22:08 INFO - "revision": "7ef1bb3238671037ae8ef82e05ba665ddb14f592", 18:22:08 INFO - "slavename": "talos-linux64-ix-047", 18:22:08 INFO - "builduid": "f4f0e49a63034fdfb3d46b5cd80ac24d", 18:22:08 INFO - "repo_path": "integration/autoland" 18:22:08 INFO - } 18:22:08 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:22:08 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 18:22:08 INFO - Running post-action listener: _resource_record_post_action 18:22:08 INFO - [mozharness: 2016-10-18 01:22:08.512461Z] Finished read-buildbot-config step (success) 18:22:08 INFO - [mozharness: 2016-10-18 01:22:08.512550Z] Running download-and-extract step. 18:22:08 INFO - Running pre-action listener: _resource_record_pre_action 18:22:08 INFO - Running main action method: download_and_extract 18:22:08 INFO - mkdir: /builds/slave/test/build/tests 18:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:08 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:22:08 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:22:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:22:08 INFO - Downloaded 1361 bytes. 18:22:08 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:22:08 INFO - Using the following test package requirements: 18:22:08 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:22:08 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:22:08 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:22:08 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:08 INFO - u'jsshell-linux-x86_64.zip'], 18:22:08 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:22:08 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:22:08 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:22:08 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:22:08 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:22:08 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:22:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:22:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:22:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:22:08 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:22:08 INFO - Http code: 200 18:22:08 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 18:22:08 INFO - x-amz-cf-id: nFqaqAD6l1ci4pvSn0uaDERWyQDiVv0VxPeleGvCgkWryFSMtbxSXQ== 18:22:08 INFO - x-amz-replication-status: COMPLETED 18:22:08 INFO - x-amz-version-id: tifiHnfUmAIdxiPUpTamnPt7_1o0nAer 18:22:09 INFO - Expected file size: 22090271 18:22:09 INFO - Obtained file size: 22090271 18:22:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:22:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:22:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:22:13 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:22:13 INFO - Http code: 200 18:22:13 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 18:22:13 INFO - x-amz-cf-id: niFuChmWfHXC2x6jp5AtZczw7_Mz5jP2dJye-XiNIbaVKiqenK3gtA== 18:22:13 INFO - x-amz-replication-status: COMPLETED 18:22:13 INFO - x-amz-version-id: tifiHnfUmAIdxiPUpTamnPt7_1o0nAer 18:22:14 INFO - Expected file size: 22090271 18:22:14 INFO - Obtained file size: 22090271 18:22:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:22:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:22:18 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:22:18 INFO - Http code: 200 18:22:18 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 18:22:18 INFO - x-amz-cf-id: RKR8q6jKD_8Af3BVXg2fdUYwKAHpaTS8iwapm1ebaiZ2l_DWxdwJBg== 18:22:18 INFO - x-amz-replication-status: COMPLETED 18:22:18 INFO - x-amz-version-id: MdTEavWu7nDdrXSW3WO0r.sLDrQYoWvd 18:22:19 INFO - Expected file size: 14409028 18:22:19 INFO - Obtained file size: 14409028 18:22: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')]} 18:22:19 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:22:19 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:22:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:22:23 INFO - Downloaded 59508353 bytes. 18:22:23 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:22:23 INFO - mkdir: /builds/slave/test/properties 18:22:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:22:23 INFO - Writing to file /builds/slave/test/properties/build_url 18:22:23 INFO - Contents: 18:22:23 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:22:23 INFO - Running post-action listener: _resource_record_post_action 18:22:23 INFO - Running post-action listener: set_extra_try_arguments 18:22:23 INFO - [mozharness: 2016-10-18 01:22:23.474002Z] Finished download-and-extract step (success) 18:22:23 INFO - [mozharness: 2016-10-18 01:22:23.474231Z] Running populate-webroot step. 18:22:23 INFO - Running pre-action listener: _resource_record_pre_action 18:22:23 INFO - Running main action method: populate_webroot 18:22:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:22:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:22:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:22:23 INFO - '--tppagecycles', 18:22:23 INFO - '7'], 18:22:23 INFO - 'tests': ['tsvgm']}}, 18:22:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:22:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:22:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:22:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:22:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:23 INFO - 'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:22:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:22:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:23 INFO - 'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['damp', 'tps']}, 18:22:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:23 INFO - 'tests': ['damp', 'tps']}, 18:22:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['dromaeo_dom']}, 18:22:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:22:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['basic_compositor_video']}, 18:22:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:22:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['a11yr', 18:22:23 INFO - 'ts_paint', 18:22:23 INFO - 'tpaint', 18:22:23 INFO - 'sessionrestore', 18:22:23 INFO - 'sessionrestore_no_auto_restore', 18:22:23 INFO - 'tabpaint']}, 18:22:23 INFO - 'other-e10s': {'tests': ['a11yr', 18:22:23 INFO - 'ts_paint', 18:22:23 INFO - 'tpaint', 18:22:23 INFO - 'sessionrestore', 18:22:23 INFO - 'sessionrestore_no_auto_restore', 18:22:23 INFO - 'tabpaint']}, 18:22:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:22:23 INFO - 'ts_paint', 18:22:23 INFO - 'tpaint', 18:22:23 INFO - 'sessionrestore', 18:22:23 INFO - 'sessionrestore_no_auto_restore', 18:22:23 INFO - 'tabpaint']}, 18:22:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:22:23 INFO - 'ts_paint', 18:22:23 INFO - 'tpaint', 18:22:23 INFO - 'sessionrestore', 18:22:23 INFO - 'sessionrestore_no_auto_restore', 18:22:23 INFO - 'tabpaint']}, 18:22:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['a11yr', 18:22:23 INFO - 'ts_paint', 18:22:23 INFO - 'tpaint', 18:22:23 INFO - 'sessionrestore', 18:22:23 INFO - 'sessionrestore_no_auto_restore', 18:22:23 INFO - 'tabpaint']}, 18:22:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['a11yr', 18:22:23 INFO - 'ts_paint', 18:22:23 INFO - 'tpaint', 18:22:23 INFO - 'sessionrestore', 18:22:23 INFO - 'sessionrestore_no_auto_restore', 18:22:23 INFO - 'tabpaint']}, 18:22:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['tsvgx', 18:22:23 INFO - 'tsvgr_opacity', 18:22:23 INFO - 'tart', 18:22:23 INFO - 'tscrollx', 18:22:23 INFO - 'cart']}, 18:22:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:22:23 INFO - 'tsvgr_opacity', 18:22:23 INFO - 'tart', 18:22:23 INFO - 'tscrollx', 18:22:23 INFO - 'cart']}, 18:22:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:23 INFO - 'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['tp5o']}, 18:22:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:23 INFO - 'tests': ['tp5o']}, 18:22:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:23 INFO - 'talos_options': ['--disable-e10s', 18:22:23 INFO - '--xperf_path', 18:22:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:22:23 INFO - 'tests': ['tp5n']}, 18:22:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:23 INFO - 'talos_options': ['--xperf_path', 18:22:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:22:23 INFO - 'tests': ['tp5n']}}, 18:22:23 INFO - 'talos.zip': {'path': '', 18:22:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:22:23 INFO - Running post-action listener: _resource_record_post_action 18:22:23 INFO - [mozharness: 2016-10-18 01:22:23.489600Z] Finished populate-webroot step (success) 18:22:23 INFO - [mozharness: 2016-10-18 01:22:23.489688Z] Running create-virtualenv step. 18:22:23 INFO - Running pre-action listener: _resource_record_pre_action 18:22:23 INFO - Running main action method: create_virtualenv 18:22:23 INFO - Creating virtualenv /builds/slave/test/build/venv 18:22:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:22:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:22:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:22:23 INFO - Using real prefix '/usr' 18:22:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:22:24 INFO - Installing distribute.............................................................................................................................................................................................done. 18:22:26 INFO - Installing pip.................done. 18:22:26 INFO - Return code: 0 18:22:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:22:26 INFO - Reading from file tmpfile_stdout 18:22:26 INFO - Output received: 18:22:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:22:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:22: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')]} 18:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22: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')]} 18:22:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f3ae92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26207b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26af790>, '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 0x26b0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b0b20>, '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': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:22: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', 'pip>=1.5'] in /builds/slave/test/build 18:22: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 pip>=1.5 18:22:26 INFO - Using env: {'DISPLAY': ':0', 18:22:26 INFO - 'HOME': '/home/cltbld', 18:22:26 INFO - 'LANG': 'en_US.UTF-8', 18:22:26 INFO - 'LANGUAGE': 'en_US:en', 18:22:26 INFO - 'LOGNAME': 'cltbld', 18:22:26 INFO - 'MAIL': '/var/mail/cltbld', 18:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:26 INFO - 'MOZ_NO_REMOTE': '1', 18:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:26 INFO - 'NO_EM_RESTART': '1', 18:22:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:26 INFO - 'PWD': '/builds/slave/test', 18:22:26 INFO - 'SHELL': '/bin/bash', 18:22:26 INFO - 'SHLVL': '1', 18:22:26 INFO - 'TERM': 'linux', 18:22:26 INFO - 'TMOUT': '86400', 18:22:26 INFO - 'USER': 'cltbld', 18:22:26 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 18:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:26 INFO - '_': '/tools/buildbot/bin/python'} 18:22:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:22:26 INFO - Cleaning up... 18:22:26 INFO - Return code: 0 18:22:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:22: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')]} 18:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22: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')]} 18:22:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22: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', '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 0x7f9f3ae92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26207b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26af790>, '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 0x26b0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b0b20>, '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': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:22: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:22: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 psutil>=3.1.1 18:22:26 INFO - Using env: {'DISPLAY': ':0', 18:22:26 INFO - 'HOME': '/home/cltbld', 18:22:26 INFO - 'LANG': 'en_US.UTF-8', 18:22:26 INFO - 'LANGUAGE': 'en_US:en', 18:22:26 INFO - 'LOGNAME': 'cltbld', 18:22:26 INFO - 'MAIL': '/var/mail/cltbld', 18:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:26 INFO - 'MOZ_NO_REMOTE': '1', 18:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:26 INFO - 'NO_EM_RESTART': '1', 18:22:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:26 INFO - 'PWD': '/builds/slave/test', 18:22:26 INFO - 'SHELL': '/bin/bash', 18:22:26 INFO - 'SHLVL': '1', 18:22:26 INFO - 'TERM': 'linux', 18:22:26 INFO - 'TMOUT': '86400', 18:22:26 INFO - 'USER': 'cltbld', 18:22:26 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 18:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:26 INFO - '_': '/tools/buildbot/bin/python'} 18:22:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:26 INFO - Downloading/unpacking psutil>=3.1.1 18:22: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 18:22: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 18:22: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 18:22: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 18:22: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 18:22: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 18:22:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:22:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:22:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:22:28 INFO - Installing collected packages: psutil 18:22:28 INFO - Running setup.py install for psutil 18:22:28 INFO - building 'psutil._psutil_linux' extension 18:22:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:22:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:22:29 INFO - building 'psutil._psutil_posix' extension 18:22:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:22:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:22:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:22:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:22:29 INFO - Successfully installed psutil 18:22:29 INFO - Cleaning up... 18:22:29 INFO - Return code: 0 18:22:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:29 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 0x7f9f3ae92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26207b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26af790>, '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 0x26b0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b0b20>, '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': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:22:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:22:29 INFO - Using env: {'DISPLAY': ':0', 18:22:29 INFO - 'HOME': '/home/cltbld', 18:22:29 INFO - 'LANG': 'en_US.UTF-8', 18:22:29 INFO - 'LANGUAGE': 'en_US:en', 18:22:29 INFO - 'LOGNAME': 'cltbld', 18:22:29 INFO - 'MAIL': '/var/mail/cltbld', 18:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:29 INFO - 'MOZ_NO_REMOTE': '1', 18:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:29 INFO - 'NO_EM_RESTART': '1', 18:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:29 INFO - 'PWD': '/builds/slave/test', 18:22:29 INFO - 'SHELL': '/bin/bash', 18:22:29 INFO - 'SHLVL': '1', 18:22:29 INFO - 'TERM': 'linux', 18:22:29 INFO - 'TMOUT': '86400', 18:22:29 INFO - 'USER': 'cltbld', 18:22:29 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 18:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:29 INFO - '_': '/tools/buildbot/bin/python'} 18:22:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:22: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 18:22: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 18:22: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 18:22: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 18:22: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 18:22: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 18:22:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:22:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:22:31 INFO - Installing collected packages: mozsystemmonitor 18:22:31 INFO - Running setup.py install for mozsystemmonitor 18:22:31 INFO - Successfully installed mozsystemmonitor 18:22:31 INFO - Cleaning up... 18:22:31 INFO - Return code: 0 18:22:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:31 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 0x7f9f3ae92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26207b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26af790>, '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 0x26b0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b0b20>, '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': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:22:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:22:31 INFO - Using env: {'DISPLAY': ':0', 18:22:31 INFO - 'HOME': '/home/cltbld', 18:22:31 INFO - 'LANG': 'en_US.UTF-8', 18:22:31 INFO - 'LANGUAGE': 'en_US:en', 18:22:31 INFO - 'LOGNAME': 'cltbld', 18:22:31 INFO - 'MAIL': '/var/mail/cltbld', 18:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:31 INFO - 'MOZ_NO_REMOTE': '1', 18:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:31 INFO - 'NO_EM_RESTART': '1', 18:22:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:31 INFO - 'PWD': '/builds/slave/test', 18:22:31 INFO - 'SHELL': '/bin/bash', 18:22:31 INFO - 'SHLVL': '1', 18:22:31 INFO - 'TERM': 'linux', 18:22:31 INFO - 'TMOUT': '86400', 18:22:31 INFO - 'USER': 'cltbld', 18:22:31 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 18:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:31 INFO - '_': '/tools/buildbot/bin/python'} 18:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:31 INFO - Downloading/unpacking jsonschema==2.5.1 18:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:22:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:34 INFO - Downloading functools32-3.2.3-2.tar.gz 18:22:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:22:34 INFO - warning: no files found matching '*.txt' 18:22:34 INFO - no previously-included directories found matching 'build' 18:22:34 INFO - no previously-included directories found matching 'dist' 18:22:34 INFO - no previously-included directories found matching '.git*' 18:22:34 INFO - Installing collected packages: jsonschema, functools32 18:22:34 INFO - Running setup.py install for functools32 18:22:34 INFO - warning: no files found matching '*.txt' 18:22:34 INFO - no previously-included directories found matching 'build' 18:22:34 INFO - no previously-included directories found matching 'dist' 18:22:34 INFO - no previously-included directories found matching '.git*' 18:22:34 INFO - Successfully installed jsonschema functools32 18:22:34 INFO - Cleaning up... 18:22:34 INFO - Return code: 0 18:22:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:34 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 0x7f9f3ae92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26207b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26af790>, '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 0x26b0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b0b20>, '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': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:22:34 INFO - Using env: {'DISPLAY': ':0', 18:22:34 INFO - 'HOME': '/home/cltbld', 18:22:34 INFO - 'LANG': 'en_US.UTF-8', 18:22:34 INFO - 'LANGUAGE': 'en_US:en', 18:22:34 INFO - 'LOGNAME': 'cltbld', 18:22:34 INFO - 'MAIL': '/var/mail/cltbld', 18:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:34 INFO - 'MOZ_NO_REMOTE': '1', 18:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:34 INFO - 'NO_EM_RESTART': '1', 18:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:34 INFO - 'PWD': '/builds/slave/test', 18:22:34 INFO - 'SHELL': '/bin/bash', 18:22:34 INFO - 'SHLVL': '1', 18:22:34 INFO - 'TERM': 'linux', 18:22:34 INFO - 'TMOUT': '86400', 18:22:34 INFO - 'USER': 'cltbld', 18:22:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 18:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:34 INFO - '_': '/tools/buildbot/bin/python'} 18:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:22:34 INFO - Cleaning up... 18:22:34 INFO - Return code: 0 18:22:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:34 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 0x7f9f3ae92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26207b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26af790>, '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 0x26b0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b0b20>, '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': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:22:34 INFO - Using env: {'DISPLAY': ':0', 18:22:34 INFO - 'HOME': '/home/cltbld', 18:22:34 INFO - 'LANG': 'en_US.UTF-8', 18:22:34 INFO - 'LANGUAGE': 'en_US:en', 18:22:34 INFO - 'LOGNAME': 'cltbld', 18:22:34 INFO - 'MAIL': '/var/mail/cltbld', 18:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:34 INFO - 'MOZ_NO_REMOTE': '1', 18:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:34 INFO - 'NO_EM_RESTART': '1', 18:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:34 INFO - 'PWD': '/builds/slave/test', 18:22:34 INFO - 'SHELL': '/bin/bash', 18:22:34 INFO - 'SHLVL': '1', 18:22:34 INFO - 'TERM': 'linux', 18:22:34 INFO - 'TMOUT': '86400', 18:22:34 INFO - 'USER': 'cltbld', 18:22:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 18:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:34 INFO - '_': '/tools/buildbot/bin/python'} 18:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:34 INFO - Downloading/unpacking blobuploader==1.2.4 18:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:36 INFO - Downloading blobuploader-1.2.4.tar.gz 18:22:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:22:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:22:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:37 INFO - Downloading docopt-0.6.1.tar.gz 18:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:22:37 INFO - Installing collected packages: blobuploader, requests, docopt 18:22:37 INFO - Running setup.py install for blobuploader 18:22:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:22:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:22:37 INFO - Running setup.py install for requests 18:22:37 INFO - Running setup.py install for docopt 18:22:37 INFO - Successfully installed blobuploader requests docopt 18:22:37 INFO - Cleaning up... 18:22:38 INFO - Return code: 0 18:22:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:38 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 0x7f9f3ae92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26207b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26af790>, '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 0x26b0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b0b20>, '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': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:22:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:22:38 INFO - Using env: {'DISPLAY': ':0', 18:22:38 INFO - 'HOME': '/home/cltbld', 18:22:38 INFO - 'LANG': 'en_US.UTF-8', 18:22:38 INFO - 'LANGUAGE': 'en_US:en', 18:22:38 INFO - 'LOGNAME': 'cltbld', 18:22:38 INFO - 'MAIL': '/var/mail/cltbld', 18:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:38 INFO - 'MOZ_NO_REMOTE': '1', 18:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:38 INFO - 'NO_EM_RESTART': '1', 18:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:38 INFO - 'PWD': '/builds/slave/test', 18:22:38 INFO - 'SHELL': '/bin/bash', 18:22:38 INFO - 'SHLVL': '1', 18:22:38 INFO - 'TERM': 'linux', 18:22:38 INFO - 'TMOUT': '86400', 18:22:38 INFO - 'USER': 'cltbld', 18:22:38 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 18:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:38 INFO - '_': '/tools/buildbot/bin/python'} 18:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:22:38 INFO - Running setup.py (path:/tmp/pip-Kr9NRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:22:38 INFO - Running setup.py (path:/tmp/pip-A_W1Hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:22:38 INFO - Running setup.py (path:/tmp/pip-oMjy0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:22:38 INFO - Running setup.py (path:/tmp/pip-mzFBD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:22:38 INFO - Running setup.py (path:/tmp/pip-TM21Dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:22:38 INFO - Running setup.py (path:/tmp/pip-xbj3Ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:22:38 INFO - Running setup.py (path:/tmp/pip-IrpO8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:22:38 INFO - Running setup.py (path:/tmp/pip-tIPC3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:22:38 INFO - Running setup.py (path:/tmp/pip-kcQZDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:22:38 INFO - Running setup.py (path:/tmp/pip-fMhUit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:22:38 INFO - Running setup.py (path:/tmp/pip-OBkaQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:22:39 INFO - Running setup.py (path:/tmp/pip-YMqoPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:22:39 INFO - Running setup.py (path:/tmp/pip-z48n2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:22:39 INFO - Running setup.py (path:/tmp/pip-4aX2gS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:39 INFO - Running setup.py (path:/tmp/pip-wYI63B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:22:39 INFO - Running setup.py (path:/tmp/pip-YDl3ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:22:39 INFO - Running setup.py (path:/tmp/pip-GuYFQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:22:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:22:39 INFO - Running setup.py install for manifestparser 18:22:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:22:39 INFO - Running setup.py install for mozcrash 18:22:39 INFO - Running setup.py install for mozdebug 18:22:39 INFO - Running setup.py install for mozdevice 18:22:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:22:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:22:39 INFO - Running setup.py install for mozfile 18:22:40 INFO - Running setup.py install for mozhttpd 18:22:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Running setup.py install for mozinfo 18:22:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Running setup.py install for mozInstall 18:22:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Running setup.py install for mozleak 18:22:40 INFO - Running setup.py install for mozlog 18:22:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Running setup.py install for moznetwork 18:22:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Running setup.py install for mozprocess 18:22:40 INFO - Running setup.py install for mozprofile 18:22:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Running setup.py install for mozrunner 18:22:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Running setup.py install for mozscreenshot 18:22:41 INFO - Running setup.py install for moztest 18:22:41 INFO - Running setup.py install for mozversion 18:22:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:22:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:22:41 INFO - Cleaning up... 18:22:41 INFO - Return code: 0 18:22:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:41 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 0x7f9f3ae92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26207b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26af790>, '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 0x26b0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b0b20>, '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': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:22:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:22:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:22:41 INFO - Using env: {'DISPLAY': ':0', 18:22:41 INFO - 'HOME': '/home/cltbld', 18:22:41 INFO - 'LANG': 'en_US.UTF-8', 18:22:41 INFO - 'LANGUAGE': 'en_US:en', 18:22:41 INFO - 'LOGNAME': 'cltbld', 18:22:41 INFO - 'MAIL': '/var/mail/cltbld', 18:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:41 INFO - 'MOZ_NO_REMOTE': '1', 18:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:41 INFO - 'NO_EM_RESTART': '1', 18:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:41 INFO - 'PWD': '/builds/slave/test', 18:22:41 INFO - 'SHELL': '/bin/bash', 18:22:41 INFO - 'SHLVL': '1', 18:22:41 INFO - 'TERM': 'linux', 18:22:41 INFO - 'TMOUT': '86400', 18:22:41 INFO - 'USER': 'cltbld', 18:22:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 18:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:41 INFO - '_': '/tools/buildbot/bin/python'} 18:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:22:41 INFO - Running setup.py (path:/tmp/pip-hDj5G7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:22:41 INFO - Running setup.py (path:/tmp/pip-bEiFba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:22:41 INFO - Running setup.py (path:/tmp/pip-DfVn7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:22:41 INFO - Running setup.py (path:/tmp/pip-w0ao4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:22:41 INFO - Running setup.py (path:/tmp/pip-QyDLV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:22:41 INFO - Running setup.py (path:/tmp/pip-030HSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:22:41 INFO - Running setup.py (path:/tmp/pip-JyRJe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:22:42 INFO - Running setup.py (path:/tmp/pip-ZNyzRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:22:42 INFO - Running setup.py (path:/tmp/pip-MlKWG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:22:42 INFO - Running setup.py (path:/tmp/pip-i2ju8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:22:42 INFO - Running setup.py (path:/tmp/pip-V8C7NP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:22:42 INFO - Running setup.py (path:/tmp/pip-PJcTu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:22:42 INFO - Running setup.py (path:/tmp/pip-5wnhvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:22:42 INFO - Running setup.py (path:/tmp/pip-WPBQSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:42 INFO - Running setup.py (path:/tmp/pip-6r_e_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:22:42 INFO - Running setup.py (path:/tmp/pip-A5FgC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:22:42 INFO - Running setup.py (path:/tmp/pip-GGX1G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:22:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:44 INFO - Downloading blessings-1.6.tar.gz 18:22:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:22:44 INFO - Installing collected packages: blessings 18:22:44 INFO - Running setup.py install for blessings 18:22:44 INFO - Successfully installed blessings 18:22:44 INFO - Cleaning up... 18:22:44 INFO - Return code: 0 18:22:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:22:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:22:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:22:45 INFO - Reading from file tmpfile_stdout 18:22:45 INFO - Current package versions: 18:22:45 INFO - argparse == 1.2.1 18:22:45 INFO - blessings == 1.6 18:22:45 INFO - blobuploader == 1.2.4 18:22:45 INFO - docopt == 0.6.1 18:22:45 INFO - functools32 == 3.2.3-2 18:22:45 INFO - jsonschema == 2.5.1 18:22:45 INFO - manifestparser == 1.1 18:22:45 INFO - mozInstall == 1.12 18:22:45 INFO - mozcrash == 0.17 18:22:45 INFO - mozdebug == 0.1 18:22:45 INFO - mozdevice == 0.48 18:22:45 INFO - mozfile == 1.2 18:22:45 INFO - mozhttpd == 0.7 18:22:45 INFO - mozinfo == 0.9 18:22:45 INFO - mozleak == 0.1 18:22:45 INFO - mozlog == 3.4 18:22:45 INFO - moznetwork == 0.27 18:22:45 INFO - mozprocess == 0.23 18:22:45 INFO - mozprofile == 0.28 18:22:45 INFO - mozrunner == 6.12 18:22:45 INFO - mozscreenshot == 0.1 18:22:45 INFO - mozsystemmonitor == 0.3 18:22:45 INFO - moztest == 0.7 18:22:45 INFO - mozversion == 1.4 18:22:45 INFO - psutil == 3.1.1 18:22:45 INFO - requests == 1.2.3 18:22:45 INFO - wsgiref == 0.1.2 18:22:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:45 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 0x7f9f3ae92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26207b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26af790>, '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 0x26b0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b0b20>, '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': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:22:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:22:45 INFO - Using env: {'DISPLAY': ':0', 18:22:45 INFO - 'HOME': '/home/cltbld', 18:22:45 INFO - 'LANG': 'en_US.UTF-8', 18:22:45 INFO - 'LANGUAGE': 'en_US:en', 18:22:45 INFO - 'LOGNAME': 'cltbld', 18:22:45 INFO - 'MAIL': '/var/mail/cltbld', 18:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:45 INFO - 'MOZ_NO_REMOTE': '1', 18:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:45 INFO - 'NO_EM_RESTART': '1', 18:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:45 INFO - 'PWD': '/builds/slave/test', 18:22:45 INFO - 'SHELL': '/bin/bash', 18:22:45 INFO - 'SHLVL': '1', 18:22:45 INFO - 'TERM': 'linux', 18:22:45 INFO - 'TMOUT': '86400', 18:22:45 INFO - 'USER': 'cltbld', 18:22:45 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 18:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:45 INFO - '_': '/tools/buildbot/bin/python'} 18:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:22:45 INFO - Cleaning up... 18:22:45 INFO - Return code: 0 18:22:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:45 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 0x7f9f3ae92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26207b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26af790>, '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 0x26b0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b0b20>, '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': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:22:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:22:45 INFO - Using env: {'DISPLAY': ':0', 18:22:45 INFO - 'HOME': '/home/cltbld', 18:22:45 INFO - 'LANG': 'en_US.UTF-8', 18:22:45 INFO - 'LANGUAGE': 'en_US:en', 18:22:45 INFO - 'LOGNAME': 'cltbld', 18:22:45 INFO - 'MAIL': '/var/mail/cltbld', 18:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:45 INFO - 'MOZ_NO_REMOTE': '1', 18:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:45 INFO - 'NO_EM_RESTART': '1', 18:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:45 INFO - 'PWD': '/builds/slave/test', 18:22:45 INFO - 'SHELL': '/bin/bash', 18:22:45 INFO - 'SHLVL': '1', 18:22:45 INFO - 'TERM': 'linux', 18:22:45 INFO - 'TMOUT': '86400', 18:22:45 INFO - 'USER': 'cltbld', 18:22:45 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 18:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:45 INFO - '_': '/tools/buildbot/bin/python'} 18:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:22:45 INFO - Cleaning up... 18:22:45 INFO - Return code: 0 18:22:45 INFO - Running post-action listener: _resource_record_post_action 18:22:45 INFO - Running post-action listener: _start_resource_monitoring 18:22:45 INFO - Starting resource monitoring. 18:22:45 INFO - [mozharness: 2016-10-18 01:22:45.678578Z] Finished create-virtualenv step (success) 18:22:45 INFO - [mozharness: 2016-10-18 01:22:45.679090Z] Running install step. 18:22:45 INFO - Running pre-action listener: _resource_record_pre_action 18:22:45 INFO - Running main action method: install 18:22:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:22:45 INFO - Reading from file tmpfile_stdout 18:22:45 INFO - Detecting whether we're running mozinstall >=1.0... 18:22:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:22:45 INFO - Reading from file tmpfile_stdout 18:22:45 INFO - Output received: 18:22:45 INFO - Usage: mozinstall [options] installer 18:22:45 INFO - Options: 18:22:45 INFO - -h, --help show this help message and exit 18:22:45 INFO - -d DEST, --destination=DEST 18:22:45 INFO - Directory to install application into. [default: 18:22:45 INFO - "/builds/slave/test"] 18:22:45 INFO - --app=APP Application being installed. [default: firefox] 18:22:45 INFO - mkdir: /builds/slave/test/build/application 18:22:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:23:02 INFO - Reading from file tmpfile_stdout 18:23:02 INFO - Output received: 18:23:02 INFO - /builds/slave/test/build/application/firefox/firefox 18:23:02 INFO - Running post-action listener: _resource_record_post_action 18:23:02 INFO - [mozharness: 2016-10-18 01:23:02.980574Z] Finished install step (success) 18:23:02 INFO - [mozharness: 2016-10-18 01:23:02.980855Z] Running run-tests step. 18:23:02 INFO - Running pre-action listener: _resource_record_pre_action 18:23:02 INFO - Running main action method: run_tests 18:23:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:23:02 INFO - Python 2.7.3 18:23:02 INFO - Return code: 0 18:23:02 INFO - grabbing minidump binary from tooltool 18:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:02 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 0x26af790>, '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 0x26b0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:23:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:23:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:23:02 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:23:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:23:03 INFO - Return code: 0 18:23:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:23:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:23:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:23:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:23:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:23:03 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/1476743401/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 18:23:03 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/1476743401/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 18:23:03 INFO - Using env: {'DISPLAY': ':0', 18:23:03 INFO - 'HOME': '/home/cltbld', 18:23:03 INFO - 'LANG': 'en_US.UTF-8', 18:23:03 INFO - 'LANGUAGE': 'en_US:en', 18:23:03 INFO - 'LOGNAME': 'cltbld', 18:23:03 INFO - 'MAIL': '/var/mail/cltbld', 18:23:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:23:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:03 INFO - 'MOZ_NO_REMOTE': '1', 18:23:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:03 INFO - 'NO_EM_RESTART': '1', 18:23:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:03 INFO - 'PWD': '/builds/slave/test', 18:23:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:23:03 INFO - 'SHELL': '/bin/bash', 18:23:03 INFO - 'SHLVL': '1', 18:23:03 INFO - 'TERM': 'linux', 18:23:03 INFO - 'TMOUT': '86400', 18:23:03 INFO - 'USER': 'cltbld', 18:23:03 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047', 18:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:03 INFO - '_': '/tools/buildbot/bin/python'} 18:23:03 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/1476743401/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 18:23:03 INFO - mozversion application_buildid: 20161017153001 18:23:03 INFO - mozversion application_changeset: 7ef1bb3238671037ae8ef82e05ba665ddb14f592 18:23:03 INFO - mozversion application_display_name: Nightly 18:23:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:23:03 INFO - mozversion application_name: Firefox 18:23:03 INFO - mozversion application_remotingname: firefox 18:23:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 18:23:03 INFO - mozversion application_vendor: Mozilla 18:23:03 INFO - mozversion application_version: 52.0a1 18:23:03 INFO - mozversion platform_buildid: 20161017153001 18:23:03 INFO - mozversion platform_changeset: 7ef1bb3238671037ae8ef82e05ba665ddb14f592 18:23:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 18:23:03 INFO - mozversion platform_version: 52.0a1 18:23:03 INFO - using testdate: 1476753783 18:23:03 INFO - actual date: 1476753783 18:23:03 INFO - starting webserver on 'localhost:42300' 18:23:03 INFO - SUITE-START | Running 2 tests 18:23:03 INFO - TEST-START | dromaeo_css 18:23:03 INFO - operating with platform_type : linux_ 18:23:03 INFO - Initialising browser for dromaeo_css test... 18:23:03 INFO - TEST-INFO | started process 22167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyBR40y/profile http://localhost:42300/getInfo.html) 18:23:07 INFO - PROCESS | 22167 | __metrics Screen width/height:1600/1200 18:23:07 INFO - PROCESS | 22167 | colorDepth:24 18:23:07 INFO - PROCESS | 22167 | Browser inner width/height: 1024/697 18:23:07 INFO - PROCESS | 22167 | __metrics 18:23:08 INFO - PROCESS | 22167 | 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" 18:23:08 INFO - PROCESS | 22167 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:23:08 INFO - PROCESS | 22167 | console.error: PushService: 18:23:08 INFO - PROCESS | 22167 | stateChangeProcessEnqueue: Error transitioning state 18:23:08 INFO - PROCESS | 22167 | UnknownError 18:23:09 INFO - TEST-INFO | 22167: exit 0 18:23:09 INFO - Browser initialized. 18:23:09 INFO - Running cycle 1/1 for dromaeo_css test... 18:23:09 INFO - TEST-INFO | started process 22251 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyBR40y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:23:21 INFO - PROCESS | 22251 | RSS: Main: 174006272 18:23:21 INFO - PROCESS | 22251 | 18:24:12 INFO - PROCESS | 22251 | 1476753852881 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:26:24 INFO - PROCESS | 22251 | Cycle 1(1): loaded http://localhost:42300/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42300/tests/dromaeo/cssquery-ext.html) 18:26:25 INFO - PROCESS | 22251 | RSS: Main: 289669120 18:26:25 INFO - PROCESS | 22251 | 18:29:27 INFO - PROCESS | 22251 | Cycle 1(1): loaded http://localhost:42300/tests/dromaeo/cssquery-ext.html (next: http://localhost:42300/tests/dromaeo/cssquery-jquery.html) 18:29:28 INFO - PROCESS | 22251 | RSS: Main: 274583552 18:29:28 INFO - PROCESS | 22251 | 18:32:30 INFO - PROCESS | 22251 | Cycle 1(1): loaded http://localhost:42300/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42300/tests/dromaeo/cssquery-mootools.html) 18:32:30 INFO - PROCESS | 22251 | RSS: Main: 282959872 18:32:30 INFO - PROCESS | 22251 | 18:35:32 INFO - PROCESS | 22251 | Cycle 1(1): loaded http://localhost:42300/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42300/tests/dromaeo/cssquery-prototype.html) 18:35:33 INFO - PROCESS | 22251 | RSS: Main: 231858176 18:35:33 INFO - PROCESS | 22251 | 18:38:36 INFO - PROCESS | 22251 | Cycle 1(1): loaded http://localhost:42300/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42300/tests/dromaeo/cssquery-yui.html) 18:38:36 INFO - PROCESS | 22251 | RSS: Main: 213688320 18:38:36 INFO - PROCESS | 22251 | 18:41:39 INFO - PROCESS | 22251 | Cycle 1(1): loaded http://localhost:42300/tests/dromaeo/cssquery-yui.html (next: http://localhost:42300/tests/dromaeo/cssquery-dojo.html) 18:41:40 INFO - PROCESS | 22251 | RSS: Main: 301891584 18:41:40 INFO - PROCESS | 22251 | 18:41:40 INFO - PROCESS | 22251 | __start_tp_report 18:41:40 INFO - PROCESS | 22251 | _x_x_mozilla_page_load 18:41:40 INFO - PROCESS | 22251 | _x_x_mozilla_page_load_details 18:41:40 INFO - PROCESS | 22251 | |i|pagename|runs| 18:41:40 INFO - PROCESS | 22251 | |0;dojo.html;2931.355101877586;2979.8957036503725;3008.2780132768144;3014.2012366722824;3032.135841285234;5121.155009423441;5228.816991405301;5248.343957005374;5310.0441920454305;5386.865328366793;5156.329677141966;5181.35233095863;5342.225377320296;5355.250264962909;5391;4734.550217729327;4742.359781429514;4773.498782627827;4774.689645173053;4799.232122860343;4801.375821143264;4818.469968303484;4898.387701537308;4901.436334821506;4956.950430495703;4671.416072990876;4785.928211076836;4790.137775200463;4796.112719146951;4908.7300198489065;4708.128996135726;4750.382450281476;4772.236442169236;4777.331173635694;4803.063402636487;4756.096341695102;4767.261074533453;4778.952210477885;4802.35168252285;4830.3237546743485;5242.868928276824;5265.657732247391;5271.288376069258;5277.973610131963;5278;5366.168243922199;5475.260839786658;5475.288212532385;5608.971955140199;5619.325680918275;5561.110222364443;5656.8020119295625;5658.377578466366;5721.7711291548285;5738.856528586777;5290.709011004393;5299.364076310867;5301.73491325436;5302.337207849019;5304.177852432879;5758.395368486333;5764.769409223668;5775.335836378787;5776.191333213354;5779.162021506942;5329.840104796862;5377.677339359651;5381.2197231402015;5483;5524.613277070647;5535.086710692691;5539;5556.444355564492;5625.71871406428;5652.660840349592;5584.21820945068;5594.440555944454;5595.38450770415;5596.552275817925;5596.972015139898;5350.759215835219;5462.890742185134;5463.098588732814;5606.046972014768;5667.773289068391;4285.528591854956;4321.308590625485;4329.350597410351;4331.480222373335;4336.479622445264;3855.556610989716;3857.1707082977296;3857.2092720992127;3896.980515097463;3899.337112690849;5124.436312005676;5175;5361.812336568201;5375.569954403638;5443.863903402367;5523.613347065747;5557.888842223133;5569.303837020372;5609.186667933127;5678.716064196857;5311.362636483646;5315.282436870973;5322.828977624917;5329.280547126166;5359.785608575691;4825.276208568743;4832.540908613676;4833.927491087637;4839.951600484021;4895.73073480962;5587.44125587438;5629.380768115422;5775.27809023872;5843.889660964403;5844.444777746107;5631.802886898939;5660.320761508646;5676.602637815313;5717.113847353667;5725.656460612377;5840.503557197686;5850.765969361178;5868.794592189253;5891.381404952418;5898.469137777621;5293.788248470018;5335.253064571041;5565.38780734127;5569.916451253315;5573.749181286771;5535;5545.473180047889;5591.720413979366;5618.213450116905;5683.3748287687495;5468.91796623059;5472.069748142905;5475.561955043508;5483.341998960151;5488.588355873405;5349.893002140013;5464.9343378042495;5501.724913754377;5508.283923090133;5572.665640061609;5400.675959442289;5429.538489228302;5487.807926722546;5510.559155267649;5586.52514536269;5515.503604675599;5545;5569.997400467792;5580.302462192226;5583.469570390806;5215.817446389358;5220.060389129993;5270.051390749702;5364.14173732201;5438.83683489496 18:41:40 INFO - PROCESS | 22251 | |1;ext.html;577.1659951370269;597.5249676507176;601.3535449391904;607.6354187487507;623.797265888586;31602.367952640932;43893.12213755727;44683.329750053774;44710.552894471046;44727.552724472785;44447;45053.54946450535;45060.324095138516;45074;45149.77425112878;8162.836743265131;8878.067802880685;9034.548272586344;9041.412308199946;9045.3668243223;8289.709860154895;10941.070009049201;11218.102551795837;11225.214235003554;11237.381943993078;10666.093382062534;10745.409002504859;10752.03231709146;10761.76239732429;10763.085137763299;10598.31110977784;10653.893461065367;10665.573377064908;10666.200034997328;10670.893291067106;10612.257142000062;10668.519916603771;10671.733206669818;10683.893161068367;10697.786044279148;42479.36280955788;42731.35902961458;42922.14155716868;42922.356164657554;42940.3558946616;3366.562346894888;3397.11674964511;3399.5920489541168;3528.823558822074;3862.517185351831;31459.34794036831;32453;32469.837650811594;32492.512612310835;32497;4199.538050814408;4381.715188512769;4468.240399132155;4525.886852828673;4527.501974782771;290579;291396;291903;291936;294152;58649.120263196084;58877.41122588719;58914;58959.41040589539;59124;61110;61148.388516115156;61317.69341153266;61366.465838353506;61369;16943.237554310086;16957;17090.48728538146;17153.399631012853;17154.742678859828;11257.662270131908;11326.377049262204;12902.548410805577;13285.13646612967;13336.133151345131;16822.15889205559;17090.48728538146;17528.474145775646;17534.12329383526;17542.14072903959;6130.509559235251;6520.47836173105;6548.410643042149;6601.603903765789;6606.669666516655;921.6543796076471;972.6255391674256;1055.8680164979378;1070.3631339353071;1102.823548232295;31851;32034;32113.51829722556;32208.19479512984;32885.342293154485;1065.737101534684;1092.983605245922;1108.634150730257;1111.9054880335261;1151.614209239914;16441.424550140688;16886;17135.57161070983;17182;17361.47915562535;477493;704497;755794;772013;773390;51485.227721584204;56104.14541964128;57278;57287.14069288964;63239;1333.5932540575218;1350.1426594112809;1367.5692156970722;1376.057400680537;1378.8414332351908;30355.091644608878;32353.51469727909;32972.50541241835;33204.42181441711;33303.66696333102;51514.48485515097;51676.74161629168;51798.482015180874;51925.7403712979;52054.73972630112;390194;390261;390813;391341;391494;27213.319667008484;27374.45251095007;27458.5881211778;27600.585991209748;27850.44299113966;46093.76953115347;46388.011122259944;48201;48323;48372;39610.60389396069;40352.39471407873;40877.32802831132;41220;42500.5749942509;38525.229495409374;39609.603903961746;40317.79841100893;40627.390589141774;41958.370624440046;40273.798631006655;40649.593504065764;41062.53348945211;41397.379039315034;41440.79279603583;33950.49074263839;36383.27233455369;36572;37047.25905481929;37165;27344.589831152945;27698.72301277042;28035.57946630843;28195.295117622223;28211.294717632223 18:41:40 INFO - PROCESS | 22251 | |2;jquery.html;368.19365589359285;372.1199363505311;382.7072289698381;387.66079680279756;404.4560066710275;14206.786898196522;18277.177527011285;18879.62240755184;18970;19794.70307945382;18297.908510457462;19193.616127677436;19235.519112022208;19313.806861931378;19391.515212119702;5376.704281264529;5654.406287339832;5659.264295641561;5663.575231857607;5667.348254950672;4061.4923134608175;4276.059266961279;4356.368326592642;5592.972035139818;5628.718564071801;6363.7454501819875;6371.649559274238;6372.808815735512;6375.776847810327;6381.553291269613;6169.012957926732;6200.596961197552;6203.751849925998;6249.9062514062325;6353.555251132422;5462.262594549725;5466.070767969415;5475.67145971239;5476.6713997159895;5481.314835645544;22082.22712205065;22735.772642273532;22845.885770571207;22940.770592294197;23047.65808957692;2184.595849767798;2189.200941656284;2245.539664368817;2265.9433514162115;2353.882305884716;13809.24049177295;14560.126392416489;14941.327640256215;14951.252437378087;14993.700125997419;1866.1042699504178;1920.5004457592981;1952.9804701952942;1959.8628096033283;1963.33246696124;82254.17745822525;83537.24082416306;83994.58002710009;85455.57272213598;87277.56361218153;9324.627014919462;9469.952650236704;9711.3202075854;10594.735131621617;11228.831567526493;14441.49454769078;14471.78292325616;14476.565703028926;14488.710225795425;14503.202323872289;7893.723719669784;8166.714165004197;8207.794805129919;8417.747467575982;8528.275096616733;7659.234076592407;7705.537667739842;7869;7962.08436029864;8024.518528888286;6192.225971753531;6283.434490895841;6472.514561407913;6474.967625161844;6523.282438931714;1811.3750755989163;1860.4232687866804;1874.9719203486272;1879.0792511669456;1917.2906024770923;865.2429124516049;1017.5065093429681;1034.3483605328745;1039.838824982129;1059.6079450603172;18933.33733319327;19912.402627921187;19974.10116544759;19976.800231997786;20340;925.8750068740768;944.15026476172;979.715882394112;1023.22746326523;1074.9193810464246;10399.428031458192;10674.412907290018;10716.550095603212;10766.084882785051;10796.136309095253;154518;425222;436883;438110;444517;91841;96345.51827240818;96512;96608;102185.48907255565;1022.4632068164125;1057.259918057363;1074.9355038697859;1077.8598782158426;1087.907527860125;16187.27157277949;16194.514164575081;16795.74806377881;16827.831721683116;16873.240704168096;38909;40140.79929600333;40642;40940.59059409368;42728;57193;57814.7109264451;58432;59615.40384596099;60958.695206523684;5536.335639723259;8112.310453611273;8316.501009939422;8325.50046997158;8524.488530688179;9581.089796469325;12946.093773435769;12976.091673582758;12977.480900763863;13105.672358191121;11367.829482557934;11403.714907127389;11505.137114716263;11522.53909843597;11870.584529541424;10645.467726613484;10987.560497580007;11102.777944441228;11116.777664446827;11428.885711142782;5963.761449541969;11347.262427942158;11433;11557.24877882935;11706.473208705458;5306;8060.717874874351;8259;8305.709300174465;8343.791405214919;9741.805163896825;11190.720231993939;11217.102631789601;11511.424428778695;11664.475098620753 18:41:40 INFO - PROCESS | 22251 | |3;mootools.html;1307.398596645543;1414.278717853895;1419.9574012779617;1550.1474189195947;1723.594955185532;7323.377512911402;8098.311643510301;8412;8426.915730842697;8631.69789057383;8389.706360277392;8457.661693532267;8463.111373305806;8474.279686226662;8482.236598706115;2247.2584047264404;2250.8086812620863;2272.6591011348264;2272.9771602778733;2278.1798552521077;2023.494126468383;2063.040686080972;2093.1941202637017;2095.9476013099643;2097.895105244739;2260.062074239189;2278.646809744492;2290.0725206291395;2292.6790249365104;2296.494771150353;2201.3379898176936;2216.357256395643;2223.9888800555896;2227.2538699535594;2227.899744511501;2198.769129241439;2203.460152262706;2203.4711669199437;2207.55848830233;2209.3151123151715;8525.104863989316;8657.783555411102;8687.565621718952;8723.60743766532;8724.171203735636;5140.640155189139;5320.361556613192;5334.27987221724;5346.679199248058;5362.839114826562;3502.404591219499;3555.484454754046;3569.9107522311892;3601.3337532556297;3618.3667858124722;1118.3569447567681;1119.86561612607;1130.2032067392468;1145.7192987717979;1153.6885041038872;11889.702757431047;11945.163838531307;11998.58004969822;12038.097142714332;12111.212771169845;4254.404383386328;4355.216061109031;4516.570925762047;4526.230540808005;4575.062112266977;9416.670416535388;9431.811363772686;9438.433693978383;9443;9445.19715824149;5160.380754309507;5172.27588137661;5175.663581867242;5177.792888284502;5190.948090519122;4049.534303555129;4237.555056719;4360.760158191267;4827.324174615556;4853.781579828917;3654.3422184006604;3744.794036328028;3751.0622344413896;3763.6236376362144;3779.5842457329672;1095.7260684828793;1097.4896673046912;1111.3220935229665;1114.0864491117368;1130.6777568393134;875.9912400876037;891.4250308550949;892.161368313783;898.2813749000774;916.6012784438791;5540.390557038803;5556.6943818089585;5562.721863906789;5662.745176467069;5680.460356266148;421.93881887126196;424.7663784918283;427.7317752862777;428.476765100066;430.6640820160217;3657.6159503252306;3761.774293542396;3803.5435747710453;3841.9423708644395;3892.6885849132;10075.899241007643;10572.735681607868;10578.682639520826;10590.841137382946;10605.09856662177;10238.33450825694;10347.741306467247;10508.842367364496;10548.208884333551;10553;7862.488938218998;7999.800004999805;8018.238267364591;8037.517748935083;8038.477498962548;5380.300560927054;5428.864278393072;5437.4562543745305;5457.972710136424;5586.972065139648;9644.75888102775;9665.71002869915;9729.805403891742;9900.960399158274;9915.107640312406;8812.691555795516;9498.715038548855;9866.753331166778;9874.654387096418;9887.653932112342;6614.669266536558;7382.114146302478;7468.850622987401;7533.284337987882;7568.735094271894;8230;8244.093149753642;8309.958450207952;8324.791880203044;8462.788430289293;7549;7655.043119610049;7664.961675191588;7673.961630191813;7691.730789422343;7414.740484083247;7452.776416707507;7505.362044226302;7585.279398457138;7649.923500764921;6778.627175505198;6787.083743694538;6841.863162736618;6843.657817109025;6880.69036893351;4567.314902764612;4787.928181077356;4818.734969576707;4889.266610008385;4940.752962351796;4719.646026547954;4807.495213002724;4847.466778654275;4898.853034408973;4980.402351717817 18:41:40 INFO - PROCESS | 22251 | |4;prototype.html;318.88998295588027;328.6910304313945;331.2662452667343;333.65466741922114;338.6494977698083;5201.0118077565285;5267.947320526793;5285.312909321783;5319.946800531999;5345.305110335651;4958.801647934088;5029.673071250366;5074.162763144077;5088.949110508894;5142.254373115896;4098.364753463218;4106.753594784308;4116.917661646765;4122.50529936408;4130.4423902773115;4108.753474791522;4113.465249517559;4122.381642753581;4127.896802579945;4153.107081977374;3825.234953009395;3891.805409729516;4060.776657283848;4063.5123785145825;4073.1853629274115;4049.5343035550995;4052.858149964737;4053.574374690674;4065.247929133105;4067.3288907330257;3647.2340808429994;3651.361011822947;3652.3425783358985;3653.5981042085614;3661.8831256466765;4869.951300486985;5085.79656813727;5103.872403189913;5122.462141475166;5145.511176438233;4602.792874320664;4626.8149274029;4633.783257235933;4634.5169545745375;4674.602658774008;5420.186971954199;5430.972845135749;5446.440173118628;5464.781408743645;5481.616286859921;3769.754965927206;3907.8436862525464;3939.960600393988;3956.2285354355913;3973.6225058619384;5621.381648018714;5626.634268772557;5629.577781666432;5638.605297629168;5642.868208144479;3921.843126274974;3950.822213000422;3954.426608141803;3964.742291751027;3972.463717398114;3907.47249121365;4020.4974378202724;4027.536833264212;4030.435738996543;4051.858184963571;4534.251848444969;4551.226291530448;4556.612687921497;4567.474740404829;4571.22289210835;5368;5370.650907690988;5372.811951581754;5401.243825864382;5420.512153906167;1334.8932085433141;1371.5542448704011;1386.5424409944694;1393.4217299820664;1394.316784775473;878.1481962496368;896.9192772650492;902.9006809250977;903.4714691905309;910.9954450227839;4636.629069674418;4655.138799322069;4683.454460028182;4694.554017368345;4713.905721885543;4901.240307752304;4907.263910413395;4917.254849070664;4923.212286034217;4964.304997300381;4323.762193079411;4716.429545897494;4718.787654555554;4724;4732.337472753818;2608.5043841670404;2622.9508196721463;2633.3416645838543;2651.5624921888057;2651.880665370063;5026.29631851541;5039.168537191395;5044.218146187347;5058.671186372948;5077.31456253401;5307.15085586312;5667.4332566743;5684.687342196136;5710.114932185518;5715.685637289906;5773.884522309446;5775.422457754275;5792.594518383673;5805.129230615357;5808;5467.589930755289;5534.972325138348;5544.362398324083;5585.190147428519;5592.440755924375;5525.143602741581;5533.6956467393065;5536.231884057971;5541.362743284574;5542.501174894279;5758.481736643722;5769.653820770767;5769.769209231584;5793.828443520659;5802.767889284551;3760.849566017438;3897.941530877096;3928.626780455852;3929.7052721046607;3973.4834471519675;5333.226682130991;5484.808031718871;5495.093309603871;5506.91739623914;5539.25220095282;5330.920036199538;5365.853658536616;5368.362649391816;5411.512963833274;5451.591130665137;5274.498922602346;5404.513593776422;5407.621466497465;5414.7021913795115;5447;5402.297701298806;5428.375736790162;5457.754401051883;5460.3993560707495;5466.699331536804;5354.313391281734;5419.701916394636;5483.945160548344;5514.834554963358;5529.944700553104;5270.920936186037;5272.76272567743;5316.627836051439;5382.273393091882;5390.568754499709 18:41:40 INFO - PROCESS | 22251 | |5;yui.html;731.6634348199824;748.1770052941763;766.0692258905428;769.6228847864548;842.02745828568;15549.922250388761;16162.757558636615;17072.658546829072;17171.742423863652;17177.484675459742;16219.432319868807;16767;16897.493075207734;16935.068571228578;16941.83058169418;806.8507326144653;832.7585000349922;836.510641274855;836.8619177835681;837.0081453477618;679.5820570349249;689.7999580121759;693.8438851258477;699.2552931128357;815.902091748991;733.8715724748174;832.5878690048435;837.656560810068;837.6858677995751;841.1294310388749;837.0499483086679;837.4849467577457;838.8406202821475;839.6137776622761;840.5671079394117;627.7143899525705;628.0924064726427;628.214731585518;628.3025841316136;628.5191828251392;11554.76890462186;11776.764464710743;15227.162506062163;15660.608484787857;15711.842881571152;14462.855371446361;15222.162781047038;15314.693706125927;15484.690306193814;15529.456469023642;11758.647240582795;11886.28682279066;11916.821247681291;12033.338166400845;12216.877831221751;3798.5554369679126;3830.1765120499226;3863.8840834775;3932.7247092703524;4039.111395492987;67089.66455167742;82188.58905705492;83844.58077709633;85120.57439712762;85167.57416212941;11461.885381146249;11499.482523286471;11699.622882455096;11715.76568468626;11770.88229117715;21813;21822.23622173248;21896;21932.89033554822;21962.584115747253;8226.753197404087;8283.25450709439;8410.663573457115;8503.277221436247;8642.740717778477;4767.73777442237;4772.6420518461255;4835.516448355136;4858.222684370484;4895.069936712084;3747.3816820224356;3872.8257228424786;3879.747816391982;3879.8060096995036;3921.941170882439;615.7998650438625;640.3916279534461;641.6984017511762;650.180772226988;670.5004771445305;740.3743836458184;740.574169852337;742.2466196810242;754.5397307642334;772.9420293477899;9621.326507144433;9647.372920760128;9715.902840971641;10126.797464050678;10511.369317840954;708.7625645408742;757.6666266842682;757.8938948547208;761.6610608279374;764.7705688293489;4350;4616.584507394351;4699.718016918928;4701.3888194535175;4739.4075740532435;119628;120345;122145.38927305306;124057.37971310086;126793;65161.67419162969;97876.51061744646;100005.49997249967;100024.49987750014;100991;88951.55524222467;89483.55258223668;90103;90294;92114.53942730243;8830.91169088301;8964.058773828914;9025.774355641162;9087.36388452802;9142.412187220905;51809.740951295;51858.74070629623;53445.7327713359;54476.45523544714;54953.1757023653;71417;79664.60167699357;81289.18710812816;82794.58602706948;84543.05979736116;12258.387080645754;12385.442655080724;12498.125131240726;12533.248005119722;12557.874421256036;14140.858591414366;14160.679425025122;14454.710905781616;14537.200453975132;14997.2501374933;12567.560135395583;12982.80525792095;13016.15394999322;13467.663308417368;13711.657208569866;13078.738425231251;13146.868531314565;13230.338483076;13559.322033898068;13989.411958787658;12792.808107878576;13076.476940922257;13364.732705346034;13404.32978351059;13417.530386436429;10874.565017399533;11082.765171294042;11112.38881861473;11121.038837264725;11510;9704.639259541771;10959.506822192861;11114.610988615359;11509.712257193638;11799.705007374541 18:41:40 INFO - PROCESS | 22251 | __end_tp_report 18:41:40 INFO - PROCESS | 22251 | __start_cc_report 18:41:40 INFO - PROCESS | 22251 | _x_x_mozilla_cycle_collect,1032 18:41:40 INFO - PROCESS | 22251 | __end_cc_report 18:41:40 INFO - PROCESS | 22251 | __startTimestamp1476754900034__endTimestamp 18:41:40 INFO - PROCESS | 22251 | 18:41:40 INFO - PROCESS | 22251 | ------- Summary: start ------- 18:41:40 INFO - PROCESS | 22251 | Number of tests: 6 18:41:40 INFO - PROCESS | 22251 | 18:41:40 INFO - PROCESS | 22251 | [#0] dojo.html Cycles:165 Average:5213.30 Median:5377.68 stddev:587.92 (10.9%) stddev-sans-first:561.81 18:41:40 INFO - PROCESS | 22251 | Values: 2931.4 2979.9 3008.3 3014.2 3032.1 5121.2 5228.8 5248.3 5310.0 5386.9 5156.3 5181.4 5342.2 5355.3 5391.0 4734.6 4742.4 4773.5 4774.7 4799.2 4801.4 4818.5 4898.4 4901.4 4957.0 4671.4 4785.9 4790.1 4796.1 4908.7 4708.1 4750.4 4772.2 4777.3 4803.1 4756.1 4767.3 4779.0 4802.4 4830.3 5242.9 5265.7 5271.3 5278.0 5278.0 5366.2 5475.3 5475.3 5609.0 5619.3 5561.1 5656.8 5658.4 5721.8 5738.9 5290.7 5299.4 5301.7 5302.3 5304.2 5758.4 5764.8 5775.3 5776.2 5779.2 5329.8 5377.7 5381.2 5483.0 5524.6 5535.1 5539.0 5556.4 5625.7 5652.7 5584.2 5594.4 5595.4 5596.6 5597.0 5350.8 5462.9 5463.1 5606.0 5667.8 4285.5 4321.3 4329.4 4331.5 4336.5 3855.6 3857.2 3857.2 3897.0 3899.3 5124.4 5175.0 5361.8 5375.6 5443.9 5523.6 5557.9 5569.3 5609.2 5678.7 5311.4 5315.3 5322.8 5329.3 5359.8 4825.3 4832.5 4833.9 4840.0 4895.7 5587.4 5629.4 5775.3 5843.9 5844.4 5631.8 5660.3 5676.6 5717.1 5725.7 5840.5 5850.8 5868.8 5891.4 5898.5 5293.8 5335.3 5565.4 5569.9 5573.7 5535.0 5545.5 5591.7 5618.2 5683.4 5468.9 5472.1 5475.6 5483.3 5488.6 5349.9 5464.9 5501.7 5508.3 5572.7 5400.7 5429.5 5487.8 5510.6 5586.5 5515.5 5545.0 5570.0 5580.3 5583.5 5215.8 5220.1 5270.1 5364.1 5438.8 18:41:40 INFO - PROCESS | 22251 | 18:41:40 INFO - PROCESS | 22251 | [#1] ext.html Cycles:180 Average:61945.68 Median:37106.13 stddev:132810.79 (357.9%) stddev-sans-first:133103.44 18:41:40 INFO - PROCESS | 22251 | Values: 577.2 597.5 601.4 607.6 623.8 31602.4 43893.1 44683.3 44710.6 44727.6 44447.0 45053.5 45060.3 45074.0 45149.8 8162.8 8878.1 9034.5 9041.4 9045.4 8289.7 10941.1 11218.1 11225.2 11237.4 10666.1 10745.4 10752.0 10761.8 10763.1 10598.3 10653.9 10665.6 10666.2 10670.9 10612.3 10668.5 10671.7 10683.9 10697.8 42479.4 42731.4 42922.1 42922.4 42940.4 3366.6 3397.1 3399.6 3528.8 3862.5 31459.3 32453.0 32469.8 32492.5 32497.0 4199.5 4381.7 4468.2 4525.9 4527.5 290579.0 291396.0 291903.0 291936.0 294152.0 58649.1 58877.4 58914.0 58959.4 59124.0 61110.0 61148.4 61317.7 61366.5 61369.0 16943.2 16957.0 17090.5 17153.4 17154.7 11257.7 11326.4 12902.5 13285.1 13336.1 16822.2 17090.5 17528.5 17534.1 17542.1 6130.5 6520.5 6548.4 6601.6 6606.7 921.7 972.6 1055.9 1070.4 1102.8 31851.0 32034.0 32113.5 32208.2 32885.3 1065.7 1093.0 1108.6 1111.9 1151.6 16441.4 16886.0 17135.6 17182.0 17361.5 477493.0 704497.0 755794.0 772013.0 773390.0 51485.2 56104.1 57278.0 57287.1 63239.0 1333.6 1350.1 1367.6 1376.1 1378.8 30355.1 32353.5 32972.5 33204.4 33303.7 51514.5 51676.7 51798.5 51925.7 52054.7 390194.0 390261.0 390813.0 391341.0 391494.0 27213.3 27374.5 27458.6 27600.6 27850.4 46093.8 46388.0 48201.0 48323.0 48372.0 39610.6 40352.4 40877.3 41220.0 42500.6 38525.2 39609.6 40317.8 40627.4 41958.4 40273.8 40649.6 41062.5 41397.4 41440.8 33950.5 36383.3 36572.0 37047.3 37165.0 27344.6 27698.7 28035.6 28195.3 28211.3 18:41:40 INFO - PROCESS | 22251 | 18:41:40 INFO - PROCESS | 22251 | [#2] jquery.html Cycles:180 Average:26079.51 Median:12700.77 stddev:66389.10 (522.7%) stddev-sans-first:66547.27 18:41:40 INFO - PROCESS | 22251 | Values: 368.2 372.1 382.7 387.7 404.5 14206.8 18277.2 18879.6 18970.0 19794.7 18297.9 19193.6 19235.5 19313.8 19391.5 5376.7 5654.4 5659.3 5663.6 5667.3 4061.5 4276.1 4356.4 5593.0 5628.7 6363.7 6371.6 6372.8 6375.8 6381.6 6169.0 6200.6 6203.8 6249.9 6353.6 5462.3 5466.1 5475.7 5476.7 5481.3 22082.2 22735.8 22845.9 22940.8 23047.7 2184.6 2189.2 2245.5 2265.9 2353.9 13809.2 14560.1 14941.3 14951.3 14993.7 1866.1 1920.5 1953.0 1959.9 1963.3 82254.2 83537.2 83994.6 85455.6 87277.6 9324.6 9470.0 9711.3 10594.7 11228.8 14441.5 14471.8 14476.6 14488.7 14503.2 7893.7 8166.7 8207.8 8417.7 8528.3 7659.2 7705.5 7869.0 7962.1 8024.5 6192.2 6283.4 6472.5 6475.0 6523.3 1811.4 1860.4 1875.0 1879.1 1917.3 865.2 1017.5 1034.3 1039.8 1059.6 18933.3 19912.4 19974.1 19976.8 20340.0 925.9 944.2 979.7 1023.2 1074.9 10399.4 10674.4 10716.6 10766.1 10796.1 154518.0 425222.0 436883.0 438110.0 444517.0 91841.0 96345.5 96512.0 96608.0 102185.5 1022.5 1057.3 1074.9 1077.9 1087.9 16187.3 16194.5 16795.7 16827.8 16873.2 38909.0 40140.8 40642.0 40940.6 42728.0 57193.0 57814.7 58432.0 59615.4 60958.7 5536.3 8112.3 8316.5 8325.5 8524.5 9581.1 12946.1 12976.1 12977.5 13105.7 11367.8 11403.7 11505.1 11522.5 11870.6 10645.5 10987.6 11102.8 11116.8 11428.9 5963.8 11347.3 11433.0 11557.2 11706.5 5306.0 8060.7 8259.0 8305.7 8343.8 9741.8 11190.7 11217.1 11511.4 11664.5 18:41:40 INFO - PROCESS | 22251 | 18:41:40 INFO - PROCESS | 22251 | [#3] mootools.html Cycles:180 Average:5553.25 Median:4871.52 stddev:3192.85 (65.5%) stddev-sans-first:3185.86 18:41:40 INFO - PROCESS | 22251 | Values: 1307.4 1414.3 1420.0 1550.1 1723.6 7323.4 8098.3 8412.0 8426.9 8631.7 8389.7 8457.7 8463.1 8474.3 8482.2 2247.3 2250.8 2272.7 2273.0 2278.2 2023.5 2063.0 2093.2 2095.9 2097.9 2260.1 2278.6 2290.1 2292.7 2296.5 2201.3 2216.4 2224.0 2227.3 2227.9 2198.8 2203.5 2203.5 2207.6 2209.3 8525.1 8657.8 8687.6 8723.6 8724.2 5140.6 5320.4 5334.3 5346.7 5362.8 3502.4 3555.5 3569.9 3601.3 3618.4 1118.4 1119.9 1130.2 1145.7 1153.7 11889.7 11945.2 11998.6 12038.1 12111.2 4254.4 4355.2 4516.6 4526.2 4575.1 9416.7 9431.8 9438.4 9443.0 9445.2 5160.4 5172.3 5175.7 5177.8 5190.9 4049.5 4237.6 4360.8 4827.3 4853.8 3654.3 3744.8 3751.1 3763.6 3779.6 1095.7 1097.5 1111.3 1114.1 1130.7 876.0 891.4 892.2 898.3 916.6 5540.4 5556.7 5562.7 5662.7 5680.5 421.9 424.8 427.7 428.5 430.7 3657.6 3761.8 3803.5 3841.9 3892.7 10075.9 10572.7 10578.7 10590.8 10605.1 10238.3 10347.7 10508.8 10548.2 10553.0 7862.5 7999.8 8018.2 8037.5 8038.5 5380.3 5428.9 5437.5 5458.0 5587.0 9644.8 9665.7 9729.8 9901.0 9915.1 8812.7 9498.7 9866.8 9874.7 9887.7 6614.7 7382.1 7468.9 7533.3 7568.7 8230.0 8244.1 8310.0 8324.8 8462.8 7549.0 7655.0 7665.0 7674.0 7691.7 7414.7 7452.8 7505.4 7585.3 7649.9 6778.6 6787.1 6841.9 6843.7 6880.7 4567.3 4787.9 4818.7 4889.3 4940.8 4719.6 4807.5 4847.5 4898.9 4980.4 18:41:40 INFO - PROCESS | 22251 | 18:41:40 INFO - PROCESS | 22251 | [#4] prototype.html Cycles:180 Average:4501.20 Median:5051.44 stddev:1325.87 (26.2%) stddev-sans-first:1291.90 18:41:40 INFO - PROCESS | 22251 | Values: 318.9 328.7 331.3 333.7 338.6 5201.0 5267.9 5285.3 5319.9 5345.3 4958.8 5029.7 5074.2 5088.9 5142.3 4098.4 4106.8 4116.9 4122.5 4130.4 4108.8 4113.5 4122.4 4127.9 4153.1 3825.2 3891.8 4060.8 4063.5 4073.2 4049.5 4052.9 4053.6 4065.2 4067.3 3647.2 3651.4 3652.3 3653.6 3661.9 4870.0 5085.8 5103.9 5122.5 5145.5 4602.8 4626.8 4633.8 4634.5 4674.6 5420.2 5431.0 5446.4 5464.8 5481.6 3769.8 3907.8 3940.0 3956.2 3973.6 5621.4 5626.6 5629.6 5638.6 5642.9 3921.8 3950.8 3954.4 3964.7 3972.5 3907.5 4020.5 4027.5 4030.4 4051.9 4534.3 4551.2 4556.6 4567.5 4571.2 5368.0 5370.7 5372.8 5401.2 5420.5 1334.9 1371.6 1386.5 1393.4 1394.3 878.1 896.9 902.9 903.5 911.0 4636.6 4655.1 4683.5 4694.6 4713.9 4901.2 4907.3 4917.3 4923.2 4964.3 4323.8 4716.4 4718.8 4724.0 4732.3 2608.5 2623.0 2633.3 2651.6 2651.9 5026.3 5039.2 5044.2 5058.7 5077.3 5307.2 5667.4 5684.7 5710.1 5715.7 5773.9 5775.4 5792.6 5805.1 5808.0 5467.6 5535.0 5544.4 5585.2 5592.4 5525.1 5533.7 5536.2 5541.4 5542.5 5758.5 5769.7 5769.8 5793.8 5802.8 3760.8 3897.9 3928.6 3929.7 3973.5 5333.2 5484.8 5495.1 5506.9 5539.3 5330.9 5365.9 5368.4 5411.5 5451.6 5274.5 5404.5 5407.6 5414.7 5447.0 5402.3 5428.4 5457.8 5460.4 5466.7 5354.3 5419.7 5483.9 5514.8 5529.9 5270.9 5272.8 5316.6 5382.3 5390.6 18:41:40 INFO - PROCESS | 22251 | 18:41:40 INFO - PROCESS | 22251 | [#5] yui.html Cycles:180 Average:21324.72 Median:4658.15 stddev:31102.66 (667.7%) stddev-sans-first:31151.48 18:41:40 INFO - PROCESS | 22251 | Values: 731.7 748.2 766.1 769.6 842.0 15549.9 16162.8 17072.7 17171.7 17177.5 16219.4 16767.0 16897.5 16935.1 16941.8 806.9 832.8 836.5 836.9 837.0 679.6 689.8 693.8 699.3 815.9 733.9 832.6 837.7 837.7 841.1 837.0 837.5 838.8 839.6 840.6 627.7 628.1 628.2 628.3 628.5 11554.8 11776.8 15227.2 15660.6 15711.8 14462.9 15222.2 15314.7 15484.7 15529.5 11758.6 11886.3 11916.8 12033.3 12216.9 3798.6 3830.2 3863.9 3932.7 4039.1 67089.7 82188.6 83844.6 85120.6 85167.6 11461.9 11499.5 11699.6 11715.8 11770.9 21813.0 21822.2 21896.0 21932.9 21962.6 8226.8 8283.3 8410.7 8503.3 8642.7 4767.7 4772.6 4835.5 4858.2 4895.1 3747.4 3872.8 3879.7 3879.8 3921.9 615.8 640.4 641.7 650.2 670.5 740.4 740.6 742.2 754.5 772.9 9621.3 9647.4 9715.9 10126.8 10511.4 708.8 757.7 757.9 761.7 764.8 4350.0 4616.6 4699.7 4701.4 4739.4 119628.0 120345.0 122145.4 124057.4 126793.0 65161.7 97876.5 100005.5 100024.5 100991.0 88951.6 89483.6 90103.0 90294.0 92114.5 8830.9 8964.1 9025.8 9087.4 9142.4 51809.7 51858.7 53445.7 54476.5 54953.2 71417.0 79664.6 81289.2 82794.6 84543.1 12258.4 12385.4 12498.1 12533.2 12557.9 14140.9 14160.7 14454.7 14537.2 14997.3 12567.6 12982.8 13016.2 13467.7 13711.7 13078.7 13146.9 13230.3 13559.3 13989.4 12792.8 13076.5 13364.7 13404.3 13417.5 10874.6 11082.8 11112.4 11121.0 11510.0 9704.6 10959.5 11114.6 11509.7 11799.7 18:41:40 INFO - PROCESS | 22251 | -------- Summary: end -------- 18:41:40 INFO - PROCESS | 22251 | 18:41:40 INFO - TEST-INFO | 22251: exit 0 18:41:40 INFO - TEST-OK | dromaeo_css | took 1117637ms 18:41:40 INFO - TEST-START | kraken 18:41:40 INFO - operating with platform_type : linux_ 18:41:40 INFO - Initialising browser for kraken test... 18:41:40 INFO - TEST-INFO | started process 22559 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKtEndM/profile http://localhost:42300/getInfo.html) 18:41:44 INFO - PROCESS | 22559 | __metrics Screen width/height:1600/1200 18:41:44 INFO - PROCESS | 22559 | colorDepth:24 18:41:44 INFO - PROCESS | 22559 | Browser inner width/height: 1024/697 18:41:44 INFO - PROCESS | 22559 | __metrics 18:41:45 INFO - PROCESS | 22559 | 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" 18:41:45 INFO - PROCESS | 22559 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:41:46 INFO - PROCESS | 22559 | console.error: PushService: 18:41:46 INFO - PROCESS | 22559 | stateChangeProcessEnqueue: Error transitioning state 18:41:46 INFO - PROCESS | 22559 | UnknownError 18:41:46 INFO - TEST-INFO | 22559: exit 0 18:41:46 INFO - Browser initialized. 18:41:46 INFO - Running cycle 1/1 for kraken test... 18:41:46 INFO - TEST-INFO | started process 22641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKtEndM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:41:58 INFO - PROCESS | 22641 | RSS: Main: 172040192 18:41:58 INFO - PROCESS | 22641 | 18:42:01 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42300/tests/kraken/driver.html?testName=audio-beat-detection) 18:42:02 INFO - PROCESS | 22641 | RSS: Main: 228999168 18:42:02 INFO - PROCESS | 22641 | 18:42:04 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42300/tests/kraken/driver.html?testName=audio-dft) 18:42:05 INFO - PROCESS | 22641 | RSS: Main: 215764992 18:42:05 INFO - PROCESS | 22641 | 18:42:08 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42300/tests/kraken/driver.html?testName=audio-fft) 18:42:09 INFO - PROCESS | 22641 | RSS: Main: 296931328 18:42:09 INFO - PROCESS | 22641 | 18:42:11 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42300/tests/kraken/driver.html?testName=audio-oscillator) 18:42:12 INFO - PROCESS | 22641 | RSS: Main: 206790656 18:42:12 INFO - PROCESS | 22641 | 18:42:14 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42300/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:42:14 INFO - PROCESS | 22641 | RSS: Main: 212258816 18:42:14 INFO - PROCESS | 22641 | 18:42:17 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42300/tests/kraken/driver.html?testName=imaging-darkroom) 18:42:18 INFO - PROCESS | 22641 | RSS: Main: 247955456 18:42:18 INFO - PROCESS | 22641 | 18:42:21 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42300/tests/kraken/driver.html?testName=imaging-desaturate) 18:42:22 INFO - PROCESS | 22641 | RSS: Main: 247201792 18:42:22 INFO - PROCESS | 22641 | 18:42:24 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42300/tests/kraken/driver.html?testName=json-parse-financial) 18:42:25 INFO - PROCESS | 22641 | RSS: Main: 246849536 18:42:25 INFO - PROCESS | 22641 | 18:42:27 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42300/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:42:27 INFO - PROCESS | 22641 | RSS: Main: 209453056 18:42:27 INFO - PROCESS | 22641 | 18:42:29 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42300/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:42:29 INFO - PROCESS | 22641 | RSS: Main: 217001984 18:42:29 INFO - PROCESS | 22641 | 18:42:32 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42300/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:42:32 INFO - PROCESS | 22641 | RSS: Main: 225759232 18:42:32 INFO - PROCESS | 22641 | 18:42:35 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:42:36 INFO - PROCESS | 22641 | RSS: Main: 230576128 18:42:36 INFO - PROCESS | 22641 | 18:42:38 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:42:39 INFO - PROCESS | 22641 | RSS: Main: 231661568 18:42:39 INFO - PROCESS | 22641 | 18:42:41 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42300/tests/kraken/driver.html?testName=ai-astar) 18:42:41 INFO - PROCESS | 22641 | RSS: Main: 281763840 18:42:41 INFO - PROCESS | 22641 | 18:42:41 INFO - PROCESS | 22641 | __start_tp_report 18:42:41 INFO - PROCESS | 22641 | _x_x_mozilla_page_load 18:42:41 INFO - PROCESS | 22641 | _x_x_mozilla_page_load_details 18:42:41 INFO - PROCESS | 22641 | |i|pagename|runs| 18:42:41 INFO - PROCESS | 22641 | |0;ai-astar;107;111;111;111;112;111;112;111;111;111 18:42:41 INFO - PROCESS | 22641 | |1;audio-beat-detection;153;124;125;166;122;132;128;124;156;122 18:42:41 INFO - PROCESS | 22641 | |2;audio-dft;163;163;163;162;161;163;163;162;162;163 18:42:41 INFO - PROCESS | 22641 | |3;audio-fft;75;77;75;111;76;76;75;75;98;75 18:42:41 INFO - PROCESS | 22641 | |4;audio-oscillator;82;83;113;81;82;81;115;83;83;107 18:42:41 INFO - PROCESS | 22641 | |5;imaging-gaussian-blur;116;117;116;117;117;116;116;117;116;117 18:42:41 INFO - PROCESS | 22641 | |6;imaging-darkroom;146;146;145;146;146;146;145;145;145;146 18:42:41 INFO - PROCESS | 22641 | |7;imaging-desaturate;84;85;85;85;84;84;84;84;85;85 18:42:41 INFO - PROCESS | 22641 | |8;json-parse-financial;57;51;50;50;52;52;53;53;50;52 18:42:41 INFO - PROCESS | 22641 | |9;json-stringify-tinderbox;58;59;59;59;59;59;59;58;59;59 18:42:41 INFO - PROCESS | 22641 | |10;stanford-crypto-aes;80;80;87;90;83;80;80;80;90;83 18:42:41 INFO - PROCESS | 22641 | |11;stanford-crypto-ccm;133;131;130;131;138;151;134;139;189;131 18:42:41 INFO - PROCESS | 22641 | |12;stanford-crypto-pbkdf2;174;169;169;176;172;168;165;172;170;167 18:42:41 INFO - PROCESS | 22641 | |13;stanford-crypto-sha256-iterative;67;72;70;68;69;65;69;64;65;65 18:42:41 INFO - PROCESS | 22641 | __end_tp_report 18:42:41 INFO - PROCESS | 22641 | __start_cc_report 18:42:41 INFO - PROCESS | 22641 | _x_x_mozilla_cycle_collect,1724 18:42:41 INFO - PROCESS | 22641 | __end_cc_report 18:42:41 INFO - PROCESS | 22641 | __startTimestamp1476754961386__endTimestamp 18:42:41 INFO - PROCESS | 22641 | 18:42:41 INFO - PROCESS | 22641 | ------- Summary: start ------- 18:42:41 INFO - PROCESS | 22641 | Number of tests: 14 18:42:41 INFO - PROCESS | 22641 | 18:42:41 INFO - PROCESS | 22641 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.40 (1.3%) stddev-sans-first:0.44 18:42:41 INFO - PROCESS | 22641 | Values: 107.0 111.0 111.0 111.0 112.0 111.0 112.0 111.0 111.0 111.0 18:42:41 INFO - PROCESS | 22641 | 18:42:41 INFO - PROCESS | 22641 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:130.00 stddev:16.54 (12.7%) stddev-sans-first:16.25 18:42:41 INFO - PROCESS | 22641 | Values: 153.0 124.0 125.0 166.0 122.0 132.0 128.0 124.0 156.0 122.0 18:42:41 INFO - PROCESS | 22641 | 18:42:41 INFO - PROCESS | 22641 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:0.71 (0.4%) stddev-sans-first:0.73 18:42:41 INFO - PROCESS | 22641 | Values: 163.0 163.0 163.0 162.0 161.0 163.0 163.0 162.0 162.0 163.0 18:42:41 INFO - PROCESS | 22641 | 18:42:41 INFO - PROCESS | 22641 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.50 stddev:12.62 (16.7%) stddev-sans-first:13.18 18:42:41 INFO - PROCESS | 22641 | Values: 75.0 77.0 75.0 111.0 76.0 76.0 75.0 75.0 98.0 75.0 18:42:41 INFO - PROCESS | 22641 | 18:42:41 INFO - PROCESS | 22641 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:82.00 stddev:14.41 (17.6%) stddev-sans-first:14.92 18:42:41 INFO - PROCESS | 22641 | Values: 82.0 83.0 113.0 81.0 82.0 81.0 115.0 83.0 83.0 107.0 18:42:41 INFO - PROCESS | 22641 | 18:42:41 INFO - PROCESS | 22641 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:42:41 INFO - PROCESS | 22641 | Values: 116.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 18:42:41 INFO - PROCESS | 22641 | 18:42:41 INFO - PROCESS | 22641 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 18:42:41 INFO - PROCESS | 22641 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 145.0 146.0 18:42:41 INFO - PROCESS | 22641 | 18:42:41 INFO - PROCESS | 22641 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 18:42:41 INFO - PROCESS | 22641 | Values: 84.0 85.0 85.0 85.0 84.0 84.0 84.0 84.0 85.0 85.0 18:42:41 INFO - PROCESS | 22641 | 18:42:41 INFO - PROCESS | 22641 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:2.11 (4.1%) stddev-sans-first:1.24 18:42:41 INFO - PROCESS | 22641 | Values: 57.0 51.0 50.0 50.0 52.0 52.0 53.0 53.0 50.0 52.0 18:42:41 INFO - PROCESS | 22641 | 18:42:41 INFO - PROCESS | 22641 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 18:42:41 INFO - PROCESS | 22641 | Values: 58.0 59.0 59.0 59.0 59.0 59.0 59.0 58.0 59.0 59.0 18:42:41 INFO - PROCESS | 22641 | 18:42:41 INFO - PROCESS | 22641 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:4.19 (5.0%) stddev-sans-first:4.27 18:42:41 INFO - PROCESS | 22641 | Values: 80.0 80.0 87.0 90.0 83.0 80.0 80.0 80.0 90.0 83.0 18:42:41 INFO - PROCESS | 22641 | 18:42:41 INFO - PROCESS | 22641 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:136.00 stddev:18.10 (13.3%) stddev-sans-first:18.99 18:42:41 INFO - PROCESS | 22641 | Values: 133.0 131.0 130.0 131.0 138.0 151.0 134.0 139.0 189.0 131.0 18:42:41 INFO - PROCESS | 22641 | 18:42:41 INFO - PROCESS | 22641 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:171.00 stddev:3.33 (1.9%) stddev-sans-first:3.23 18:42:41 INFO - PROCESS | 22641 | Values: 174.0 169.0 169.0 176.0 172.0 168.0 165.0 172.0 170.0 167.0 18:42:41 INFO - PROCESS | 22641 | 18:42:41 INFO - PROCESS | 22641 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.50 stddev:2.63 (3.8%) stddev-sans-first:2.79 18:42:41 INFO - PROCESS | 22641 | Values: 67.0 72.0 70.0 68.0 69.0 65.0 69.0 64.0 65.0 65.0 18:42:41 INFO - PROCESS | 22641 | -------- Summary: end -------- 18:42:41 INFO - PROCESS | 22641 | 18:42:42 INFO - TEST-INFO | 22641: exit 0 18:42:42 INFO - TEST-OK | kraken | took 61723ms 18:42:42 INFO - SUITE-END | took 1179s 18:42:43 INFO - Completed test suite (00:19:39) 18:42:43 INFO - javascript benchmark 18:42:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2931.355101877586, 2979.8957036503725, 3008.2780132768144, 3014.2012366722824, 3032.135841285234, 5121.155009423441, 5228.816991405301, 5248.343957005374, 5310.0441920454305, 5386.865328366793, 5156.329677141966, 5181.35233095863, 5342.225377320296, 5355.250264962909, 5391.0, 4734.550217729327, 4742.359781429514, 4773.498782627827, 4774.689645173053, 4799.232122860343, 4801.375821143264, 4818.469968303484, 4898.387701537308, 4901.436334821506, 4956.950430495703, 4671.416072990876, 4785.928211076836, 4790.137775200463, 4796.112719146951, 4908.7300198489065, 4708.128996135726, 4750.382450281476, 4772.236442169236, 4777.331173635694, 4803.063402636487, 4756.096341695102, 4767.261074533453, 4778.952210477885, 4802.35168252285, 4830.3237546743485, 5242.868928276824, 5265.657732247391, 5271.288376069258, 5277.973610131963, 5278.0, 5366.168243922199, 5475.260839786658, 5475.288212532385, 5608.971955140199, 5619.325680918275, 5561.110222364443, 5656.8020119295625, 5658.377578466366, 5721.7711291548285, 5738.856528586777, 5290.709011004393, 5299.364076310867, 5301.73491325436, 5302.337207849019, 5304.177852432879, 5758.395368486333, 5764.769409223668, 5775.335836378787, 5776.191333213354, 5779.162021506942, 5329.840104796862, 5377.677339359651, 5381.2197231402015, 5483.0, 5524.613277070647, 5535.086710692691, 5539.0, 5556.444355564492, 5625.71871406428, 5652.660840349592, 5584.21820945068, 5594.440555944454, 5595.38450770415, 5596.552275817925, 5596.972015139898, 5350.759215835219, 5462.890742185134, 5463.098588732814, 5606.046972014768, 5667.773289068391, 4285.528591854956, 4321.308590625485, 4329.350597410351, 4331.480222373335, 4336.479622445264, 3855.556610989716, 3857.1707082977296, 3857.2092720992127, 3896.980515097463, 3899.337112690849, 5124.436312005676, 5175.0, 5361.812336568201, 5375.569954403638, 5443.863903402367, 5523.613347065747, 5557.888842223133, 5569.303837020372, 5609.186667933127, 5678.716064196857, 5311.362636483646, 5315.282436870973, 5322.828977624917, 5329.280547126166, 5359.785608575691, 4825.276208568743, 4832.540908613676, 4833.927491087637, 4839.951600484021, 4895.73073480962, 5587.44125587438, 5629.380768115422, 5775.27809023872, 5843.889660964403, 5844.444777746107, 5631.802886898939, 5660.320761508646, 5676.602637815313, 5717.113847353667, 5725.656460612377, 5840.503557197686, 5850.765969361178, 5868.794592189253, 5891.381404952418, 5898.469137777621, 5293.788248470018, 5335.253064571041, 5565.38780734127, 5569.916451253315, 5573.749181286771, 5535.0, 5545.473180047889, 5591.720413979366, 5618.213450116905, 5683.3748287687495, 5468.91796623059, 5472.069748142905, 5475.561955043508, 5483.341998960151, 5488.588355873405, 5349.893002140013, 5464.9343378042495, 5501.724913754377, 5508.283923090133, 5572.665640061609, 5400.675959442289, 5429.538489228302, 5487.807926722546, 5510.559155267649, 5586.52514536269, 5515.503604675599, 5545.0, 5569.997400467792, 5580.302462192226, 5583.469570390806, 5215.817446389358, 5220.060389129993, 5270.051390749702, 5364.14173732201, 5438.83683489496], "value": 5173.665566331386, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.1659951370269, 597.5249676507176, 601.3535449391904, 607.6354187487507, 623.797265888586, 31602.367952640932, 43893.12213755727, 44683.329750053774, 44710.552894471046, 44727.552724472785, 44447.0, 45053.54946450535, 45060.324095138516, 45074.0, 45149.77425112878, 8162.836743265131, 8878.067802880685, 9034.548272586344, 9041.412308199946, 9045.3668243223, 8289.709860154895, 10941.070009049201, 11218.102551795837, 11225.214235003554, 11237.381943993078, 10666.093382062534, 10745.409002504859, 10752.03231709146, 10761.76239732429, 10763.085137763299, 10598.31110977784, 10653.893461065367, 10665.573377064908, 10666.200034997328, 10670.893291067106, 10612.257142000062, 10668.519916603771, 10671.733206669818, 10683.893161068367, 10697.786044279148, 42479.36280955788, 42731.35902961458, 42922.14155716868, 42922.356164657554, 42940.3558946616, 3366.562346894888, 3397.11674964511, 3399.5920489541168, 3528.823558822074, 3862.517185351831, 31459.34794036831, 32453.0, 32469.837650811594, 32492.512612310835, 32497.0, 4199.538050814408, 4381.715188512769, 4468.240399132155, 4525.886852828673, 4527.501974782771, 290579.0, 291396.0, 291903.0, 291936.0, 294152.0, 58649.120263196084, 58877.41122588719, 58914.0, 58959.41040589539, 59124.0, 61110.0, 61148.388516115156, 61317.69341153266, 61366.465838353506, 61369.0, 16943.237554310086, 16957.0, 17090.48728538146, 17153.399631012853, 17154.742678859828, 11257.662270131908, 11326.377049262204, 12902.548410805577, 13285.13646612967, 13336.133151345131, 16822.15889205559, 17090.48728538146, 17528.474145775646, 17534.12329383526, 17542.14072903959, 6130.509559235251, 6520.47836173105, 6548.410643042149, 6601.603903765789, 6606.669666516655, 921.6543796076471, 972.6255391674256, 1055.8680164979378, 1070.3631339353071, 1102.823548232295, 31851.0, 32034.0, 32113.51829722556, 32208.19479512984, 32885.342293154485, 1065.737101534684, 1092.983605245922, 1108.634150730257, 1111.9054880335261, 1151.614209239914, 16441.424550140688, 16886.0, 17135.57161070983, 17182.0, 17361.47915562535, 477493.0, 704497.0, 755794.0, 772013.0, 773390.0, 51485.227721584204, 56104.14541964128, 57278.0, 57287.14069288964, 63239.0, 1333.5932540575218, 1350.1426594112809, 1367.5692156970722, 1376.057400680537, 1378.8414332351908, 30355.091644608878, 32353.51469727909, 32972.50541241835, 33204.42181441711, 33303.66696333102, 51514.48485515097, 51676.74161629168, 51798.482015180874, 51925.7403712979, 52054.73972630112, 390194.0, 390261.0, 390813.0, 391341.0, 391494.0, 27213.319667008484, 27374.45251095007, 27458.5881211778, 27600.585991209748, 27850.44299113966, 46093.76953115347, 46388.011122259944, 48201.0, 48323.0, 48372.0, 39610.60389396069, 40352.39471407873, 40877.32802831132, 41220.0, 42500.5749942509, 38525.229495409374, 39609.603903961746, 40317.79841100893, 40627.390589141774, 41958.370624440046, 40273.798631006655, 40649.593504065764, 41062.53348945211, 41397.379039315034, 41440.79279603583, 33950.49074263839, 36383.27233455369, 36572.0, 37047.25905481929, 37165.0, 27344.589831152945, 27698.72301277042, 28035.57946630843, 28195.295117622223, 28211.294717632223], "value": 20385.901716774923, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.19365589359285, 372.1199363505311, 382.7072289698381, 387.66079680279756, 404.4560066710275, 14206.786898196522, 18277.177527011285, 18879.62240755184, 18970.0, 19794.70307945382, 18297.908510457462, 19193.616127677436, 19235.519112022208, 19313.806861931378, 19391.515212119702, 5376.704281264529, 5654.406287339832, 5659.264295641561, 5663.575231857607, 5667.348254950672, 4061.4923134608175, 4276.059266961279, 4356.368326592642, 5592.972035139818, 5628.718564071801, 6363.7454501819875, 6371.649559274238, 6372.808815735512, 6375.776847810327, 6381.553291269613, 6169.012957926732, 6200.596961197552, 6203.751849925998, 6249.9062514062325, 6353.555251132422, 5462.262594549725, 5466.070767969415, 5475.67145971239, 5476.6713997159895, 5481.314835645544, 22082.22712205065, 22735.772642273532, 22845.885770571207, 22940.770592294197, 23047.65808957692, 2184.595849767798, 2189.200941656284, 2245.539664368817, 2265.9433514162115, 2353.882305884716, 13809.24049177295, 14560.126392416489, 14941.327640256215, 14951.252437378087, 14993.700125997419, 1866.1042699504178, 1920.5004457592981, 1952.9804701952942, 1959.8628096033283, 1963.33246696124, 82254.17745822525, 83537.24082416306, 83994.58002710009, 85455.57272213598, 87277.56361218153, 9324.627014919462, 9469.952650236704, 9711.3202075854, 10594.735131621617, 11228.831567526493, 14441.49454769078, 14471.78292325616, 14476.565703028926, 14488.710225795425, 14503.202323872289, 7893.723719669784, 8166.714165004197, 8207.794805129919, 8417.747467575982, 8528.275096616733, 7659.234076592407, 7705.537667739842, 7869.0, 7962.08436029864, 8024.518528888286, 6192.225971753531, 6283.434490895841, 6472.514561407913, 6474.967625161844, 6523.282438931714, 1811.3750755989163, 1860.4232687866804, 1874.9719203486272, 1879.0792511669456, 1917.2906024770923, 865.2429124516049, 1017.5065093429681, 1034.3483605328745, 1039.838824982129, 1059.6079450603172, 18933.33733319327, 19912.402627921187, 19974.10116544759, 19976.800231997786, 20340.0, 925.8750068740768, 944.15026476172, 979.715882394112, 1023.22746326523, 1074.9193810464246, 10399.428031458192, 10674.412907290018, 10716.550095603212, 10766.084882785051, 10796.136309095253, 154518.0, 425222.0, 436883.0, 438110.0, 444517.0, 91841.0, 96345.51827240818, 96512.0, 96608.0, 102185.48907255565, 1022.4632068164125, 1057.259918057363, 1074.9355038697859, 1077.8598782158426, 1087.907527860125, 16187.27157277949, 16194.514164575081, 16795.74806377881, 16827.831721683116, 16873.240704168096, 38909.0, 40140.79929600333, 40642.0, 40940.59059409368, 42728.0, 57193.0, 57814.7109264451, 58432.0, 59615.40384596099, 60958.695206523684, 5536.335639723259, 8112.310453611273, 8316.501009939422, 8325.50046997158, 8524.488530688179, 9581.089796469325, 12946.093773435769, 12976.091673582758, 12977.480900763863, 13105.672358191121, 11367.829482557934, 11403.714907127389, 11505.137114716263, 11522.53909843597, 11870.584529541424, 10645.467726613484, 10987.560497580007, 11102.777944441228, 11116.777664446827, 11428.885711142782, 5963.761449541969, 11347.262427942158, 11433.0, 11557.24877882935, 11706.473208705458, 5306.0, 8060.717874874351, 8259.0, 8305.709300174465, 8343.791405214919, 9741.805163896825, 11190.720231993939, 11217.102631789601, 11511.424428778695, 11664.475098620753], "value": 9125.926809364326, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1307.398596645543, 1414.278717853895, 1419.9574012779617, 1550.1474189195947, 1723.594955185532, 7323.377512911402, 8098.311643510301, 8412.0, 8426.915730842697, 8631.69789057383, 8389.706360277392, 8457.661693532267, 8463.111373305806, 8474.279686226662, 8482.236598706115, 2247.2584047264404, 2250.8086812620863, 2272.6591011348264, 2272.9771602778733, 2278.1798552521077, 2023.494126468383, 2063.040686080972, 2093.1941202637017, 2095.9476013099643, 2097.895105244739, 2260.062074239189, 2278.646809744492, 2290.0725206291395, 2292.6790249365104, 2296.494771150353, 2201.3379898176936, 2216.357256395643, 2223.9888800555896, 2227.2538699535594, 2227.899744511501, 2198.769129241439, 2203.460152262706, 2203.4711669199437, 2207.55848830233, 2209.3151123151715, 8525.104863989316, 8657.783555411102, 8687.565621718952, 8723.60743766532, 8724.171203735636, 5140.640155189139, 5320.361556613192, 5334.27987221724, 5346.679199248058, 5362.839114826562, 3502.404591219499, 3555.484454754046, 3569.9107522311892, 3601.3337532556297, 3618.3667858124722, 1118.3569447567681, 1119.86561612607, 1130.2032067392468, 1145.7192987717979, 1153.6885041038872, 11889.702757431047, 11945.163838531307, 11998.58004969822, 12038.097142714332, 12111.212771169845, 4254.404383386328, 4355.216061109031, 4516.570925762047, 4526.230540808005, 4575.062112266977, 9416.670416535388, 9431.811363772686, 9438.433693978383, 9443.0, 9445.19715824149, 5160.380754309507, 5172.27588137661, 5175.663581867242, 5177.792888284502, 5190.948090519122, 4049.534303555129, 4237.555056719, 4360.760158191267, 4827.324174615556, 4853.781579828917, 3654.3422184006604, 3744.794036328028, 3751.0622344413896, 3763.6236376362144, 3779.5842457329672, 1095.7260684828793, 1097.4896673046912, 1111.3220935229665, 1114.0864491117368, 1130.6777568393134, 875.9912400876037, 891.4250308550949, 892.161368313783, 898.2813749000774, 916.6012784438791, 5540.390557038803, 5556.6943818089585, 5562.721863906789, 5662.745176467069, 5680.460356266148, 421.93881887126196, 424.7663784918283, 427.7317752862777, 428.476765100066, 430.6640820160217, 3657.6159503252306, 3761.774293542396, 3803.5435747710453, 3841.9423708644395, 3892.6885849132, 10075.899241007643, 10572.735681607868, 10578.682639520826, 10590.841137382946, 10605.09856662177, 10238.33450825694, 10347.741306467247, 10508.842367364496, 10548.208884333551, 10553.0, 7862.488938218998, 7999.800004999805, 8018.238267364591, 8037.517748935083, 8038.477498962548, 5380.300560927054, 5428.864278393072, 5437.4562543745305, 5457.972710136424, 5586.972065139648, 9644.75888102775, 9665.71002869915, 9729.805403891742, 9900.960399158274, 9915.107640312406, 8812.691555795516, 9498.715038548855, 9866.753331166778, 9874.654387096418, 9887.653932112342, 6614.669266536558, 7382.114146302478, 7468.850622987401, 7533.284337987882, 7568.735094271894, 8230.0, 8244.093149753642, 8309.958450207952, 8324.791880203044, 8462.788430289293, 7549.0, 7655.043119610049, 7664.961675191588, 7673.961630191813, 7691.730789422343, 7414.740484083247, 7452.776416707507, 7505.362044226302, 7585.279398457138, 7649.923500764921, 6778.627175505198, 6787.083743694538, 6841.863162736618, 6843.657817109025, 6880.69036893351, 4567.314902764612, 4787.928181077356, 4818.734969576707, 4889.266610008385, 4940.752962351796, 4719.646026547954, 4807.495213002724, 4847.466778654275, 4898.853034408973, 4980.402351717817], "value": 4351.210337699102, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.88998295588027, 328.6910304313945, 331.2662452667343, 333.65466741922114, 338.6494977698083, 5201.0118077565285, 5267.947320526793, 5285.312909321783, 5319.946800531999, 5345.305110335651, 4958.801647934088, 5029.673071250366, 5074.162763144077, 5088.949110508894, 5142.254373115896, 4098.364753463218, 4106.753594784308, 4116.917661646765, 4122.50529936408, 4130.4423902773115, 4108.753474791522, 4113.465249517559, 4122.381642753581, 4127.896802579945, 4153.107081977374, 3825.234953009395, 3891.805409729516, 4060.776657283848, 4063.5123785145825, 4073.1853629274115, 4049.5343035550995, 4052.858149964737, 4053.574374690674, 4065.247929133105, 4067.3288907330257, 3647.2340808429994, 3651.361011822947, 3652.3425783358985, 3653.5981042085614, 3661.8831256466765, 4869.951300486985, 5085.79656813727, 5103.872403189913, 5122.462141475166, 5145.511176438233, 4602.792874320664, 4626.8149274029, 4633.783257235933, 4634.5169545745375, 4674.602658774008, 5420.186971954199, 5430.972845135749, 5446.440173118628, 5464.781408743645, 5481.616286859921, 3769.754965927206, 3907.8436862525464, 3939.960600393988, 3956.2285354355913, 3973.6225058619384, 5621.381648018714, 5626.634268772557, 5629.577781666432, 5638.605297629168, 5642.868208144479, 3921.843126274974, 3950.822213000422, 3954.426608141803, 3964.742291751027, 3972.463717398114, 3907.47249121365, 4020.4974378202724, 4027.536833264212, 4030.435738996543, 4051.858184963571, 4534.251848444969, 4551.226291530448, 4556.612687921497, 4567.474740404829, 4571.22289210835, 5368.0, 5370.650907690988, 5372.811951581754, 5401.243825864382, 5420.512153906167, 1334.8932085433141, 1371.5542448704011, 1386.5424409944694, 1393.4217299820664, 1394.316784775473, 878.1481962496368, 896.9192772650492, 902.9006809250977, 903.4714691905309, 910.9954450227839, 4636.629069674418, 4655.138799322069, 4683.454460028182, 4694.554017368345, 4713.905721885543, 4901.240307752304, 4907.263910413395, 4917.254849070664, 4923.212286034217, 4964.304997300381, 4323.762193079411, 4716.429545897494, 4718.787654555554, 4724.0, 4732.337472753818, 2608.5043841670404, 2622.9508196721463, 2633.3416645838543, 2651.5624921888057, 2651.880665370063, 5026.29631851541, 5039.168537191395, 5044.218146187347, 5058.671186372948, 5077.31456253401, 5307.15085586312, 5667.4332566743, 5684.687342196136, 5710.114932185518, 5715.685637289906, 5773.884522309446, 5775.422457754275, 5792.594518383673, 5805.129230615357, 5808.0, 5467.589930755289, 5534.972325138348, 5544.362398324083, 5585.190147428519, 5592.440755924375, 5525.143602741581, 5533.6956467393065, 5536.231884057971, 5541.362743284574, 5542.501174894279, 5758.481736643722, 5769.653820770767, 5769.769209231584, 5793.828443520659, 5802.767889284551, 3760.849566017438, 3897.941530877096, 3928.626780455852, 3929.7052721046607, 3973.4834471519675, 5333.226682130991, 5484.808031718871, 5495.093309603871, 5506.91739623914, 5539.25220095282, 5330.920036199538, 5365.853658536616, 5368.362649391816, 5411.512963833274, 5451.591130665137, 5274.498922602346, 5404.513593776422, 5407.621466497465, 5414.7021913795115, 5447.0, 5402.297701298806, 5428.375736790162, 5457.754401051883, 5460.3993560707495, 5466.699331536804, 5354.313391281734, 5419.701916394636, 5483.945160548344, 5514.834554963358, 5529.944700553104, 5270.920936186037, 5272.76272567743, 5316.627836051439, 5382.273393091882, 5390.568754499709], "value": 4080.3040417135053, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.6634348199824, 748.1770052941763, 766.0692258905428, 769.6228847864548, 842.02745828568, 15549.922250388761, 16162.757558636615, 17072.658546829072, 17171.742423863652, 17177.484675459742, 16219.432319868807, 16767.0, 16897.493075207734, 16935.068571228578, 16941.83058169418, 806.8507326144653, 832.7585000349922, 836.510641274855, 836.8619177835681, 837.0081453477618, 679.5820570349249, 689.7999580121759, 693.8438851258477, 699.2552931128357, 815.902091748991, 733.8715724748174, 832.5878690048435, 837.656560810068, 837.6858677995751, 841.1294310388749, 837.0499483086679, 837.4849467577457, 838.8406202821475, 839.6137776622761, 840.5671079394117, 627.7143899525705, 628.0924064726427, 628.214731585518, 628.3025841316136, 628.5191828251392, 11554.76890462186, 11776.764464710743, 15227.162506062163, 15660.608484787857, 15711.842881571152, 14462.855371446361, 15222.162781047038, 15314.693706125927, 15484.690306193814, 15529.456469023642, 11758.647240582795, 11886.28682279066, 11916.821247681291, 12033.338166400845, 12216.877831221751, 3798.5554369679126, 3830.1765120499226, 3863.8840834775, 3932.7247092703524, 4039.111395492987, 67089.66455167742, 82188.58905705492, 83844.58077709633, 85120.57439712762, 85167.57416212941, 11461.885381146249, 11499.482523286471, 11699.622882455096, 11715.76568468626, 11770.88229117715, 21813.0, 21822.23622173248, 21896.0, 21932.89033554822, 21962.584115747253, 8226.753197404087, 8283.25450709439, 8410.663573457115, 8503.277221436247, 8642.740717778477, 4767.73777442237, 4772.6420518461255, 4835.516448355136, 4858.222684370484, 4895.069936712084, 3747.3816820224356, 3872.8257228424786, 3879.747816391982, 3879.8060096995036, 3921.941170882439, 615.7998650438625, 640.3916279534461, 641.6984017511762, 650.180772226988, 670.5004771445305, 740.3743836458184, 740.574169852337, 742.2466196810242, 754.5397307642334, 772.9420293477899, 9621.326507144433, 9647.372920760128, 9715.902840971641, 10126.797464050678, 10511.369317840954, 708.7625645408742, 757.6666266842682, 757.8938948547208, 761.6610608279374, 764.7705688293489, 4350.0, 4616.584507394351, 4699.718016918928, 4701.3888194535175, 4739.4075740532435, 119628.0, 120345.0, 122145.38927305306, 124057.37971310086, 126793.0, 65161.67419162969, 97876.51061744646, 100005.49997249967, 100024.49987750014, 100991.0, 88951.55524222467, 89483.55258223668, 90103.0, 90294.0, 92114.53942730243, 8830.91169088301, 8964.058773828914, 9025.774355641162, 9087.36388452802, 9142.412187220905, 51809.740951295, 51858.74070629623, 53445.7327713359, 54476.45523544714, 54953.1757023653, 71417.0, 79664.60167699357, 81289.18710812816, 82794.58602706948, 84543.05979736116, 12258.387080645754, 12385.442655080724, 12498.125131240726, 12533.248005119722, 12557.874421256036, 14140.858591414366, 14160.679425025122, 14454.710905781616, 14537.200453975132, 14997.2501374933, 12567.560135395583, 12982.80525792095, 13016.15394999322, 13467.663308417368, 13711.657208569866, 13078.738425231251, 13146.868531314565, 13230.338483076, 13559.322033898068, 13989.411958787658, 12792.808107878576, 13076.476940922257, 13364.732705346034, 13404.32978351059, 13417.530386436429, 10874.565017399533, 11082.765171294042, 11112.38881861473, 11121.038837264725, 11510.0, 9704.639259541771, 10959.506822192861, 11114.610988615359, 11509.712257193638, 11799.705007374541], "value": 7631.737282500189, "unit": "score"}], "name": "dromaeo_css", "value": 7121.370101991954, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 111.0, 111.0, 112.0, 111.0, 112.0, 111.0, 111.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 125.0, 166.0, 122.0, 132.0, 128.0, 124.0, 156.0, 122.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 162.0, 161.0, 163.0, 163.0, 162.0, 162.0, 163.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 111.0, 76.0, 76.0, 75.0, 75.0, 98.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 113.0, 81.0, 82.0, 81.0, 115.0, 83.0, 83.0, 107.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0, 85.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 51.0, 50.0, 50.0, 52.0, 52.0, 53.0, 53.0, 50.0, 52.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0, 59.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 87.0, 90.0, 83.0, 80.0, 80.0, 80.0, 90.0, 83.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 130.0, 131.0, 138.0, 151.0, 134.0, 139.0, 189.0, 131.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 169.0, 169.0, 176.0, 172.0, 168.0, 165.0, 172.0, 170.0, 167.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 70.0, 68.0, 69.0, 65.0, 69.0, 64.0, 65.0, 65.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1499.8000000000002, "alertThreshold": 2.0}]} 18:42:43 INFO - Return code: 0 18:42:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:42:43 INFO - # TBPL SUCCESS # 18:42:43 INFO - Running post-action listener: _resource_record_post_action 18:42:43 INFO - [mozharness: 2016-10-18 01:42:43.186411Z] Finished run-tests step (success) 18:42:43 INFO - Running post-run listener: _resource_record_post_run 18:42:43 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403054592; Read time: 12; Write time: 287660 18:42:43 INFO - TinderboxPrint: CPU usage
13.1% 18:42:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:42:43 INFO - TinderboxPrint: I/O write bytes / time
403,054,592 / 287,660 18:42:43 INFO - TinderboxPrint: CPU idle
8,301.0 (86.9%) 18:42:43 INFO - TinderboxPrint: CPU user
1,199.7 (12.6%) 18:42:43 INFO - TinderboxPrint: Swap in / out
0 / 0 18:42:43 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115105792; Read time: 0; Write time: 73088 18:42:43 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287948800; Read time: 0; Write time: 214572 18:42:43 INFO - Running post-run listener: _upload_blobber_files 18:42:43 INFO - Blob upload gear active. 18:42:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:42:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:42:43 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'] 18:42:43 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 18:42:44 INFO - (blobuploader) - INFO - Open directory for files ... 18:42:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:42:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:42:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:42:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:42:48 INFO - (blobuploader) - INFO - Done attempting. 18:42:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:42:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:42:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:42:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:42:48 INFO - (blobuploader) - INFO - Done attempting. 18:42:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:42:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:42:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:42:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:42:49 INFO - (blobuploader) - INFO - Done attempting. 18:42:49 INFO - (blobuploader) - INFO - Iteration through files over. 18:42:49 INFO - Return code: 0 18:42:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:42:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:42:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9407035e4b75760e1e60059b80b7a8742d42030f7e91797060c31f0522ee5feb6e0cdf88367d6c77a9180d1143f42e7512f4d0fa8812b6c0d7e8f2b1ea80a88c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b25d6484135f7481ec273e1b900e1501c142e83b26eabeaccb587497b4531a239f2d453ab41f0d519be0a553701229f17d68e57eee7513311910a68a895d6539", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6bd9f9dacb4f28ff5a0b5daabe65cdd3df10320b3305180540f6c7957336cf97b500a135e1a5d2d53efc1b19030b41b9a16e4771f2a1a601a8cd1a9b1113cd8c"} 18:42:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:42:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:42:49 INFO - Contents: 18:42:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9407035e4b75760e1e60059b80b7a8742d42030f7e91797060c31f0522ee5feb6e0cdf88367d6c77a9180d1143f42e7512f4d0fa8812b6c0d7e8f2b1ea80a88c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b25d6484135f7481ec273e1b900e1501c142e83b26eabeaccb587497b4531a239f2d453ab41f0d519be0a553701229f17d68e57eee7513311910a68a895d6539", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6bd9f9dacb4f28ff5a0b5daabe65cdd3df10320b3305180540f6c7957336cf97b500a135e1a5d2d53efc1b19030b41b9a16e4771f2a1a601a8cd1a9b1113cd8c"} 18:42:49 INFO - Running post-run listener: copy_logs_to_upload_dir 18:42:49 INFO - Copying logs to upload dir... 18:42:49 INFO - mkdir: /builds/slave/test/build/upload/logs 18:42:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.766967 ========= master_lag: 1.56 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-17 18:42:51.010869) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 18:42:51.015072) ========= 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=03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047 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/9407035e4b75760e1e60059b80b7a8742d42030f7e91797060c31f0522ee5feb6e0cdf88367d6c77a9180d1143f42e7512f4d0fa8812b6c0d7e8f2b1ea80a88c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b25d6484135f7481ec273e1b900e1501c142e83b26eabeaccb587497b4531a239f2d453ab41f0d519be0a553701229f17d68e57eee7513311910a68a895d6539", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6bd9f9dacb4f28ff5a0b5daabe65cdd3df10320b3305180540f6c7957336cf97b500a135e1a5d2d53efc1b19030b41b9a16e4771f2a1a601a8cd1a9b1113cd8c"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011207 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/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/9407035e4b75760e1e60059b80b7a8742d42030f7e91797060c31f0522ee5feb6e0cdf88367d6c77a9180d1143f42e7512f4d0fa8812b6c0d7e8f2b1ea80a88c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b25d6484135f7481ec273e1b900e1501c142e83b26eabeaccb587497b4531a239f2d453ab41f0d519be0a553701229f17d68e57eee7513311910a68a895d6539", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6bd9f9dacb4f28ff5a0b5daabe65cdd3df10320b3305180540f6c7957336cf97b500a135e1a5d2d53efc1b19030b41b9a16e4771f2a1a601a8cd1a9b1113cd8c"}' ========= master_lag: 0.62 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 18:42:51.644270) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 18:42:51.644591) ========= 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=03627c79f6bb3d1578c4a402000001ba-1476753427.877287-23846047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 18:42:51.667183) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 18:42:51.667494) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 18:42:51.667800) ========= ========= Total master_lag: 2.27 =========