builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1476399248.67 results: success (0) buildid: 20161013153807 builduid: 52e528347c744481b837bc127e728130 revision: 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:08.667168) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:08.667617) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:08.667898) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:08.682338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:08.682618) ========= 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=5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-13 15:54:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-10-13 15:54:09 (219 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131208 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:08.827551) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:08.827868) ========= 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=5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014226 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:08.876923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:08.877299) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5 --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=5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-13 15:54:09,163 truncating revision to first 12 chars 2016-10-13 15:54:09,163 Setting DEBUG logging. 2016-10-13 15:54:09,163 attempt 1/10 2016-10-13 15:54:09,163 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/62ccb498db3e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 15:54:09,623 unpacking tar archive at: fx-team-62ccb498db3e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.786935 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:09.677602) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:09.677966) ========= script_repo_revision: 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:09.678373) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:09.678654) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:09.689206) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-13 15:54:09.689482) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:54:10 INFO - MultiFileLogger online at 20161013 15:54:10 in /builds/slave/test 15:54:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:54:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:54:10 INFO - {'append_to_log': False, 15:54:10 INFO - 'base_work_dir': '/builds/slave/test', 15:54:10 INFO - 'blob_upload_branch': 'Fx-Team', 15:54:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:54:10 INFO - 'branch': 'Fx-Team', 15:54:10 INFO - 'buildbot_json_path': 'buildprops.json', 15:54:10 INFO - 'config_files': ('talos/linux_config.py',), 15:54:10 INFO - 'default_actions': ('clobber', 15:54:10 INFO - 'read-buildbot-config', 15:54:10 INFO - 'download-and-extract', 15:54:10 INFO - 'populate-webroot', 15:54:10 INFO - 'create-virtualenv', 15:54:10 INFO - 'install', 15:54:10 INFO - 'run-tests'), 15:54:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:54:10 INFO - 'download_minidump_stackwalk': True, 15:54:10 INFO - 'download_symbols': 'ondemand', 15:54:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:54:10 INFO - 'tooltool.py': '/tools/tooltool.py', 15:54:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:54:10 INFO - '/tools/misc-python/virtualenv.py')}, 15:54:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:54:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:54:10 INFO - 'installer_path': 'installer.exe', 15:54:10 INFO - 'log_level': 'info', 15:54:10 INFO - 'log_name': 'talos', 15:54:10 INFO - 'log_to_console': True, 15:54:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:54:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:54:10 INFO - 'opt_config_files': (), 15:54:10 INFO - 'pip_index': False, 15:54:10 INFO - 'sps_profile': False, 15:54:10 INFO - 'sps_profile_interval': 0, 15:54:10 INFO - 'suite': 'dromaeojs-e10s', 15:54:10 INFO - 'system_bits': '32', 15:54:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:54:10 INFO - 'title': 'talos-linux64-ix-039', 15:54:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:54:10 INFO - 'use_talos_json': True, 15:54:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:54:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:54:10 INFO - 'work_dir': 'build'} 15:54:10 INFO - [mozharness: 2016-10-13 22:54:10.069603Z] Running clobber step. 15:54:10 INFO - Running pre-action listener: _resource_record_pre_action 15:54:10 INFO - Running main action method: clobber 15:54:10 INFO - rmtree: /builds/slave/test/build 15:54:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:54:10 INFO - Running post-action listener: _resource_record_post_action 15:54:10 INFO - [mozharness: 2016-10-13 22:54:10.520779Z] Finished clobber step (success) 15:54:10 INFO - [mozharness: 2016-10-13 22:54:10.520879Z] Running read-buildbot-config step. 15:54:10 INFO - Running pre-action listener: _resource_record_pre_action 15:54:10 INFO - Running main action method: read_buildbot_config 15:54:10 INFO - Using buildbot properties: 15:54:10 INFO - { 15:54:10 INFO - "project": "", 15:54:10 INFO - "product": "firefox", 15:54:10 INFO - "script_repo_revision": "production", 15:54:10 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:54:10 INFO - "repository": "", 15:54:10 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 15:54:10 INFO - "buildid": "20161013153807", 15:54:10 INFO - "stage_platform": "linux64-pgo", 15:54:10 INFO - "basedir": "/builds/slave/test", 15:54:10 INFO - "buildnumber": 821, 15:54:10 INFO - "platform": "ubuntu64_hw", 15:54:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:54:10 INFO - "slavebuilddir": "test", 15:54:10 INFO - "branch": "fx-team", 15:54:10 INFO - "revision": "62ccb498db3ec05bef1b6427d5b1b4b0e501cad5", 15:54:10 INFO - "slavename": "talos-linux64-ix-039", 15:54:10 INFO - "builduid": "52e528347c744481b837bc127e728130", 15:54:10 INFO - "repo_path": "integration/fx-team" 15:54:10 INFO - } 15:54:10 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:54:10 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 15:54:10 INFO - Running post-action listener: _resource_record_post_action 15:54:10 INFO - [mozharness: 2016-10-13 22:54:10.523266Z] Finished read-buildbot-config step (success) 15:54:10 INFO - [mozharness: 2016-10-13 22:54:10.523354Z] Running download-and-extract step. 15:54:10 INFO - Running pre-action listener: _resource_record_pre_action 15:54:10 INFO - Running main action method: download_and_extract 15:54:10 INFO - mkdir: /builds/slave/test/build/tests 15:54:10 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')]} 15:54:10 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:54:10 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/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 15:54:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/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 15:54:10 INFO - Downloaded 1361 bytes. 15:54:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:54:10 INFO - Using the following test package requirements: 15:54:10 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:54:10 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:54:10 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:54:10 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:10 INFO - u'jsshell-linux-x86_64.zip'], 15:54:10 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:54:10 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:54:10 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:54:10 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:54:10 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:54:10 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:54:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:54:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:54:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:54:10 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:54:10 INFO - Http code: 200 15:54:10 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 15:54:10 INFO - x-amz-cf-id: wB_5VMl9Olr1xWW2o8DYJNUGZgKqe1IxtJ26UtvWCargp1PTh-N4aQ== 15:54:10 INFO - x-amz-replication-status: COMPLETED 15:54:10 INFO - x-amz-version-id: tjICeCD8Y5ch2GeB_RnlezlCnrKSCXML 15:54:10 INFO - Expected file size: 22120853 15:54:10 INFO - Obtained file size: 22120853 15:54:15 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 15:54:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:54:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:54:15 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:54:15 INFO - Http code: 200 15:54:15 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 15:54:15 INFO - x-amz-cf-id: 6qPTAn2P1Gk04o9MCYEN4v9nWTvnhvtc2HE99GMu9lS1Ij5rRxG2rw== 15:54:15 INFO - x-amz-replication-status: COMPLETED 15:54:15 INFO - x-amz-version-id: tjICeCD8Y5ch2GeB_RnlezlCnrKSCXML 15:54:15 INFO - Expected file size: 22120853 15:54:15 INFO - Obtained file size: 22120853 15:54:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:54:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:54:19 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:54:19 INFO - Http code: 200 15:54:19 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 15:54:19 INFO - x-amz-cf-id: 4gpBP4Y-0WHTCTkrqWx-3tWHCDeLq-uI7ba-iqfgSo-UwS3HJONQbg== 15:54:19 INFO - x-amz-replication-status: COMPLETED 15:54:19 INFO - x-amz-version-id: jJ.RKjayqD.XS1aKf2hKqxq9ZQN0VoDf 15:54:20 INFO - Expected file size: 14409006 15:54:20 INFO - Obtained file size: 14409006 15:54:20 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')]} 15:54:20 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:54:20 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/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 15:54:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/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 15:54:21 INFO - Downloaded 59789533 bytes. 15:54:21 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:54:21 INFO - mkdir: /builds/slave/test/properties 15:54:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:54:21 INFO - Writing to file /builds/slave/test/properties/build_url 15:54:21 INFO - Contents: 15:54:21 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:54:21 INFO - Running post-action listener: _resource_record_post_action 15:54:21 INFO - Running post-action listener: set_extra_try_arguments 15:54:21 INFO - [mozharness: 2016-10-13 22:54:21.655864Z] Finished download-and-extract step (success) 15:54:21 INFO - [mozharness: 2016-10-13 22:54:21.656091Z] Running populate-webroot step. 15:54:21 INFO - Running pre-action listener: _resource_record_pre_action 15:54:21 INFO - Running main action method: populate_webroot 15:54:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:54:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:54:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:54:21 INFO - '--tppagecycles', 15:54:21 INFO - '7'], 15:54:21 INFO - 'tests': ['tsvgm']}}, 15:54:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:54:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:54:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:54:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:54:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:54:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:54:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:21 INFO - 'talos_options': ['--disable-e10s'], 15:54:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:54:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:54:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:21 INFO - 'talos_options': ['--disable-e10s'], 15:54:21 INFO - 'tests': ['damp', 'tps']}, 15:54:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:21 INFO - 'tests': ['damp', 'tps']}, 15:54:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:54:21 INFO - 'tests': ['dromaeo_dom']}, 15:54:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:54:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:54:21 INFO - 'tests': ['basic_compositor_video']}, 15:54:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:54:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:54:21 INFO - 'tests': ['a11yr', 15:54:21 INFO - 'ts_paint', 15:54:21 INFO - 'tpaint', 15:54:21 INFO - 'sessionrestore', 15:54:21 INFO - 'sessionrestore_no_auto_restore', 15:54:21 INFO - 'tabpaint']}, 15:54:21 INFO - 'other-e10s': {'tests': ['a11yr', 15:54:21 INFO - 'ts_paint', 15:54:21 INFO - 'tpaint', 15:54:21 INFO - 'sessionrestore', 15:54:21 INFO - 'sessionrestore_no_auto_restore', 15:54:21 INFO - 'tabpaint']}, 15:54:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:54:21 INFO - 'ts_paint', 15:54:21 INFO - 'tpaint', 15:54:21 INFO - 'sessionrestore', 15:54:21 INFO - 'sessionrestore_no_auto_restore', 15:54:21 INFO - 'tabpaint']}, 15:54:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:54:21 INFO - 'ts_paint', 15:54:21 INFO - 'tpaint', 15:54:21 INFO - 'sessionrestore', 15:54:21 INFO - 'sessionrestore_no_auto_restore', 15:54:21 INFO - 'tabpaint']}, 15:54:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:54:21 INFO - 'tests': ['a11yr', 15:54:21 INFO - 'ts_paint', 15:54:21 INFO - 'tpaint', 15:54:21 INFO - 'sessionrestore', 15:54:21 INFO - 'sessionrestore_no_auto_restore', 15:54:21 INFO - 'tabpaint']}, 15:54:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:54:21 INFO - 'tests': ['a11yr', 15:54:21 INFO - 'ts_paint', 15:54:21 INFO - 'tpaint', 15:54:21 INFO - 'sessionrestore', 15:54:21 INFO - 'sessionrestore_no_auto_restore', 15:54:21 INFO - 'tabpaint']}, 15:54:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:54:21 INFO - 'tests': ['tsvgx', 15:54:21 INFO - 'tsvgr_opacity', 15:54:21 INFO - 'tart', 15:54:21 INFO - 'tscrollx', 15:54:21 INFO - 'cart']}, 15:54:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:54:21 INFO - 'tsvgr_opacity', 15:54:21 INFO - 'tart', 15:54:21 INFO - 'tscrollx', 15:54:21 INFO - 'cart']}, 15:54:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:21 INFO - 'talos_options': ['--disable-e10s'], 15:54:21 INFO - 'tests': ['tp5o']}, 15:54:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:21 INFO - 'tests': ['tp5o']}, 15:54:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:21 INFO - 'talos_options': ['--disable-e10s', 15:54:21 INFO - '--xperf_path', 15:54:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:54:21 INFO - 'tests': ['tp5n']}, 15:54:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:21 INFO - 'talos_options': ['--xperf_path', 15:54:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:54:21 INFO - 'tests': ['tp5n']}}, 15:54:21 INFO - 'talos.zip': {'path': '', 15:54:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:54:21 INFO - Running post-action listener: _resource_record_post_action 15:54:21 INFO - [mozharness: 2016-10-13 22:54:21.677597Z] Finished populate-webroot step (success) 15:54:21 INFO - [mozharness: 2016-10-13 22:54:21.677685Z] Running create-virtualenv step. 15:54:21 INFO - Running pre-action listener: _resource_record_pre_action 15:54:21 INFO - Running main action method: create_virtualenv 15:54:21 INFO - Creating virtualenv /builds/slave/test/build/venv 15:54:21 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 15:54:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:54:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:54:21 INFO - Using real prefix '/usr' 15:54:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:54:22 INFO - Installing distribute.............................................................................................................................................................................................done. 15:54:24 INFO - Installing pip.................done. 15:54:24 INFO - Return code: 0 15:54:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:54:24 INFO - Reading from file tmpfile_stdout 15:54:24 INFO - Output received: 15:54:24 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) 15:54:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d292edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1766790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1763930>, '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 0x1764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1764cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', '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 15:54:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:54:24 INFO - Using env: {'DISPLAY': ':0', 15:54:24 INFO - 'HOME': '/home/cltbld', 15:54:24 INFO - 'LANG': 'en_US.UTF-8', 15:54:24 INFO - 'LANGUAGE': 'en_US:en', 15:54:24 INFO - 'LOGNAME': 'cltbld', 15:54:24 INFO - 'MAIL': '/var/mail/cltbld', 15:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:24 INFO - 'MOZ_NO_REMOTE': '1', 15:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:24 INFO - 'NO_EM_RESTART': '1', 15:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:24 INFO - 'PWD': '/builds/slave/test', 15:54:24 INFO - 'SHELL': '/bin/bash', 15:54:24 INFO - 'SHLVL': '1', 15:54:24 INFO - 'TERM': 'linux', 15:54:24 INFO - 'TMOUT': '86400', 15:54:24 INFO - 'USER': 'cltbld', 15:54:24 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', 15:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:24 INFO - '_': '/tools/buildbot/bin/python'} 15:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:24 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 15:54:24 INFO - Cleaning up... 15:54:24 INFO - Return code: 0 15:54:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2d292edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1766790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1763930>, '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 0x1764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1764cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', '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 15:54:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:54:24 INFO - Using env: {'DISPLAY': ':0', 15:54:24 INFO - 'HOME': '/home/cltbld', 15:54:24 INFO - 'LANG': 'en_US.UTF-8', 15:54:24 INFO - 'LANGUAGE': 'en_US:en', 15:54:24 INFO - 'LOGNAME': 'cltbld', 15:54:24 INFO - 'MAIL': '/var/mail/cltbld', 15:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:24 INFO - 'MOZ_NO_REMOTE': '1', 15:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:24 INFO - 'NO_EM_RESTART': '1', 15:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:24 INFO - 'PWD': '/builds/slave/test', 15:54:24 INFO - 'SHELL': '/bin/bash', 15:54:24 INFO - 'SHLVL': '1', 15:54:24 INFO - 'TERM': 'linux', 15:54:24 INFO - 'TMOUT': '86400', 15:54:24 INFO - 'USER': 'cltbld', 15:54:24 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', 15:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:24 INFO - '_': '/tools/buildbot/bin/python'} 15:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:24 INFO - Downloading/unpacking psutil>=3.1.1 15:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:54:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:54:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:54:26 INFO - Installing collected packages: psutil 15:54:26 INFO - Running setup.py install for psutil 15:54:27 INFO - building 'psutil._psutil_linux' extension 15:54:27 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 15:54:27 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 15:54:27 INFO - building 'psutil._psutil_posix' extension 15:54:27 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 15:54:27 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 15:54:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:54:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:54:27 INFO - Successfully installed psutil 15:54:27 INFO - Cleaning up... 15:54:27 INFO - Return code: 0 15:54:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d292edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1766790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1763930>, '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 0x1764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1764cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', '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 15:54:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:54:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:54:27 INFO - Using env: {'DISPLAY': ':0', 15:54:27 INFO - 'HOME': '/home/cltbld', 15:54:27 INFO - 'LANG': 'en_US.UTF-8', 15:54:27 INFO - 'LANGUAGE': 'en_US:en', 15:54:27 INFO - 'LOGNAME': 'cltbld', 15:54:27 INFO - 'MAIL': '/var/mail/cltbld', 15:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:27 INFO - 'MOZ_NO_REMOTE': '1', 15:54:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:27 INFO - 'NO_EM_RESTART': '1', 15:54:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:27 INFO - 'PWD': '/builds/slave/test', 15:54:27 INFO - 'SHELL': '/bin/bash', 15:54:27 INFO - 'SHLVL': '1', 15:54:27 INFO - 'TERM': 'linux', 15:54:27 INFO - 'TMOUT': '86400', 15:54:27 INFO - 'USER': 'cltbld', 15:54:27 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', 15:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:27 INFO - '_': '/tools/buildbot/bin/python'} 15:54:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:54:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:54:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:54:29 INFO - Installing collected packages: mozsystemmonitor 15:54:29 INFO - Running setup.py install for mozsystemmonitor 15:54:29 INFO - Successfully installed mozsystemmonitor 15:54:29 INFO - Cleaning up... 15:54:29 INFO - Return code: 0 15:54:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:54: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')]} 15:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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')]} 15:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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', '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 0x7f2d292edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1766790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1763930>, '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 0x1764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1764cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', '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 15:54: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:54: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 jsonschema==2.5.1 15:54:29 INFO - Using env: {'DISPLAY': ':0', 15:54:29 INFO - 'HOME': '/home/cltbld', 15:54:29 INFO - 'LANG': 'en_US.UTF-8', 15:54:29 INFO - 'LANGUAGE': 'en_US:en', 15:54:29 INFO - 'LOGNAME': 'cltbld', 15:54:29 INFO - 'MAIL': '/var/mail/cltbld', 15:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:29 INFO - 'MOZ_NO_REMOTE': '1', 15:54:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:29 INFO - 'NO_EM_RESTART': '1', 15:54:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:29 INFO - 'PWD': '/builds/slave/test', 15:54:29 INFO - 'SHELL': '/bin/bash', 15:54:29 INFO - 'SHLVL': '1', 15:54:29 INFO - 'TERM': 'linux', 15:54:29 INFO - 'TMOUT': '86400', 15:54:29 INFO - 'USER': 'cltbld', 15:54:29 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', 15:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:29 INFO - '_': '/tools/buildbot/bin/python'} 15:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:30 INFO - Downloading/unpacking jsonschema==2.5.1 15:54:30 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 15:54:30 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 15:54:30 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 15:54:30 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 15:54:30 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 15:54:30 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 15:54:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:54:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54:32 INFO - Downloading functools32-3.2.3-2.tar.gz 15:54:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:54:32 INFO - warning: no files found matching '*.txt' 15:54:32 INFO - no previously-included directories found matching 'build' 15:54:32 INFO - no previously-included directories found matching 'dist' 15:54:32 INFO - no previously-included directories found matching '.git*' 15:54:32 INFO - Installing collected packages: jsonschema, functools32 15:54:32 INFO - Running setup.py install for functools32 15:54:32 INFO - warning: no files found matching '*.txt' 15:54:32 INFO - no previously-included directories found matching 'build' 15:54:32 INFO - no previously-included directories found matching 'dist' 15:54:32 INFO - no previously-included directories found matching '.git*' 15:54:32 INFO - Successfully installed jsonschema functools32 15:54:32 INFO - Cleaning up... 15:54:32 INFO - Return code: 0 15:54:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:54:32 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')]} 15:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:32 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')]} 15:54:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:32 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 0x7f2d292edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1766790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1763930>, '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 0x1764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1764cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', '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 15:54:32 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 15:54:32 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 15:54:32 INFO - Using env: {'DISPLAY': ':0', 15:54:32 INFO - 'HOME': '/home/cltbld', 15:54:32 INFO - 'LANG': 'en_US.UTF-8', 15:54:32 INFO - 'LANGUAGE': 'en_US:en', 15:54:32 INFO - 'LOGNAME': 'cltbld', 15:54:32 INFO - 'MAIL': '/var/mail/cltbld', 15:54:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:32 INFO - 'MOZ_NO_REMOTE': '1', 15:54:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:32 INFO - 'NO_EM_RESTART': '1', 15:54:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:32 INFO - 'PWD': '/builds/slave/test', 15:54:32 INFO - 'SHELL': '/bin/bash', 15:54:32 INFO - 'SHLVL': '1', 15:54:32 INFO - 'TERM': 'linux', 15:54:32 INFO - 'TMOUT': '86400', 15:54:32 INFO - 'USER': 'cltbld', 15:54:32 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', 15:54:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:32 INFO - '_': '/tools/buildbot/bin/python'} 15:54:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:54:32 INFO - Cleaning up... 15:54:32 INFO - Return code: 0 15:54:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:54:32 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')]} 15:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:32 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')]} 15:54:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:32 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 0x7f2d292edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1766790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1763930>, '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 0x1764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1764cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', '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 15:54:32 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 15:54:32 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 15:54:32 INFO - Using env: {'DISPLAY': ':0', 15:54:32 INFO - 'HOME': '/home/cltbld', 15:54:32 INFO - 'LANG': 'en_US.UTF-8', 15:54:32 INFO - 'LANGUAGE': 'en_US:en', 15:54:32 INFO - 'LOGNAME': 'cltbld', 15:54:32 INFO - 'MAIL': '/var/mail/cltbld', 15:54:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:32 INFO - 'MOZ_NO_REMOTE': '1', 15:54:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:32 INFO - 'NO_EM_RESTART': '1', 15:54:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:32 INFO - 'PWD': '/builds/slave/test', 15:54:32 INFO - 'SHELL': '/bin/bash', 15:54:32 INFO - 'SHLVL': '1', 15:54:32 INFO - 'TERM': 'linux', 15:54:32 INFO - 'TMOUT': '86400', 15:54:32 INFO - 'USER': 'cltbld', 15:54:32 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', 15:54:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:32 INFO - '_': '/tools/buildbot/bin/python'} 15:54:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:32 INFO - Downloading/unpacking blobuploader==1.2.4 15:54:32 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 15:54:32 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 15:54:32 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 15:54:32 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 15:54:32 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 15:54:32 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 15:54:34 INFO - Downloading blobuploader-1.2.4.tar.gz 15:54:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:54:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:54:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:35 INFO - Downloading docopt-0.6.1.tar.gz 15:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:54:35 INFO - Installing collected packages: blobuploader, requests, docopt 15:54:35 INFO - Running setup.py install for blobuploader 15:54:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:54:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:54:35 INFO - Running setup.py install for requests 15:54:35 INFO - Running setup.py install for docopt 15:54:36 INFO - Successfully installed blobuploader requests docopt 15:54:36 INFO - Cleaning up... 15:54:36 INFO - Return code: 0 15:54:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54:36 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')]} 15:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:36 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')]} 15:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:36 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 0x7f2d292edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1766790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1763930>, '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 0x1764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1764cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', '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 15:54:36 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 15:54:36 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 15:54:36 INFO - Using env: {'DISPLAY': ':0', 15:54:36 INFO - 'HOME': '/home/cltbld', 15:54:36 INFO - 'LANG': 'en_US.UTF-8', 15:54:36 INFO - 'LANGUAGE': 'en_US:en', 15:54:36 INFO - 'LOGNAME': 'cltbld', 15:54:36 INFO - 'MAIL': '/var/mail/cltbld', 15:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:36 INFO - 'MOZ_NO_REMOTE': '1', 15:54:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:36 INFO - 'NO_EM_RESTART': '1', 15:54:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:36 INFO - 'PWD': '/builds/slave/test', 15:54:36 INFO - 'SHELL': '/bin/bash', 15:54:36 INFO - 'SHLVL': '1', 15:54:36 INFO - 'TERM': 'linux', 15:54:36 INFO - 'TMOUT': '86400', 15:54:36 INFO - 'USER': 'cltbld', 15:54:36 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', 15:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:36 INFO - '_': '/tools/buildbot/bin/python'} 15:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:54:36 INFO - Running setup.py (path:/tmp/pip-nAF0ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:54:36 INFO - Running setup.py (path:/tmp/pip-GRqdzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:54:36 INFO - Running setup.py (path:/tmp/pip-tgaayS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:54:36 INFO - Running setup.py (path:/tmp/pip-WlrD7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:54:36 INFO - Running setup.py (path:/tmp/pip-g8XMi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:54:36 INFO - Running setup.py (path:/tmp/pip-vRWFCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:54:36 INFO - Running setup.py (path:/tmp/pip-w5Fa_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:54:36 INFO - Running setup.py (path:/tmp/pip-RdeGrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:54:36 INFO - Running setup.py (path:/tmp/pip-dWYoOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:54:37 INFO - Running setup.py (path:/tmp/pip-O7DIh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:54:37 INFO - Running setup.py (path:/tmp/pip-1OeVlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:54:37 INFO - Running setup.py (path:/tmp/pip-tG1HFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:54:37 INFO - Running setup.py (path:/tmp/pip-Zhf424-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:54:37 INFO - Running setup.py (path:/tmp/pip-8bfgNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:37 INFO - Running setup.py (path:/tmp/pip-LBE4KD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:54:37 INFO - Running setup.py (path:/tmp/pip-ThLDKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:54:37 INFO - Running setup.py (path:/tmp/pip-0RtIU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:54:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:54:37 INFO - Running setup.py install for manifestparser 15:54:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:54:37 INFO - Running setup.py install for mozcrash 15:54:37 INFO - Running setup.py install for mozdebug 15:54:37 INFO - Running setup.py install for mozdevice 15:54:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:54:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:54:38 INFO - Running setup.py install for mozfile 15:54:38 INFO - Running setup.py install for mozhttpd 15:54:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:54:38 INFO - Running setup.py install for mozinfo 15:54:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:54:38 INFO - Running setup.py install for mozInstall 15:54:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:54:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:54:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:54:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:54:38 INFO - Running setup.py install for mozleak 15:54:38 INFO - Running setup.py install for mozlog 15:54:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:54:38 INFO - Running setup.py install for moznetwork 15:54:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:54:38 INFO - Running setup.py install for mozprocess 15:54:38 INFO - Running setup.py install for mozprofile 15:54:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:54:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:54:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:54:38 INFO - Running setup.py install for mozrunner 15:54:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:54:39 INFO - Running setup.py install for mozscreenshot 15:54:39 INFO - Running setup.py install for moztest 15:54:39 INFO - Running setup.py install for mozversion 15:54:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:54:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:54:39 INFO - Cleaning up... 15:54:39 INFO - Return code: 0 15:54:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:39 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 0x7f2d292edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1766790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1763930>, '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 0x1764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1764cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', '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 15:54:39 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 15:54:39 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 15:54:39 INFO - Using env: {'DISPLAY': ':0', 15:54:39 INFO - 'HOME': '/home/cltbld', 15:54:39 INFO - 'LANG': 'en_US.UTF-8', 15:54:39 INFO - 'LANGUAGE': 'en_US:en', 15:54:39 INFO - 'LOGNAME': 'cltbld', 15:54:39 INFO - 'MAIL': '/var/mail/cltbld', 15:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:39 INFO - 'MOZ_NO_REMOTE': '1', 15:54:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:39 INFO - 'NO_EM_RESTART': '1', 15:54:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:39 INFO - 'PWD': '/builds/slave/test', 15:54:39 INFO - 'SHELL': '/bin/bash', 15:54:39 INFO - 'SHLVL': '1', 15:54:39 INFO - 'TERM': 'linux', 15:54:39 INFO - 'TMOUT': '86400', 15:54:39 INFO - 'USER': 'cltbld', 15:54:39 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', 15:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:39 INFO - '_': '/tools/buildbot/bin/python'} 15:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:54:39 INFO - Running setup.py (path:/tmp/pip-rY25W2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:54:39 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)) 15:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:54:39 INFO - Running setup.py (path:/tmp/pip-lBW7vS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:54:39 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)) 15:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:54:39 INFO - Running setup.py (path:/tmp/pip-Tt380N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:54:39 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)) 15:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:54:39 INFO - Running setup.py (path:/tmp/pip-RIXMM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:54:39 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)) 15:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:54:39 INFO - Running setup.py (path:/tmp/pip-WrRmYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:54:39 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)) 15:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:54:40 INFO - Running setup.py (path:/tmp/pip-lc1ktn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:54:40 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)) 15:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:54:40 INFO - Running setup.py (path:/tmp/pip-e7jPvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:54:40 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)) 15:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:54:40 INFO - Running setup.py (path:/tmp/pip-oCVRft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:54:40 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)) 15:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:54:40 INFO - Running setup.py (path:/tmp/pip-xYul8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:54:40 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)) 15:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:54:40 INFO - Running setup.py (path:/tmp/pip-IKpdzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:54:40 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)) 15:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:54:40 INFO - Running setup.py (path:/tmp/pip-lsECDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:54:40 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)) 15:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:54:40 INFO - Running setup.py (path:/tmp/pip-tcaLr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:54:40 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)) 15:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:54:40 INFO - Running setup.py (path:/tmp/pip-88mpXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:54:40 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)) 15:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:54:40 INFO - Running setup.py (path:/tmp/pip-97B4F7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:54:40 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)) 15:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:40 INFO - Running setup.py (path:/tmp/pip-ygqfmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:40 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)) 15:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:54:40 INFO - Running setup.py (path:/tmp/pip-_Nr8ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:54:40 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)) 15:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:54:40 INFO - Running setup.py (path:/tmp/pip-N_aXPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:54:40 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)) 15:54:40 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)) 15:54:40 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)) 15:54:40 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)) 15:54:40 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)) 15:54:40 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)) 15:54:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:54:40 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 15:54:40 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 15:54:40 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 15:54:40 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 15:54:40 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 15:54:40 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 15:54:42 INFO - Downloading blessings-1.6.tar.gz 15:54:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:54:42 INFO - Installing collected packages: blessings 15:54:42 INFO - Running setup.py install for blessings 15:54:43 INFO - Successfully installed blessings 15:54:43 INFO - Cleaning up... 15:54:43 INFO - Return code: 0 15:54:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:54:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:54:43 INFO - Reading from file tmpfile_stdout 15:54:43 INFO - Current package versions: 15:54:43 INFO - argparse == 1.2.1 15:54:43 INFO - blessings == 1.6 15:54:43 INFO - blobuploader == 1.2.4 15:54:43 INFO - docopt == 0.6.1 15:54:43 INFO - functools32 == 3.2.3-2 15:54:43 INFO - jsonschema == 2.5.1 15:54:43 INFO - manifestparser == 1.1 15:54:43 INFO - mozInstall == 1.12 15:54:43 INFO - mozcrash == 0.17 15:54:43 INFO - mozdebug == 0.1 15:54:43 INFO - mozdevice == 0.48 15:54:43 INFO - mozfile == 1.2 15:54:43 INFO - mozhttpd == 0.7 15:54:43 INFO - mozinfo == 0.9 15:54:43 INFO - mozleak == 0.1 15:54:43 INFO - mozlog == 3.4 15:54:43 INFO - moznetwork == 0.27 15:54:43 INFO - mozprocess == 0.23 15:54:43 INFO - mozprofile == 0.28 15:54:43 INFO - mozrunner == 6.12 15:54:43 INFO - mozscreenshot == 0.1 15:54:43 INFO - mozsystemmonitor == 0.3 15:54:43 INFO - moztest == 0.7 15:54:43 INFO - mozversion == 1.4 15:54:43 INFO - psutil == 3.1.1 15:54:43 INFO - requests == 1.2.3 15:54:43 INFO - wsgiref == 0.1.2 15:54:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54:43 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')]} 15:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:43 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')]} 15:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:43 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 0x7f2d292edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1766790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1763930>, '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 0x1764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1764cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', '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 15:54:43 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 15:54:43 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 15:54:43 INFO - Using env: {'DISPLAY': ':0', 15:54:43 INFO - 'HOME': '/home/cltbld', 15:54:43 INFO - 'LANG': 'en_US.UTF-8', 15:54:43 INFO - 'LANGUAGE': 'en_US:en', 15:54:43 INFO - 'LOGNAME': 'cltbld', 15:54:43 INFO - 'MAIL': '/var/mail/cltbld', 15:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:43 INFO - 'MOZ_NO_REMOTE': '1', 15:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:43 INFO - 'NO_EM_RESTART': '1', 15:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:43 INFO - 'PWD': '/builds/slave/test', 15:54:43 INFO - 'SHELL': '/bin/bash', 15:54:43 INFO - 'SHLVL': '1', 15:54:43 INFO - 'TERM': 'linux', 15:54:43 INFO - 'TMOUT': '86400', 15:54:43 INFO - 'USER': 'cltbld', 15:54:43 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', 15:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:43 INFO - '_': '/tools/buildbot/bin/python'} 15:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:43 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)) 15:54:43 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)) 15:54:43 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)) 15:54:43 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)) 15:54:43 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)) 15:54:43 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)) 15:54:43 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)) 15:54:43 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)) 15:54:43 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)) 15:54:43 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)) 15:54:43 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)) 15:54:43 INFO - Cleaning up... 15:54:43 INFO - Return code: 0 15:54:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:54:43 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')]} 15:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:43 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')]} 15:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:43 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 0x7f2d292edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1766790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1763930>, '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 0x1764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1764cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', '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 15:54:43 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 15:54:43 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 15:54:43 INFO - Using env: {'DISPLAY': ':0', 15:54:43 INFO - 'HOME': '/home/cltbld', 15:54:43 INFO - 'LANG': 'en_US.UTF-8', 15:54:43 INFO - 'LANGUAGE': 'en_US:en', 15:54:43 INFO - 'LOGNAME': 'cltbld', 15:54:43 INFO - 'MAIL': '/var/mail/cltbld', 15:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:43 INFO - 'MOZ_NO_REMOTE': '1', 15:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:43 INFO - 'NO_EM_RESTART': '1', 15:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:43 INFO - 'PWD': '/builds/slave/test', 15:54:43 INFO - 'SHELL': '/bin/bash', 15:54:43 INFO - 'SHLVL': '1', 15:54:43 INFO - 'TERM': 'linux', 15:54:43 INFO - 'TMOUT': '86400', 15:54:43 INFO - 'USER': 'cltbld', 15:54:43 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', 15:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:43 INFO - '_': '/tools/buildbot/bin/python'} 15:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:54:43 INFO - Cleaning up... 15:54:43 INFO - Return code: 0 15:54:43 INFO - Running post-action listener: _resource_record_post_action 15:54:43 INFO - Running post-action listener: _start_resource_monitoring 15:54:43 INFO - Starting resource monitoring. 15:54:43 INFO - [mozharness: 2016-10-13 22:54:43.849175Z] Finished create-virtualenv step (success) 15:54:43 INFO - [mozharness: 2016-10-13 22:54:43.849687Z] Running install step. 15:54:43 INFO - Running pre-action listener: _resource_record_pre_action 15:54:43 INFO - Running main action method: install 15:54:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:54:44 INFO - Reading from file tmpfile_stdout 15:54:44 INFO - Detecting whether we're running mozinstall >=1.0... 15:54:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:54:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:54:44 INFO - Reading from file tmpfile_stdout 15:54:44 INFO - Output received: 15:54:44 INFO - Usage: mozinstall [options] installer 15:54:44 INFO - Options: 15:54:44 INFO - -h, --help show this help message and exit 15:54:44 INFO - -d DEST, --destination=DEST 15:54:44 INFO - Directory to install application into. [default: 15:54:44 INFO - "/builds/slave/test"] 15:54:44 INFO - --app=APP Application being installed. [default: firefox] 15:54:44 INFO - mkdir: /builds/slave/test/build/application 15:54:44 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'] 15:54:44 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 15:55:01 INFO - Reading from file tmpfile_stdout 15:55:01 INFO - Output received: 15:55:01 INFO - /builds/slave/test/build/application/firefox/firefox 15:55:01 INFO - Running post-action listener: _resource_record_post_action 15:55:01 INFO - [mozharness: 2016-10-13 22:55:01.190688Z] Finished install step (success) 15:55:01 INFO - [mozharness: 2016-10-13 22:55:01.190959Z] Running run-tests step. 15:55:01 INFO - Running pre-action listener: _resource_record_pre_action 15:55:01 INFO - Running main action method: run_tests 15:55:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:55:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:55:01 INFO - Python 2.7.3 15:55:01 INFO - Return code: 0 15:55:01 INFO - grabbing minidump binary from tooltool 15:55:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:55:01 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 0x1763930>, '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 0x1764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1764cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:55:01 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 15:55:01 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 15:55:01 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 15:55:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:55:01 INFO - Return code: 0 15:55:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:55:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:55:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:55:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:55:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:55:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:55:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:55:01 INFO - Using env: {'DISPLAY': ':0', 15:55:01 INFO - 'HOME': '/home/cltbld', 15:55:01 INFO - 'LANG': 'en_US.UTF-8', 15:55:01 INFO - 'LANGUAGE': 'en_US:en', 15:55:01 INFO - 'LOGNAME': 'cltbld', 15:55:01 INFO - 'MAIL': '/var/mail/cltbld', 15:55:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:55:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:55:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:01 INFO - 'MOZ_NO_REMOTE': '1', 15:55:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:55:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:01 INFO - 'NO_EM_RESTART': '1', 15:55:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:01 INFO - 'PWD': '/builds/slave/test', 15:55:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:55:01 INFO - 'SHELL': '/bin/bash', 15:55:01 INFO - 'SHLVL': '1', 15:55:01 INFO - 'TERM': 'linux', 15:55:01 INFO - 'TMOUT': '86400', 15:55:01 INFO - 'USER': 'cltbld', 15:55:01 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632', 15:55:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:01 INFO - '_': '/tools/buildbot/bin/python'} 15:55:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:55:01 INFO - mozversion application_buildid: 20161013123018 15:55:01 INFO - mozversion application_changeset: 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5 15:55:01 INFO - mozversion application_display_name: Nightly 15:55:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:55:01 INFO - mozversion application_name: Firefox 15:55:01 INFO - mozversion application_remotingname: firefox 15:55:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:55:01 INFO - mozversion application_vendor: Mozilla 15:55:01 INFO - mozversion application_version: 52.0a1 15:55:01 INFO - mozversion platform_buildid: 20161013123018 15:55:01 INFO - mozversion platform_changeset: 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5 15:55:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:55:01 INFO - mozversion platform_version: 52.0a1 15:55:01 INFO - using testdate: 1476399301 15:55:01 INFO - actual date: 1476399301 15:55:01 INFO - starting webserver on 'localhost:52495' 15:55:01 INFO - SUITE-START | Running 2 tests 15:55:01 INFO - TEST-START | dromaeo_css 15:55:01 INFO - operating with platform_type : linux_ 15:55:01 INFO - Initialising browser for dromaeo_css test... 15:55:01 INFO - TEST-INFO | started process 2102 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn7hcHu/profile http://localhost:52495/getInfo.html) 15:55:06 INFO - PROCESS | 2102 | __metrics Screen width/height:1600/1200 15:55:06 INFO - PROCESS | 2102 | colorDepth:24 15:55:06 INFO - PROCESS | 2102 | Browser inner width/height: 1024/697 15:55:06 INFO - PROCESS | 2102 | __metrics 15:55:06 ERROR - PROCESS | 2102 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 15:55:07 INFO - TEST-INFO | 2102: exit 0 15:55:07 INFO - Browser initialized. 15:55:07 INFO - Running cycle 1/1 for dromaeo_css test... 15:55:07 INFO - TEST-INFO | started process 2225 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn7hcHu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:55:19 INFO - PROCESS | 2225 | RSS: Main: 185094144 15:55:19 INFO - PROCESS | 2225 | 15:56:09 INFO - PROCESS | 2225 | 1476399369499 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] 15:58:20 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:52495/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52495/tests/dromaeo/cssquery-ext.html) 15:58:22 INFO - PROCESS | 2225 | RSS: Main: 202608640 15:58:22 INFO - PROCESS | 2225 | 16:01:24 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:52495/tests/dromaeo/cssquery-ext.html (next: http://localhost:52495/tests/dromaeo/cssquery-jquery.html) 16:01:24 INFO - PROCESS | 2225 | RSS: Main: 202158080 16:01:24 INFO - PROCESS | 2225 | 16:04:26 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:52495/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52495/tests/dromaeo/cssquery-mootools.html) 16:04:27 INFO - PROCESS | 2225 | RSS: Main: 200527872 16:04:27 INFO - PROCESS | 2225 | 16:07:29 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:52495/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52495/tests/dromaeo/cssquery-prototype.html) 16:07:29 INFO - PROCESS | 2225 | RSS: Main: 195268608 16:07:29 INFO - PROCESS | 2225 | 16:10:32 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:52495/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52495/tests/dromaeo/cssquery-yui.html) 16:10:33 INFO - PROCESS | 2225 | RSS: Main: 198823936 16:10:33 INFO - PROCESS | 2225 | 16:13:36 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:52495/tests/dromaeo/cssquery-yui.html (next: http://localhost:52495/tests/dromaeo/cssquery-dojo.html) 16:13:36 INFO - PROCESS | 2225 | RSS: Main: 200015872 16:13:36 INFO - PROCESS | 2225 | 16:13:36 INFO - PROCESS | 2225 | __start_tp_report 16:13:36 INFO - PROCESS | 2225 | _x_x_mozilla_page_load 16:13:36 INFO - PROCESS | 2225 | _x_x_mozilla_page_load_details 16:13:36 INFO - PROCESS | 2225 | |i|pagename|runs| 16:13:36 INFO - PROCESS | 2225 | |0;dojo.html;3014.9849250753746;3060.663327034027;3064.126723883692;3099.6745341739115;3106.897051546701;5209.7134657593815;5321.22842187883;5325.201219817024;5334.493223143795;5460.808871689492;5259.76331065102;5271.42014378418;5288.8413347599535;5367.812126575571;5383.703896285702;4782.665213435061;4819.2289233722695;4837.226043832988;4862.5380588844;4922.138625740481;4766.379430993462;4822.228443449048;4881.292212629167;4883.267509873512;4885.145099607572;4711.7879695413785;4892.241702536113;4950.801967921278;4963.478919414472;4974.427940786783;4756.7859446325;4789.4971028042255;4796.44840843304;4816.060868130716;4824.975875120602;4721.598664113554;4775.856724298242;4807.471178170398;4881.926771098437;4950.653454258203;5309.230161626581;5348.598855085846;5358.008768377824;5373.785048598052;5379.246905433242;5541.944580554183;5566.415526369754;5593.188987596775;5606.55147588192;5615.831525054214;5613.915791263134;5642.153676948449;5652.095664693629;5660.264165658438;5692.77228910843;5123.129068058439;5137.2037334213255;5325.866853328659;5334.1732031535175;5362.168863826113;5740.68426236561;5751.22358481608;5768.048272035067;5779.248697669276;5846.941530584725;5573.359063707726;5574.804881829197;5576.079946808813;5578.219049333096;5590.804321848797;5484.369297530755;5648.435156484319;5649.661020338793;5650.74571644277;5659.717014149359;5414.539764120015;5536.4186760389575;5554.333479982428;5608;5613.915791263134;5624.690642014647;5630.915536266877;5642.71786410686;5657;5719.056355701346;4322.697411181187;4323.308270676676;4368.453943257093;4369.519352871182;4372.519022907478;3800.657940785343;3814.7138964577766;3852.210296889131;3875.0312421894528;3896.0649444133205;5415.241866138744;5424.996375670514;5445.482679145475;5489.64317319373;5503.504684578407;5698.344690360579;5730.5129064030025;5743.195952566644;5756.481916627524;5764.365919748824;5219.869503262449;5270.92093618596;5380.596455265792;5407.83776486706;5503.3120859892515;4849.2968519564465;4894.608431325485;4898.191798353232;4941.45643979162;4955.529224723646;5915.763369465173;5923;5925.4370834770625;5933.406659334032;5936.614120082095;5546.084895992278;5693.202951586698;5720.8283751487525;5747.137929310469;5749.626274292157;5786.710664466676;5876.970615146897;5890.352061273342;5977.820665380045;5997.280326360865;5648.5481161507805;5651.689157096399;5653.3781284057895;5654.717264136859;5655.321361436654;5527.751251193626;5585.860353491195;5692.060809966475;5711.029125048834;5746.770129194785;5619.2133101365025;5625.268715067015;5627.43725627434;5656;5678.77284908599;5584.944150558443;5592.3009623797025;5592.972035139798;5598.916016259841;5603.411641777555;5362.329708786402;5363.061464243664;5374.785008599769;5583.35791383996;5606.383297837153;5411.783528658967;5456.0451920914475;5487.067198576172;5527;5532.391436942014;5392.272043274108;5437.918431223456;5494.313210848644;5498.615096943336;5505.091659876076 16:13:36 INFO - PROCESS | 2225 | |1;ext.html;564.9039663257247;572.6220694341732;580.2949416459002;586.448738186105;593.4658807073633;41231.79384103079;43094.569054309446;43189.35215971763;47536.762316188455;47555.28667069997;45310;45862.31206531896;45975.77012114935;45982.770086149525;46012.53987460124;8894.599743011564;9048.909510904905;9052.321075919332;9063.365564410495;9071.909280907206;8765.517896515688;8936.776580585505;8944.8658270126;8946.329025323093;8967.865482017742;9008.639654413815;9041.683541076063;9041.864372034424;9076.773080673003;9082.091790820898;8941.552922353889;8947.910520894839;8983.68557100505;8989.820203595957;9001.18989290967;8898.911010889873;8907.910920890772;8944.150305720947;8960.103989601053;8994.775130621787;42119.1576168478;42540;42595.36106958398;43012;43028.35457468109;3056.2970516781265;3271.1658527075683;3390.0507857799857;3506.2286297014616;3599.1182160370613;31130.533042004387;31240;31809.681903180903;31829.363412731847;31928.840355798304;4243.745375277494;4304.9532297084515;4317.503487098992;4387.868363949055;4536.160810250114;313297;315718;316454;317100;318214;57983;58172.70913645405;58209.9401113787;58324.70837645869;58503.12245316324;60397;60669;60686;60952;61010.694946524985;14595.197264150362;14759.114453132846;14860.405583776528;14872.776908346383;14901.850981490263;11164.609238676607;11211.775764484664;11301.095912326995;11327.093832493381;11329.980301772715;16277.151498487718;17061.658766824596;17140.914295428443;17218.65562688764;17568.121593920252;5861.658854453006;5880.323762767251;5937.287525496881;6114.816555503253;6163.84590385235;886.2555453419159;986.127277359542;1016.4612755239734;1018.7554986803113;1107.7286064914147;32291;32416.513752293733;32641.18397040093;32667.346653066805;32823.1794205142;1029.984550231747;1054.7099547624464;1062.5431064642123;1073.4954571351452;1135.644802183635;16086.597835053983;16926.153692315336;16939.830601694073;17083.40208092711;17120.571985700208;476407;479838;480452;482503;482518;57987;58022.7098864503;58213;58232.708836455546;58276.708616457494;1281.9615411537668;1297.0855546839455;1336.4253371050347;1347.2724728646422;1357.830271216098;29255.268618284714;31301;31339;31856.68143318537;32507.18732031718;50815.74592127016;51251.48748512467;51348;51500.742496287276;51569.22646160235;405379;406638;410565;410649;411517;40132.71624927183;40904.38643420291;41789;42183.7890810544;42205.78897105618;46919.29621055755;47070.293945591526;47866.5213347876;48108.27837582369;48772.75613622051;40022;41211.793941030104;42013.57986420097;42759.14481710286;43787.79851454982;38232.80883595564;40573;42680.786596068065;43522.34716479192;44820.55179448164;39735.403968939914;39909.80045099872;40090.599094008685;41448.792756036026;41462.37806432966;35682.46476302806;37302;37811.43282850814;38254.808725956194;38417.80791096138;28292.43415131727;28363.858180708965;28379.432411351245;28412.289692757848;28656.713432865403 16:13:36 INFO - PROCESS | 2225 | |2;jquery.html;389.8323720800055;396.1957226829537;406.5284270246515;409.7172950664042;427.6514640567937;16063;16203.351865925379;17510.82489175108;19046.428607141792;19084.04579771011;12295.692607684812;12979.675508112301;12988.54540091097;15647.687046259096;17720.202590883408;5287.735613219334;5531.142672885689;5537.723113844312;5539.390667026624;5542.8337149885565;4355.499117601469;5896.321922978869;5954.374790646984;5960.403959604048;5981.5214782817275;5427.45725427458;5914.556408269375;5917.289925208959;5938.673372964486;5943.435373639497;5430.619856610039;5458.344998600173;5470.753816078286;5483.561315094783;5491;5159.432462429129;5292.761825717852;5316.415194328621;5321.3348331458565;5345.518903298683;14363.353649085817;14446;14481.42074317026;14546.490872819506;14577.125372477685;2205.0056621751746;2213.9335819925427;2229.9777002230094;2270.4664403865077;2478.5910324796387;10064.849027264598;10232.53953572091;10265;10792.136629069655;11020.724481887937;1923.7018262169247;1954.6677064898859;1999.8200161985492;2012.2152360579387;2017.425033865356;82714.58642706808;82907.58546207291;83326.58336708277;85923.57038214832;88486.5575672124;10960.506777195045;11124.61063862761;11263.887361126448;11312.321260724382;11420.371879546705;12241;13010.54463093806;16028.599285017968;16053.919730401274;16120.355185792672;6144.631322120687;6305.180326557518;6872.312768723188;7382.593957332291;7663.233676632292;7175.964120179366;7236.095488063992;7366.77899663011;7417.666205020787;7472.32749052577;3999.440078389028;4116.835326586963;4208.915821683549;4293.2272191005295;4334.21984042869;1951.9414417567496;2020.3635854706015;2022.7370441842465;2088.2098990332497;2100.7479102507796;885.2563846369081;933.1042199488431;945.9858102128474;964.8022155458115;990.1929927109383;18102.366417175337;18810.529736756416;18883.52791180204;18969.62060758777;19574.314898978468;929.9628014879329;943.7546237978175;971.8007808399261;981.3670182732097;1025.3489034463169;10307.793844123076;10463.424511651932;10792.730181745363;10803.675889723321;10827.187960902964;434678;437757;447679;456423;457863;64178.67910660417;86701.56649216714;87035.56482217548;87103.56448217845;87553.56223218843;904.7421484876778;923.7182659288982;927.1516562345513;930.1210356213313;939.8214339275515;15735.921320393325;15755.291011904263;16095.195240237706;16578.58553536171;17115.657686845945;30614.693853061184;39216;41134;41574.37638435365;42642.36036459394;55661.721691391285;57317.42682573121;57592.4240757587;58044;58820;5511.586631002771;6892.414144797748;7215.206327304098;7962.761117166494;8209.302209312274;10300.742481438025;12552.49790008426;12585.87414125847;12836.614901552968;12938.870611294144;10613.840792388275;10829.891701083203;11016.724581885517;11024.944875275572;11091.944540277247;10720.678379648623;11088.501017454073;11090.16823738239;11147.55409783632;11523.654290371302;11244.943775281072;11542.249753765978;11544.365059921785;11568.826467602825;11665.416729163677;8257.876131857907;8406.327493800603;8419.031811341774;8490.320774337915;8502.914970850212;11121.666350009513;11176.441177941233;11250.606228781953;11305.660830175108;11707.88292117068 16:13:36 INFO - PROCESS | 2225 | |3;mootools.html;1455.9781603275953;1488.2112480385395;1630.8206097329298;1747.1962897067365;1787.7229029500425;8040.517568945867;8280.296174825133;8610.095939926312;9362.95318523408;9367.578458969345;8556.5293908835;8921.241694455963;8951.865722014176;9195.448273103619;9237.44575325481;2385.558671645751;2394.5330660521204;2401.759824017593;2417.770311820383;2425.842320249187;2336.427575244059;2381.9761802382013;2401.399650087478;2403.098837935774;2403.3030421177837;2345.1323010486144;2345.519168570439;2383.618621020637;2424.9030038798514;2429.4047958250167;2336.661184128309;2351.529694061186;2355.0697474497647;2364.1441468447274;2365.3731761083327;2266.648669456237;2271.886405679726;2313.4910319729634;2318.8724620145886;2324.6629238760283;9103.635854565875;9263.258939284908;9270.536473176315;9277.814443711088;9294.07059294072;5351.812686555991;5463.617546771728;5482.068048431776;5494.780208791643;5497.615166938316;3594.4428613564937;3599.766015209003;3633.94549081764;3637.1089083174793;3677.797721125337;1161.4425075963584;1187.1808452167977;1198.3708553009653;1199.5261871560772;1208.299186471853;12889.935550322281;12927.288999105045;12937.02972277083;12940.094193406465;12957.157784743962;4445.177642136216;4697.882552936204;4782.952170478251;4882.462929077798;4896.143174944371;10687.946560267304;10696.358218506915;10709.518071686793;10733.463326833627;10790.51442685081;5455.372632147274;5475.534579560703;5500.257465242141;5501.807436739695;5505.834824955257;4393.560643935645;4524.705894116872;4853.417589889165;4976.0794253063295;5043.84868453947;3933;3966.504186976628;4006.338954072545;4081.8979525511504;4086.244044851712;1282.0704988883172;1301.1087405127519;1315.6447759105179;1318.3408295852073;1323.5235315286488;680.8331958670059;728.9453291003196;743.0043741386568;849.7960489482604;857.6440777077568;5582.469665381782;5611.831645050655;5645.2096706461125;5753.942460575425;5780.335261444988;447.8925057986125;447.9014616784302;452.7736131934033;457.9038401935631;477.61551950680035;4080.4083407905687;4110.403991421227;4129.648979836687;4134;4144.461220041375;11072.062389081879;11292.096632269398;11375.943120284512;11438.828417573743;11486.425678716198;11299.830502542469;11314.830277545843;11320.207585468937;11347.148963827745;11363.318200907972;7879.172686867911;8246.175382461706;8399.53802540854;8445.408821382443;8466.57667116654;6013.188219590299;6139.3553676863285;6189.9690501549;6236.095766113979;6257.2804127525915;10367.688969330931;10594.20543459259;10613.257072005194;10654.62708805188;10655.946720266658;9932.304738668512;10471.3193642413;10477.9476102619;10605.89394106049;10785.946070269598;6573.1454910861285;6775.559588626724;7628.961855190911;7877.842443151219;8066.072401673648;8236.629351679068;8589.098144694717;8629.266512346521;8629.39594228398;8682.826343473222;7600.695972161052;7880.05439347282;7889.881651775343;8044.2760151586635;8164.224398682116;7619.276168763959;7635.465517413728;7748.883766743391;7762.184970578008;7824.84350313002;6866.622335771581;7010.123734533184;7013.684384202621;7023.894641580278;7043.718251269892;5071.239314102914;5168.508991645787;5215.4002289735645;5262;5437.972810135924;5087.796488140433;5098.872528186825;5161.845144645667;5217.452167522356;5424.945750542444 16:13:36 INFO - PROCESS | 2225 | |4;prototype.html;321.641369872592;332.3038234897889;332.70389353475395;335.4649334311772;342.1890120414617;5162.354705661793;5316.059638232046;5434.918476222855;5493.862653433666;5494.478024587668;5129.717865517395;5292.708901010443;5321.893562128756;5333.706646134461;5339.733013349327;4198.9370159447635;4213.894652633678;4253.723507971972;4260.190563792885;4277.786110694468;4158.378232489332;4163.250614889319;4176.958230417687;4261.275583150872;4273.401723758676;4149.522804877448;4161.521425036114;4178.268802959486;4197.16056788642;4218.869470917182;4185.4977402711565;4214.220369231702;4216.241076606225;4228.238916994939;4231.597998190167;3737.5141231639986;3748.850045998157;3755.830987605564;3756.323861704892;3766.886993390203;5089.312942752755;5218.295530103425;5258.973705131488;5283.788648454057;5337.838175538875;4786.401699787527;4826.420829500447;4842.18418093215;4854.368932038848;4860.586850117745;5449.891002179934;5616.466435688603;5645.491905728463;5673.943260567383;5677.829665110054;4059.0664147246002;4083;4085.1829634073306;4094.7747873866924;4099.262132816092;5871.970640146772;5901.380355062743;5937.614055086406;5938.257717785277;5943.851403714899;4219.240536703423;4222;4229.746215227096;4235.305877648965;4241.957580424156;3927.6072392761066;4136.407483119021;4166.7708276045105;4172.102997855475;4201.579842015774;4768.737719425465;4807.78364973577;4811.639127065484;4812.123271923952;4820.638452116105;5723.914141287884;5731.681713205986;5736.856578585485;5744.770209191585;5749.511291540182;1385.9328317195702;1426.9369319856773;1435.5429239322095;1440.5030264558711;1440.9481078812526;880.3705350674298;908.3377419322624;916.8899732032199;919.4599046596924;937.016133060284;4730.810767569327;4789.784459699322;4797.280407938837;4851;4882.877928051827;5045;5046.596272298208;5051.4695956924;5057.317262169634;5066.620003499752;4782.33047373368;4785.59322457595;4806.8798280043275;4834.661573689808;5100.821471248489;3030.9696903031127;3077.661457239702;3078;3081.1372815611667;3085.6760040195904;6039.365866583946;6045.486133678686;6076.270847498328;6102.291358419649;6111;5630.18362337467;5930.110483427434;5966.791162309385;5970.641761494324;5997;5993.400659934059;6023.367546407651;6040.607360521552;6089.1779609753;6090.33006369299;5597.5521958242425;5801.76792928295;5822.94177058224;5840.620359676607;5868.295804503487;5785.566082543742;5792.333881603669;5799.391063938395;5835.79574714883;5839.737211825393;6112.816615501542;6123.785667501616;6124.54065945047;6143.784967526115;6148.385161483816;4080.551139374607;4137.193247316744;4148.23257697327;4183.560726123835;4197.160567886496;5818.592698511064;5836.795712150054;5838.591298609056;5843.561732869966;5867.32525759526;5558.8592445269915;5733.824565964051;5761.222234998221;5779.335376431764;5788.681622510802;5689;5705.144228365778;5725.971370143123;5728.4271572844045;5740.225069615715;5644.463775941279;5673.489385955284;5675.545956323567;5689.914651280317;5709.486146246858;5421.674699518042;5681.375048744718;5705.600607957404;5724.652892314131;5736.110902810071;5589.552835773047;5615.578831587729;5628.943710562842;5630.211770352236;5631.493165615114 16:13:36 INFO - PROCESS | 2225 | |5;yui.html;696.6064173741833;707.1266985273187;710.9608971506567;757.7158565537924;798.1738900238255;13960.930195349034;15330.15684137372;15373.461928832494;15489.225538723074;15612.375504979802;14802.925985370084;14957.775633365482;14982.62543436412;15011.774823377631;15053.924730376333;654.8722999015171;669.6250099944023;783.2050468774198;787.3347021766626;795.9005124359455;800.8118092248346;816.6080281464871;817.0726225733775;817.2318021060214;817.3461231015194;864.2912811494577;864.4121997042009;866.3502373220085;870.6560908441162;870.6778491957984;864.8529749942525;865.7748985263845;866.4584634603373;866.653338664533;867.444835305405;629.2669040567733;630.5082036011918;630.8328293002359;631.4001698386551;631.4979591224987;15151.469698560608;15250.923745381313;15282.465113720966;15314.004589701744;15345.923270383688;14379.496717614833;14424;14435.639109022359;14725.926370368186;14753;11758.544845162898;11781.646550603497;11983.28100313984;12286.262824230575;12801.807972880415;3598.604153543108;3600.9099772505633;3640.581333146669;3654.634536546351;3759.586445490994;75882.62058689726;78452.21547784506;79539.20460795375;79703;80093.19906800915;11497.54009839597;11543.76912461763;11706.35615041181;11800.52797888092;12328.938355308166;22066.88966555157;22082.558348832932;22153.446163846034;22202;22228.222012229493;8258.380621453294;8295.917040829514;8563.614637341334;8587;8671.869921951176;4547.886302842389;4797.544233297901;4806.975965120152;4879.878003049881;4958.553730164303;3362.193073662352;3560.092176495029;3613;3613.1509095362567;3622.8550857965915;607.1014897950969;608.9391060893964;628.5286035473395;641.1920979565781;648.7307767276621;671.2113266911359;693.4313862632694;694.6804469943781;695.7425752471618;722.6025685872748;8794.20852123312;9954.900450995543;9998.350107243006;10173.898261017295;10420.739481513023;572.6163470474792;594.7442599682179;625.978090766821;656.212544946057;670.6981858163846;4533.206688829508;4846.345743324677;4902.583280421204;4906.828261010919;4952.579030782424;122186;127051;127135;128323;129546;67983;69322.65338673274;99918.5004074975;102603.48698256462;103360;94102.52948735212;96133.5193324029;96663.51668241614;96937.69904956296;97684;8307.6676932922;8637.69768058115;8734.126587341216;8858.73423797287;9123.589438475152;48131.63078584606;49673.75163124306;49806.75096624494;50572.747136264086;50627;73362;75103;76979;77756;79142.6042869782;11319.943400282946;11432.314061156358;11453.427328633368;11525.308481491138;11740.178187526792;12422;12811.679708007374;12849.935750321189;12932.676683082622;12986.935065324613;11932.917759082975;12546.247225166155;12546.87453125457;12658.367081646065;12767.170133941265;11737;12126.636200913987;12286.447109880255;12347.365555473203;12839.293838838954;11778.293302401884;12176.884223036404;12266.080043996557;12495.812562811747;12773.425195866394;9857.852132217879;10428.791424171322;10490.160787136858;10716.491661519469;10751.731206719895;9182.449053056838;10334.896651033694;10427.322224055411;10428.739281517719;10504 16:13:36 INFO - PROCESS | 2225 | __end_tp_report 16:13:36 INFO - PROCESS | 2225 | __start_cc_report 16:13:36 INFO - PROCESS | 2225 | _x_x_mozilla_cycle_collect,322 16:13:36 INFO - PROCESS | 2225 | __end_cc_report 16:13:36 INFO - PROCESS | 2225 | __startTimestamp1476400416587__endTimestamp 16:13:36 INFO - PROCESS | 2225 | 16:13:36 INFO - PROCESS | 2225 | ------- Summary: start ------- 16:13:36 INFO - PROCESS | 2225 | Number of tests: 6 16:13:36 INFO - PROCESS | 2225 | 16:13:36 INFO - PROCESS | 2225 | [#0] dojo.html Cycles:165 Average:5275.17 Median:5489.64 stddev:598.52 (10.9%) stddev-sans-first:573.49 16:13:36 INFO - PROCESS | 2225 | Values: 3015.0 3060.7 3064.1 3099.7 3106.9 5209.7 5321.2 5325.2 5334.5 5460.8 5259.8 5271.4 5288.8 5367.8 5383.7 4782.7 4819.2 4837.2 4862.5 4922.1 4766.4 4822.2 4881.3 4883.3 4885.1 4711.8 4892.2 4950.8 4963.5 4974.4 4756.8 4789.5 4796.4 4816.1 4825.0 4721.6 4775.9 4807.5 4881.9 4950.7 5309.2 5348.6 5358.0 5373.8 5379.2 5541.9 5566.4 5593.2 5606.6 5615.8 5613.9 5642.2 5652.1 5660.3 5692.8 5123.1 5137.2 5325.9 5334.2 5362.2 5740.7 5751.2 5768.0 5779.2 5846.9 5573.4 5574.8 5576.1 5578.2 5590.8 5484.4 5648.4 5649.7 5650.7 5659.7 5414.5 5536.4 5554.3 5608.0 5613.9 5624.7 5630.9 5642.7 5657.0 5719.1 4322.7 4323.3 4368.5 4369.5 4372.5 3800.7 3814.7 3852.2 3875.0 3896.1 5415.2 5425.0 5445.5 5489.6 5503.5 5698.3 5730.5 5743.2 5756.5 5764.4 5219.9 5270.9 5380.6 5407.8 5503.3 4849.3 4894.6 4898.2 4941.5 4955.5 5915.8 5923.0 5925.4 5933.4 5936.6 5546.1 5693.2 5720.8 5747.1 5749.6 5786.7 5877.0 5890.4 5977.8 5997.3 5648.5 5651.7 5653.4 5654.7 5655.3 5527.8 5585.9 5692.1 5711.0 5746.8 5619.2 5625.3 5627.4 5656.0 5678.8 5584.9 5592.3 5593.0 5598.9 5603.4 5362.3 5363.1 5374.8 5583.4 5606.4 5411.8 5456.0 5487.1 5527.0 5532.4 5392.3 5437.9 5494.3 5498.6 5505.1 16:13:36 INFO - PROCESS | 2225 | 16:13:36 INFO - PROCESS | 2225 | [#1] ext.html Cycles:180 Average:57344.31 Median:23391.87 stddev:107585.98 (459.9%) stddev-sans-first:107803.32 16:13:36 INFO - PROCESS | 2225 | Values: 564.9 572.6 580.3 586.4 593.5 41231.8 43094.6 43189.4 47536.8 47555.3 45310.0 45862.3 45975.8 45982.8 46012.5 8894.6 9048.9 9052.3 9063.4 9071.9 8765.5 8936.8 8944.9 8946.3 8967.9 9008.6 9041.7 9041.9 9076.8 9082.1 8941.6 8947.9 8983.7 8989.8 9001.2 8898.9 8907.9 8944.2 8960.1 8994.8 42119.2 42540.0 42595.4 43012.0 43028.4 3056.3 3271.2 3390.1 3506.2 3599.1 31130.5 31240.0 31809.7 31829.4 31928.8 4243.7 4305.0 4317.5 4387.9 4536.2 313297.0 315718.0 316454.0 317100.0 318214.0 57983.0 58172.7 58209.9 58324.7 58503.1 60397.0 60669.0 60686.0 60952.0 61010.7 14595.2 14759.1 14860.4 14872.8 14901.9 11164.6 11211.8 11301.1 11327.1 11330.0 16277.2 17061.7 17140.9 17218.7 17568.1 5861.7 5880.3 5937.3 6114.8 6163.8 886.3 986.1 1016.5 1018.8 1107.7 32291.0 32416.5 32641.2 32667.3 32823.2 1030.0 1054.7 1062.5 1073.5 1135.6 16086.6 16926.2 16939.8 17083.4 17120.6 476407.0 479838.0 480452.0 482503.0 482518.0 57987.0 58022.7 58213.0 58232.7 58276.7 1282.0 1297.1 1336.4 1347.3 1357.8 29255.3 31301.0 31339.0 31856.7 32507.2 50815.7 51251.5 51348.0 51500.7 51569.2 405379.0 406638.0 410565.0 410649.0 411517.0 40132.7 40904.4 41789.0 42183.8 42205.8 46919.3 47070.3 47866.5 48108.3 48772.8 40022.0 41211.8 42013.6 42759.1 43787.8 38232.8 40573.0 42680.8 43522.3 44820.6 39735.4 39909.8 40090.6 41448.8 41462.4 35682.5 37302.0 37811.4 38254.8 38417.8 28292.4 28363.9 28379.4 28412.3 28656.7 16:13:36 INFO - PROCESS | 2225 | 16:13:36 INFO - PROCESS | 2225 | [#2] jquery.html Cycles:180 Average:26873.29 Median:2202.98 stddev:73934.31 (3356.1%) stddev-sans-first:74114.97 16:13:36 INFO - PROCESS | 2225 | Values: 389.8 396.2 406.5 409.7 427.7 16063.0 16203.4 17510.8 19046.4 19084.0 12295.7 12979.7 12988.5 15647.7 17720.2 5287.7 5531.1 5537.7 5539.4 5542.8 4355.5 5896.3 5954.4 5960.4 5981.5 5427.5 5914.6 5917.3 5938.7 5943.4 5430.6 5458.3 5470.8 5483.6 5491.0 5159.4 5292.8 5316.4 5321.3 5345.5 14363.4 14446.0 14481.4 14546.5 14577.1 2205.0 2213.9 2230.0 2270.5 2478.6 10064.8 10232.5 10265.0 10792.1 11020.7 1923.7 1954.7 1999.8 2012.2 2017.4 82714.6 82907.6 83326.6 85923.6 88486.6 10960.5 11124.6 11263.9 11312.3 11420.4 12241.0 13010.5 16028.6 16053.9 16120.4 6144.6 6305.2 6872.3 7382.6 7663.2 7176.0 7236.1 7366.8 7417.7 7472.3 3999.4 4116.8 4208.9 4293.2 4334.2 1951.9 2020.4 2022.7 2088.2 2100.7 885.3 933.1 946.0 964.8 990.2 18102.4 18810.5 18883.5 18969.6 19574.3 930.0 943.8 971.8 981.4 1025.3 10307.8 10463.4 10792.7 10803.7 10827.2 434678.0 437757.0 447679.0 456423.0 457863.0 64178.7 86701.6 87035.6 87103.6 87553.6 904.7 923.7 927.2 930.1 939.8 15735.9 15755.3 16095.2 16578.6 17115.7 30614.7 39216.0 41134.0 41574.4 42642.4 55661.7 57317.4 57592.4 58044.0 58820.0 5511.6 6892.4 7215.2 7962.8 8209.3 10300.7 12552.5 12585.9 12836.6 12938.9 10613.8 10829.9 11016.7 11024.9 11091.9 10720.7 11088.5 11090.2 11147.6 11523.7 11244.9 11542.2 11544.4 11568.8 11665.4 8257.9 8406.3 8419.0 8490.3 8502.9 11121.7 11176.4 11250.6 11305.7 11707.9 16:13:36 INFO - PROCESS | 2225 | 16:13:36 INFO - PROCESS | 2225 | [#3] mootools.html Cycles:180 Average:5911.23 Median:2577.89 stddev:3439.27 (133.4%) stddev-sans-first:3432.62 16:13:36 INFO - PROCESS | 2225 | Values: 1456.0 1488.2 1630.8 1747.2 1787.7 8040.5 8280.3 8610.1 9363.0 9367.6 8556.5 8921.2 8951.9 9195.4 9237.4 2385.6 2394.5 2401.8 2417.8 2425.8 2336.4 2382.0 2401.4 2403.1 2403.3 2345.1 2345.5 2383.6 2424.9 2429.4 2336.7 2351.5 2355.1 2364.1 2365.4 2266.6 2271.9 2313.5 2318.9 2324.7 9103.6 9263.3 9270.5 9277.8 9294.1 5351.8 5463.6 5482.1 5494.8 5497.6 3594.4 3599.8 3633.9 3637.1 3677.8 1161.4 1187.2 1198.4 1199.5 1208.3 12889.9 12927.3 12937.0 12940.1 12957.2 4445.2 4697.9 4783.0 4882.5 4896.1 10687.9 10696.4 10709.5 10733.5 10790.5 5455.4 5475.5 5500.3 5501.8 5505.8 4393.6 4524.7 4853.4 4976.1 5043.8 3933.0 3966.5 4006.3 4081.9 4086.2 1282.1 1301.1 1315.6 1318.3 1323.5 680.8 728.9 743.0 849.8 857.6 5582.5 5611.8 5645.2 5753.9 5780.3 447.9 447.9 452.8 457.9 477.6 4080.4 4110.4 4129.6 4134.0 4144.5 11072.1 11292.1 11375.9 11438.8 11486.4 11299.8 11314.8 11320.2 11347.1 11363.3 7879.2 8246.2 8399.5 8445.4 8466.6 6013.2 6139.4 6190.0 6236.1 6257.3 10367.7 10594.2 10613.3 10654.6 10655.9 9932.3 10471.3 10477.9 10605.9 10785.9 6573.1 6775.6 7629.0 7877.8 8066.1 8236.6 8589.1 8629.3 8629.4 8682.8 7600.7 7880.1 7889.9 8044.3 8164.2 7619.3 7635.5 7748.9 7762.2 7824.8 6866.6 7010.1 7013.7 7023.9 7043.7 5071.2 5168.5 5215.4 5262.0 5438.0 5087.8 5098.9 5161.8 5217.5 5424.9 16:13:36 INFO - PROCESS | 2225 | 16:13:36 INFO - PROCESS | 2225 | [#4] prototype.html Cycles:180 Average:4734.46 Median:5288.25 stddev:1401.82 (26.5%) stddev-sans-first:1366.06 16:13:36 INFO - PROCESS | 2225 | Values: 321.6 332.3 332.7 335.5 342.2 5162.4 5316.1 5434.9 5493.9 5494.5 5129.7 5292.7 5321.9 5333.7 5339.7 4198.9 4213.9 4253.7 4260.2 4277.8 4158.4 4163.3 4177.0 4261.3 4273.4 4149.5 4161.5 4178.3 4197.2 4218.9 4185.5 4214.2 4216.2 4228.2 4231.6 3737.5 3748.9 3755.8 3756.3 3766.9 5089.3 5218.3 5259.0 5283.8 5337.8 4786.4 4826.4 4842.2 4854.4 4860.6 5449.9 5616.5 5645.5 5673.9 5677.8 4059.1 4083.0 4085.2 4094.8 4099.3 5872.0 5901.4 5937.6 5938.3 5943.9 4219.2 4222.0 4229.7 4235.3 4242.0 3927.6 4136.4 4166.8 4172.1 4201.6 4768.7 4807.8 4811.6 4812.1 4820.6 5723.9 5731.7 5736.9 5744.8 5749.5 1385.9 1426.9 1435.5 1440.5 1440.9 880.4 908.3 916.9 919.5 937.0 4730.8 4789.8 4797.3 4851.0 4882.9 5045.0 5046.6 5051.5 5057.3 5066.6 4782.3 4785.6 4806.9 4834.7 5100.8 3031.0 3077.7 3078.0 3081.1 3085.7 6039.4 6045.5 6076.3 6102.3 6111.0 5630.2 5930.1 5966.8 5970.6 5997.0 5993.4 6023.4 6040.6 6089.2 6090.3 5597.6 5801.8 5822.9 5840.6 5868.3 5785.6 5792.3 5799.4 5835.8 5839.7 6112.8 6123.8 6124.5 6143.8 6148.4 4080.6 4137.2 4148.2 4183.6 4197.2 5818.6 5836.8 5838.6 5843.6 5867.3 5558.9 5733.8 5761.2 5779.3 5788.7 5689.0 5705.1 5726.0 5728.4 5740.2 5644.5 5673.5 5675.5 5689.9 5709.5 5421.7 5681.4 5705.6 5724.7 5736.1 5589.6 5615.6 5628.9 5630.2 5631.5 16:13:36 INFO - PROCESS | 2225 | 16:13:36 INFO - PROCESS | 2225 | [#5] yui.html Cycles:180 Average:20977.96 Median:26469.30 stddev:31334.20 (118.4%) stddev-sans-first:31385.10 16:13:36 INFO - PROCESS | 2225 | Values: 696.6 707.1 711.0 757.7 798.2 13960.9 15330.2 15373.5 15489.2 15612.4 14802.9 14957.8 14982.6 15011.8 15053.9 654.9 669.6 783.2 787.3 795.9 800.8 816.6 817.1 817.2 817.3 864.3 864.4 866.4 870.7 870.7 864.9 865.8 866.5 866.7 867.4 629.3 630.5 630.8 631.4 631.5 15151.5 15250.9 15282.5 15314.0 15345.9 14379.5 14424.0 14435.6 14725.9 14753.0 11758.5 11781.6 11983.3 12286.3 12801.8 3598.6 3600.9 3640.6 3654.6 3759.6 75882.6 78452.2 79539.2 79703.0 80093.2 11497.5 11543.8 11706.4 11800.5 12328.9 22066.9 22082.6 22153.4 22202.0 22228.2 8258.4 8295.9 8563.6 8587.0 8671.9 4547.9 4797.5 4807.0 4879.9 4958.6 3362.2 3560.1 3613.0 3613.2 3622.9 607.1 608.9 628.5 641.2 648.7 671.2 693.4 694.7 695.7 722.6 8794.2 9954.9 9998.4 10173.9 10420.7 572.6 594.7 626.0 656.2 670.7 4533.2 4846.3 4902.6 4906.8 4952.6 122186.0 127051.0 127135.0 128323.0 129546.0 67983.0 69322.7 99918.5 102603.5 103360.0 94102.5 96133.5 96663.5 96937.7 97684.0 8307.7 8637.7 8734.1 8858.7 9123.6 48131.6 49673.8 49806.8 50572.7 50627.0 73362.0 75103.0 76979.0 77756.0 79142.6 11319.9 11432.3 11453.4 11525.3 11740.2 12422.0 12811.7 12849.9 12932.7 12986.9 11932.9 12546.2 12546.9 12658.4 12767.2 11737.0 12126.6 12286.4 12347.4 12839.3 11778.3 12176.9 12266.1 12495.8 12773.4 9857.9 10428.8 10490.2 10716.5 10751.7 9182.4 10334.9 10427.3 10428.7 10504.0 16:13:36 INFO - PROCESS | 2225 | -------- Summary: end -------- 16:13:36 INFO - PROCESS | 2225 | 16:13:37 INFO - TEST-INFO | 2225: exit 0 16:13:37 INFO - TEST-OK | dromaeo_css | took 1116162ms 16:13:37 INFO - TEST-START | kraken 16:13:37 INFO - operating with platform_type : linux_ 16:13:37 INFO - Initialising browser for kraken test... 16:13:37 INFO - TEST-INFO | started process 2674 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4CKDEo/profile http://localhost:52495/getInfo.html) 16:13:42 INFO - PROCESS | 2674 | __metrics Screen width/height:1600/1200 16:13:42 INFO - PROCESS | 2674 | colorDepth:24 16:13:42 INFO - PROCESS | 2674 | Browser inner width/height: 1024/697 16:13:42 INFO - PROCESS | 2674 | __metrics 16:13:42 ERROR - PROCESS | 2674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 16:13:43 INFO - TEST-INFO | 2674: exit 0 16:13:43 INFO - Browser initialized. 16:13:43 INFO - Running cycle 1/1 for kraken test... 16:13:43 INFO - TEST-INFO | started process 2890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4CKDEo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:13:55 INFO - PROCESS | 2890 | RSS: Main: 185032704 16:13:55 INFO - PROCESS | 2890 | 16:13:58 INFO - PROCESS | 2890 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52495/tests/kraken/driver.html?testName=audio-beat-detection) 16:13:59 INFO - PROCESS | 2890 | RSS: Main: 199036928 16:13:59 INFO - PROCESS | 2890 | 16:14:02 INFO - PROCESS | 2890 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52495/tests/kraken/driver.html?testName=audio-dft) 16:14:02 INFO - PROCESS | 2890 | RSS: Main: 197095424 16:14:02 INFO - PROCESS | 2890 | 16:14:05 INFO - PROCESS | 2890 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52495/tests/kraken/driver.html?testName=audio-fft) 16:14:06 INFO - PROCESS | 2890 | RSS: Main: 192827392 16:14:06 INFO - PROCESS | 2890 | 16:14:08 INFO - PROCESS | 2890 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52495/tests/kraken/driver.html?testName=audio-oscillator) 16:14:09 INFO - PROCESS | 2890 | RSS: Main: 193236992 16:14:09 INFO - PROCESS | 2890 | 16:14:11 INFO - PROCESS | 2890 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52495/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:14:11 INFO - PROCESS | 2890 | RSS: Main: 193400832 16:14:11 INFO - PROCESS | 2890 | 16:14:14 INFO - PROCESS | 2890 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52495/tests/kraken/driver.html?testName=imaging-darkroom) 16:14:15 INFO - PROCESS | 2890 | RSS: Main: 193499136 16:14:15 INFO - PROCESS | 2890 | 16:14:18 INFO - PROCESS | 2890 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52495/tests/kraken/driver.html?testName=imaging-desaturate) 16:14:19 INFO - PROCESS | 2890 | RSS: Main: 193675264 16:14:19 INFO - PROCESS | 2890 | 16:14:22 INFO - PROCESS | 2890 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52495/tests/kraken/driver.html?testName=json-parse-financial) 16:14:23 INFO - PROCESS | 2890 | RSS: Main: 193830912 16:14:23 INFO - PROCESS | 2890 | 16:14:24 INFO - PROCESS | 2890 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52495/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:14:25 INFO - PROCESS | 2890 | RSS: Main: 193110016 16:14:25 INFO - PROCESS | 2890 | 16:14:27 INFO - PROCESS | 2890 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52495/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:14:27 INFO - PROCESS | 2890 | RSS: Main: 193261568 16:14:27 INFO - PROCESS | 2890 | 16:14:29 INFO - PROCESS | 2890 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52495/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:14:30 INFO - PROCESS | 2890 | RSS: Main: 193650688 16:14:30 INFO - PROCESS | 2890 | 16:14:33 INFO - PROCESS | 2890 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52495/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:14:33 INFO - PROCESS | 2890 | RSS: Main: 193642496 16:14:33 INFO - PROCESS | 2890 | 16:14:36 INFO - PROCESS | 2890 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52495/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:14:37 INFO - PROCESS | 2890 | RSS: Main: 194097152 16:14:37 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52495/tests/kraken/driver.html?testName=ai-astar) 16:14:39 INFO - PROCESS | 2890 | RSS: Main: 195506176 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | __start_tp_report 16:14:39 INFO - PROCESS | 2890 | _x_x_mozilla_page_load 16:14:39 INFO - PROCESS | 2890 | _x_x_mozilla_page_load_details 16:14:39 INFO - PROCESS | 2890 | |i|pagename|runs| 16:14:39 INFO - PROCESS | 2890 | |0;ai-astar;106;111;113;111;110;111;110;111;112;112 16:14:39 INFO - PROCESS | 2890 | |1;audio-beat-detection;157;123;124;174;129;128;123;125;161;128 16:14:39 INFO - PROCESS | 2890 | |2;audio-dft;164;166;170;170;173;163;169;162;162;164 16:14:39 INFO - PROCESS | 2890 | |3;audio-fft;75;76;79;108;76;77;76;78;105;75 16:14:39 INFO - PROCESS | 2890 | |4;audio-oscillator;82;83;114;83;82;84;100;83;83;105 16:14:39 INFO - PROCESS | 2890 | |5;imaging-gaussian-blur;118;119;117;118;120;117;119;118;117;118 16:14:39 INFO - PROCESS | 2890 | |6;imaging-darkroom;146;147;148;147;148;148;148;147;147;148 16:14:39 INFO - PROCESS | 2890 | |7;imaging-desaturate;97;96;96;97;97;95;96;96;97;97 16:14:39 INFO - PROCESS | 2890 | |8;json-parse-financial;53;51;53;53;55;53;56;54;53;54 16:14:39 INFO - PROCESS | 2890 | |9;json-stringify-tinderbox;61;61;61;62;63;62;62;62;61;63 16:14:39 INFO - PROCESS | 2890 | |10;stanford-crypto-aes;81;82;81;82;80;80;80;81;80;89 16:14:39 INFO - PROCESS | 2890 | |11;stanford-crypto-ccm;139;146;134;139;137;137;144;147;174;145 16:14:39 INFO - PROCESS | 2890 | |12;stanford-crypto-pbkdf2;167;167;164;176;165;166;165;164;165;164 16:14:39 INFO - PROCESS | 2890 | |13;stanford-crypto-sha256-iterative;69;68;71;74;67;72;70;66;66;66 16:14:39 INFO - PROCESS | 2890 | __end_tp_report 16:14:39 INFO - PROCESS | 2890 | __start_cc_report 16:14:39 INFO - PROCESS | 2890 | _x_x_mozilla_cycle_collect,817 16:14:39 INFO - PROCESS | 2890 | __end_cc_report 16:14:39 INFO - PROCESS | 2890 | __startTimestamp1476400479332__endTimestamp 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | ------- Summary: start ------- 16:14:39 INFO - PROCESS | 2890 | Number of tests: 14 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.89 (1.7%) stddev-sans-first:0.97 16:14:39 INFO - PROCESS | 2890 | Values: 106.0 111.0 113.0 111.0 110.0 111.0 110.0 111.0 112.0 112.0 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | [#1] audio-beat-detection Cycles:10 Average:137.20 Median:128.50 stddev:19.08 (14.8%) stddev-sans-first:18.84 16:14:39 INFO - PROCESS | 2890 | Values: 157.0 123.0 124.0 174.0 129.0 128.0 123.0 125.0 161.0 128.0 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | [#2] audio-dft Cycles:10 Average:166.30 Median:167.50 stddev:3.92 (2.3%) stddev-sans-first:4.07 16:14:39 INFO - PROCESS | 2890 | Values: 164.0 166.0 170.0 170.0 173.0 163.0 169.0 162.0 162.0 164.0 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.00 stddev:12.73 (16.8%) stddev-sans-first:13.21 16:14:39 INFO - PROCESS | 2890 | Values: 75.0 76.0 79.0 108.0 76.0 77.0 76.0 78.0 105.0 75.0 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:83.00 stddev:11.84 (14.3%) stddev-sans-first:12.20 16:14:39 INFO - PROCESS | 2890 | Values: 82.0 83.0 114.0 83.0 82.0 84.0 100.0 83.0 83.0 105.0 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.99 (0.8%) stddev-sans-first:1.05 16:14:39 INFO - PROCESS | 2890 | Values: 118.0 119.0 117.0 118.0 120.0 117.0 119.0 118.0 117.0 118.0 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 16:14:39 INFO - PROCESS | 2890 | Values: 146.0 147.0 148.0 147.0 148.0 148.0 148.0 147.0 147.0 148.0 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 16:14:39 INFO - PROCESS | 2890 | Values: 97.0 96.0 96.0 97.0 97.0 95.0 96.0 96.0 97.0 97.0 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.50 stddev:1.35 (2.5%) stddev-sans-first:1.42 16:14:39 INFO - PROCESS | 2890 | Values: 53.0 51.0 53.0 53.0 55.0 53.0 56.0 54.0 53.0 54.0 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 16:14:39 INFO - PROCESS | 2890 | Values: 61.0 61.0 61.0 62.0 63.0 62.0 62.0 62.0 61.0 63.0 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:81.00 stddev:2.72 (3.4%) stddev-sans-first:2.87 16:14:39 INFO - PROCESS | 2890 | Values: 81.0 82.0 81.0 82.0 80.0 80.0 80.0 81.0 80.0 89.0 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:144.50 stddev:11.36 (7.9%) stddev-sans-first:11.89 16:14:39 INFO - PROCESS | 2890 | Values: 139.0 146.0 134.0 139.0 137.0 137.0 144.0 147.0 174.0 145.0 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:165.50 stddev:3.59 (2.2%) stddev-sans-first:3.80 16:14:39 INFO - PROCESS | 2890 | Values: 167.0 167.0 164.0 176.0 165.0 166.0 165.0 164.0 165.0 164.0 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.50 stddev:2.81 (4.0%) stddev-sans-first:2.98 16:14:39 INFO - PROCESS | 2890 | Values: 69.0 68.0 71.0 74.0 67.0 72.0 70.0 66.0 66.0 66.0 16:14:39 INFO - PROCESS | 2890 | -------- Summary: end -------- 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | 16:14:39 INFO - PROCESS | 2890 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 16:14:39 INFO - PROCESS | 2890 | 16:14:40 INFO - TEST-INFO | 2890: exit 0 16:14:40 INFO - TEST-OK | kraken | took 62779ms 16:14:40 INFO - SUITE-END | took 1178s 16:14:40 INFO - Completed test suite (00:19:39) 16:14:40 INFO - javascript benchmark 16:14:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7135.591475867378, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3014.9849250753746, 3060.663327034027, 3064.126723883692, 3099.6745341739115, 3106.897051546701, 5209.7134657593815, 5321.22842187883, 5325.201219817024, 5334.493223143795, 5460.808871689492, 5259.76331065102, 5271.42014378418, 5288.8413347599535, 5367.812126575571, 5383.703896285702, 4782.665213435061, 4819.2289233722695, 4837.226043832988, 4862.5380588844, 4922.138625740481, 4766.379430993462, 4822.228443449048, 4881.292212629167, 4883.267509873512, 4885.145099607572, 4711.7879695413785, 4892.241702536113, 4950.801967921278, 4963.478919414472, 4974.427940786783, 4756.7859446325, 4789.4971028042255, 4796.44840843304, 4816.060868130716, 4824.975875120602, 4721.598664113554, 4775.856724298242, 4807.471178170398, 4881.926771098437, 4950.653454258203, 5309.230161626581, 5348.598855085846, 5358.008768377824, 5373.785048598052, 5379.246905433242, 5541.944580554183, 5566.415526369754, 5593.188987596775, 5606.55147588192, 5615.831525054214, 5613.915791263134, 5642.153676948449, 5652.095664693629, 5660.264165658438, 5692.77228910843, 5123.129068058439, 5137.2037334213255, 5325.866853328659, 5334.1732031535175, 5362.168863826113, 5740.68426236561, 5751.22358481608, 5768.048272035067, 5779.248697669276, 5846.941530584725, 5573.359063707726, 5574.804881829197, 5576.079946808813, 5578.219049333096, 5590.804321848797, 5484.369297530755, 5648.435156484319, 5649.661020338793, 5650.74571644277, 5659.717014149359, 5414.539764120015, 5536.4186760389575, 5554.333479982428, 5608.0, 5613.915791263134, 5624.690642014647, 5630.915536266877, 5642.71786410686, 5657.0, 5719.056355701346, 4322.697411181187, 4323.308270676676, 4368.453943257093, 4369.519352871182, 4372.519022907478, 3800.657940785343, 3814.7138964577766, 3852.210296889131, 3875.0312421894528, 3896.0649444133205, 5415.241866138744, 5424.996375670514, 5445.482679145475, 5489.64317319373, 5503.504684578407, 5698.344690360579, 5730.5129064030025, 5743.195952566644, 5756.481916627524, 5764.365919748824, 5219.869503262449, 5270.92093618596, 5380.596455265792, 5407.83776486706, 5503.3120859892515, 4849.2968519564465, 4894.608431325485, 4898.191798353232, 4941.45643979162, 4955.529224723646, 5915.763369465173, 5923.0, 5925.4370834770625, 5933.406659334032, 5936.614120082095, 5546.084895992278, 5693.202951586698, 5720.8283751487525, 5747.137929310469, 5749.626274292157, 5786.710664466676, 5876.970615146897, 5890.352061273342, 5977.820665380045, 5997.280326360865, 5648.5481161507805, 5651.689157096399, 5653.3781284057895, 5654.717264136859, 5655.321361436654, 5527.751251193626, 5585.860353491195, 5692.060809966475, 5711.029125048834, 5746.770129194785, 5619.2133101365025, 5625.268715067015, 5627.43725627434, 5656.0, 5678.77284908599, 5584.944150558443, 5592.3009623797025, 5592.972035139798, 5598.916016259841, 5603.411641777555, 5362.329708786402, 5363.061464243664, 5374.785008599769, 5583.35791383996, 5606.383297837153, 5411.783528658967, 5456.0451920914475, 5487.067198576172, 5527.0, 5532.391436942014, 5392.272043274108, 5437.918431223456, 5494.313210848644, 5498.615096943336, 5505.091659876076], "value": 5234.738636651829, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.9039663257247, 572.6220694341732, 580.2949416459002, 586.448738186105, 593.4658807073633, 41231.79384103079, 43094.569054309446, 43189.35215971763, 47536.762316188455, 47555.28667069997, 45310.0, 45862.31206531896, 45975.77012114935, 45982.770086149525, 46012.53987460124, 8894.599743011564, 9048.909510904905, 9052.321075919332, 9063.365564410495, 9071.909280907206, 8765.517896515688, 8936.776580585505, 8944.8658270126, 8946.329025323093, 8967.865482017742, 9008.639654413815, 9041.683541076063, 9041.864372034424, 9076.773080673003, 9082.091790820898, 8941.552922353889, 8947.910520894839, 8983.68557100505, 8989.820203595957, 9001.18989290967, 8898.911010889873, 8907.910920890772, 8944.150305720947, 8960.103989601053, 8994.775130621787, 42119.1576168478, 42540.0, 42595.36106958398, 43012.0, 43028.35457468109, 3056.2970516781265, 3271.1658527075683, 3390.0507857799857, 3506.2286297014616, 3599.1182160370613, 31130.533042004387, 31240.0, 31809.681903180903, 31829.363412731847, 31928.840355798304, 4243.745375277494, 4304.9532297084515, 4317.503487098992, 4387.868363949055, 4536.160810250114, 313297.0, 315718.0, 316454.0, 317100.0, 318214.0, 57983.0, 58172.70913645405, 58209.9401113787, 58324.70837645869, 58503.12245316324, 60397.0, 60669.0, 60686.0, 60952.0, 61010.694946524985, 14595.197264150362, 14759.114453132846, 14860.405583776528, 14872.776908346383, 14901.850981490263, 11164.609238676607, 11211.775764484664, 11301.095912326995, 11327.093832493381, 11329.980301772715, 16277.151498487718, 17061.658766824596, 17140.914295428443, 17218.65562688764, 17568.121593920252, 5861.658854453006, 5880.323762767251, 5937.287525496881, 6114.816555503253, 6163.84590385235, 886.2555453419159, 986.127277359542, 1016.4612755239734, 1018.7554986803113, 1107.7286064914147, 32291.0, 32416.513752293733, 32641.18397040093, 32667.346653066805, 32823.1794205142, 1029.984550231747, 1054.7099547624464, 1062.5431064642123, 1073.4954571351452, 1135.644802183635, 16086.597835053983, 16926.153692315336, 16939.830601694073, 17083.40208092711, 17120.571985700208, 476407.0, 479838.0, 480452.0, 482503.0, 482518.0, 57987.0, 58022.7098864503, 58213.0, 58232.708836455546, 58276.708616457494, 1281.9615411537668, 1297.0855546839455, 1336.4253371050347, 1347.2724728646422, 1357.830271216098, 29255.268618284714, 31301.0, 31339.0, 31856.68143318537, 32507.18732031718, 50815.74592127016, 51251.48748512467, 51348.0, 51500.742496287276, 51569.22646160235, 405379.0, 406638.0, 410565.0, 410649.0, 411517.0, 40132.71624927183, 40904.38643420291, 41789.0, 42183.7890810544, 42205.78897105618, 46919.29621055755, 47070.293945591526, 47866.5213347876, 48108.27837582369, 48772.75613622051, 40022.0, 41211.793941030104, 42013.57986420097, 42759.14481710286, 43787.79851454982, 38232.80883595564, 40573.0, 42680.786596068065, 43522.34716479192, 44820.55179448164, 39735.403968939914, 39909.80045099872, 40090.599094008685, 41448.792756036026, 41462.37806432966, 35682.46476302806, 37302.0, 37811.43282850814, 38254.808725956194, 38417.80791096138, 28292.43415131727, 28363.858180708965, 28379.432411351245, 28412.289692757848, 28656.713432865403], "value": 19887.93066603285, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.8323720800055, 396.1957226829537, 406.5284270246515, 409.7172950664042, 427.6514640567937, 16063.0, 16203.351865925379, 17510.82489175108, 19046.428607141792, 19084.04579771011, 12295.692607684812, 12979.675508112301, 12988.54540091097, 15647.687046259096, 17720.202590883408, 5287.735613219334, 5531.142672885689, 5537.723113844312, 5539.390667026624, 5542.8337149885565, 4355.499117601469, 5896.321922978869, 5954.374790646984, 5960.403959604048, 5981.5214782817275, 5427.45725427458, 5914.556408269375, 5917.289925208959, 5938.673372964486, 5943.435373639497, 5430.619856610039, 5458.344998600173, 5470.753816078286, 5483.561315094783, 5491.0, 5159.432462429129, 5292.761825717852, 5316.415194328621, 5321.3348331458565, 5345.518903298683, 14363.353649085817, 14446.0, 14481.42074317026, 14546.490872819506, 14577.125372477685, 2205.0056621751746, 2213.9335819925427, 2229.9777002230094, 2270.4664403865077, 2478.5910324796387, 10064.849027264598, 10232.53953572091, 10265.0, 10792.136629069655, 11020.724481887937, 1923.7018262169247, 1954.6677064898859, 1999.8200161985492, 2012.2152360579387, 2017.425033865356, 82714.58642706808, 82907.58546207291, 83326.58336708277, 85923.57038214832, 88486.5575672124, 10960.506777195045, 11124.61063862761, 11263.887361126448, 11312.321260724382, 11420.371879546705, 12241.0, 13010.54463093806, 16028.599285017968, 16053.919730401274, 16120.355185792672, 6144.631322120687, 6305.180326557518, 6872.312768723188, 7382.593957332291, 7663.233676632292, 7175.964120179366, 7236.095488063992, 7366.77899663011, 7417.666205020787, 7472.32749052577, 3999.440078389028, 4116.835326586963, 4208.915821683549, 4293.2272191005295, 4334.21984042869, 1951.9414417567496, 2020.3635854706015, 2022.7370441842465, 2088.2098990332497, 2100.7479102507796, 885.2563846369081, 933.1042199488431, 945.9858102128474, 964.8022155458115, 990.1929927109383, 18102.366417175337, 18810.529736756416, 18883.52791180204, 18969.62060758777, 19574.314898978468, 929.9628014879329, 943.7546237978175, 971.8007808399261, 981.3670182732097, 1025.3489034463169, 10307.793844123076, 10463.424511651932, 10792.730181745363, 10803.675889723321, 10827.187960902964, 434678.0, 437757.0, 447679.0, 456423.0, 457863.0, 64178.67910660417, 86701.56649216714, 87035.56482217548, 87103.56448217845, 87553.56223218843, 904.7421484876778, 923.7182659288982, 927.1516562345513, 930.1210356213313, 939.8214339275515, 15735.921320393325, 15755.291011904263, 16095.195240237706, 16578.58553536171, 17115.657686845945, 30614.693853061184, 39216.0, 41134.0, 41574.37638435365, 42642.36036459394, 55661.721691391285, 57317.42682573121, 57592.4240757587, 58044.0, 58820.0, 5511.586631002771, 6892.414144797748, 7215.206327304098, 7962.761117166494, 8209.302209312274, 10300.742481438025, 12552.49790008426, 12585.87414125847, 12836.614901552968, 12938.870611294144, 10613.840792388275, 10829.891701083203, 11016.724581885517, 11024.944875275572, 11091.944540277247, 10720.678379648623, 11088.501017454073, 11090.16823738239, 11147.55409783632, 11523.654290371302, 11244.943775281072, 11542.249753765978, 11544.365059921785, 11568.826467602825, 11665.416729163677, 8257.876131857907, 8406.327493800603, 8419.031811341774, 8490.320774337915, 8502.914970850212, 11121.666350009513, 11176.441177941233, 11250.606228781953, 11305.660830175108, 11707.88292117068], "value": 8670.022240146214, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1455.9781603275953, 1488.2112480385395, 1630.8206097329298, 1747.1962897067365, 1787.7229029500425, 8040.517568945867, 8280.296174825133, 8610.095939926312, 9362.95318523408, 9367.578458969345, 8556.5293908835, 8921.241694455963, 8951.865722014176, 9195.448273103619, 9237.44575325481, 2385.558671645751, 2394.5330660521204, 2401.759824017593, 2417.770311820383, 2425.842320249187, 2336.427575244059, 2381.9761802382013, 2401.399650087478, 2403.098837935774, 2403.3030421177837, 2345.1323010486144, 2345.519168570439, 2383.618621020637, 2424.9030038798514, 2429.4047958250167, 2336.661184128309, 2351.529694061186, 2355.0697474497647, 2364.1441468447274, 2365.3731761083327, 2266.648669456237, 2271.886405679726, 2313.4910319729634, 2318.8724620145886, 2324.6629238760283, 9103.635854565875, 9263.258939284908, 9270.536473176315, 9277.814443711088, 9294.07059294072, 5351.812686555991, 5463.617546771728, 5482.068048431776, 5494.780208791643, 5497.615166938316, 3594.4428613564937, 3599.766015209003, 3633.94549081764, 3637.1089083174793, 3677.797721125337, 1161.4425075963584, 1187.1808452167977, 1198.3708553009653, 1199.5261871560772, 1208.299186471853, 12889.935550322281, 12927.288999105045, 12937.02972277083, 12940.094193406465, 12957.157784743962, 4445.177642136216, 4697.882552936204, 4782.952170478251, 4882.462929077798, 4896.143174944371, 10687.946560267304, 10696.358218506915, 10709.518071686793, 10733.463326833627, 10790.51442685081, 5455.372632147274, 5475.534579560703, 5500.257465242141, 5501.807436739695, 5505.834824955257, 4393.560643935645, 4524.705894116872, 4853.417589889165, 4976.0794253063295, 5043.84868453947, 3933.0, 3966.504186976628, 4006.338954072545, 4081.8979525511504, 4086.244044851712, 1282.0704988883172, 1301.1087405127519, 1315.6447759105179, 1318.3408295852073, 1323.5235315286488, 680.8331958670059, 728.9453291003196, 743.0043741386568, 849.7960489482604, 857.6440777077568, 5582.469665381782, 5611.831645050655, 5645.2096706461125, 5753.942460575425, 5780.335261444988, 447.8925057986125, 447.9014616784302, 452.7736131934033, 457.9038401935631, 477.61551950680035, 4080.4083407905687, 4110.403991421227, 4129.648979836687, 4134.0, 4144.461220041375, 11072.062389081879, 11292.096632269398, 11375.943120284512, 11438.828417573743, 11486.425678716198, 11299.830502542469, 11314.830277545843, 11320.207585468937, 11347.148963827745, 11363.318200907972, 7879.172686867911, 8246.175382461706, 8399.53802540854, 8445.408821382443, 8466.57667116654, 6013.188219590299, 6139.3553676863285, 6189.9690501549, 6236.095766113979, 6257.2804127525915, 10367.688969330931, 10594.20543459259, 10613.257072005194, 10654.62708805188, 10655.946720266658, 9932.304738668512, 10471.3193642413, 10477.9476102619, 10605.89394106049, 10785.946070269598, 6573.1454910861285, 6775.559588626724, 7628.961855190911, 7877.842443151219, 8066.072401673648, 8236.629351679068, 8589.098144694717, 8629.266512346521, 8629.39594228398, 8682.826343473222, 7600.695972161052, 7880.05439347282, 7889.881651775343, 8044.2760151586635, 8164.224398682116, 7619.276168763959, 7635.465517413728, 7748.883766743391, 7762.184970578008, 7824.84350313002, 6866.622335771581, 7010.123734533184, 7013.684384202621, 7023.894641580278, 7043.718251269892, 5071.239314102914, 5168.508991645787, 5215.4002289735645, 5262.0, 5437.972810135924, 5087.796488140433, 5098.872528186825, 5161.845144645667, 5217.452167522356, 5424.945750542444], "value": 4615.348784079644, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.641369872592, 332.3038234897889, 332.70389353475395, 335.4649334311772, 342.1890120414617, 5162.354705661793, 5316.059638232046, 5434.918476222855, 5493.862653433666, 5494.478024587668, 5129.717865517395, 5292.708901010443, 5321.893562128756, 5333.706646134461, 5339.733013349327, 4198.9370159447635, 4213.894652633678, 4253.723507971972, 4260.190563792885, 4277.786110694468, 4158.378232489332, 4163.250614889319, 4176.958230417687, 4261.275583150872, 4273.401723758676, 4149.522804877448, 4161.521425036114, 4178.268802959486, 4197.16056788642, 4218.869470917182, 4185.4977402711565, 4214.220369231702, 4216.241076606225, 4228.238916994939, 4231.597998190167, 3737.5141231639986, 3748.850045998157, 3755.830987605564, 3756.323861704892, 3766.886993390203, 5089.312942752755, 5218.295530103425, 5258.973705131488, 5283.788648454057, 5337.838175538875, 4786.401699787527, 4826.420829500447, 4842.18418093215, 4854.368932038848, 4860.586850117745, 5449.891002179934, 5616.466435688603, 5645.491905728463, 5673.943260567383, 5677.829665110054, 4059.0664147246002, 4083.0, 4085.1829634073306, 4094.7747873866924, 4099.262132816092, 5871.970640146772, 5901.380355062743, 5937.614055086406, 5938.257717785277, 5943.851403714899, 4219.240536703423, 4222.0, 4229.746215227096, 4235.305877648965, 4241.957580424156, 3927.6072392761066, 4136.407483119021, 4166.7708276045105, 4172.102997855475, 4201.579842015774, 4768.737719425465, 4807.78364973577, 4811.639127065484, 4812.123271923952, 4820.638452116105, 5723.914141287884, 5731.681713205986, 5736.856578585485, 5744.770209191585, 5749.511291540182, 1385.9328317195702, 1426.9369319856773, 1435.5429239322095, 1440.5030264558711, 1440.9481078812526, 880.3705350674298, 908.3377419322624, 916.8899732032199, 919.4599046596924, 937.016133060284, 4730.810767569327, 4789.784459699322, 4797.280407938837, 4851.0, 4882.877928051827, 5045.0, 5046.596272298208, 5051.4695956924, 5057.317262169634, 5066.620003499752, 4782.33047373368, 4785.59322457595, 4806.8798280043275, 4834.661573689808, 5100.821471248489, 3030.9696903031127, 3077.661457239702, 3078.0, 3081.1372815611667, 3085.6760040195904, 6039.365866583946, 6045.486133678686, 6076.270847498328, 6102.291358419649, 6111.0, 5630.18362337467, 5930.110483427434, 5966.791162309385, 5970.641761494324, 5997.0, 5993.400659934059, 6023.367546407651, 6040.607360521552, 6089.1779609753, 6090.33006369299, 5597.5521958242425, 5801.76792928295, 5822.94177058224, 5840.620359676607, 5868.295804503487, 5785.566082543742, 5792.333881603669, 5799.391063938395, 5835.79574714883, 5839.737211825393, 6112.816615501542, 6123.785667501616, 6124.54065945047, 6143.784967526115, 6148.385161483816, 4080.551139374607, 4137.193247316744, 4148.23257697327, 4183.560726123835, 4197.160567886496, 5818.592698511064, 5836.795712150054, 5838.591298609056, 5843.561732869966, 5867.32525759526, 5558.8592445269915, 5733.824565964051, 5761.222234998221, 5779.335376431764, 5788.681622510802, 5689.0, 5705.144228365778, 5725.971370143123, 5728.4271572844045, 5740.225069615715, 5644.463775941279, 5673.489385955284, 5675.545956323567, 5689.914651280317, 5709.486146246858, 5421.674699518042, 5681.375048744718, 5705.600607957404, 5724.652892314131, 5736.110902810071, 5589.552835773047, 5615.578831587729, 5628.943710562842, 5630.211770352236, 5631.493165615114], "value": 4284.002423743047, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.6064173741833, 707.1266985273187, 710.9608971506567, 757.7158565537924, 798.1738900238255, 13960.930195349034, 15330.15684137372, 15373.461928832494, 15489.225538723074, 15612.375504979802, 14802.925985370084, 14957.775633365482, 14982.62543436412, 15011.774823377631, 15053.924730376333, 654.8722999015171, 669.6250099944023, 783.2050468774198, 787.3347021766626, 795.9005124359455, 800.8118092248346, 816.6080281464871, 817.0726225733775, 817.2318021060214, 817.3461231015194, 864.2912811494577, 864.4121997042009, 866.3502373220085, 870.6560908441162, 870.6778491957984, 864.8529749942525, 865.7748985263845, 866.4584634603373, 866.653338664533, 867.444835305405, 629.2669040567733, 630.5082036011918, 630.8328293002359, 631.4001698386551, 631.4979591224987, 15151.469698560608, 15250.923745381313, 15282.465113720966, 15314.004589701744, 15345.923270383688, 14379.496717614833, 14424.0, 14435.639109022359, 14725.926370368186, 14753.0, 11758.544845162898, 11781.646550603497, 11983.28100313984, 12286.262824230575, 12801.807972880415, 3598.604153543108, 3600.9099772505633, 3640.581333146669, 3654.634536546351, 3759.586445490994, 75882.62058689726, 78452.21547784506, 79539.20460795375, 79703.0, 80093.19906800915, 11497.54009839597, 11543.76912461763, 11706.35615041181, 11800.52797888092, 12328.938355308166, 22066.88966555157, 22082.558348832932, 22153.446163846034, 22202.0, 22228.222012229493, 8258.380621453294, 8295.917040829514, 8563.614637341334, 8587.0, 8671.869921951176, 4547.886302842389, 4797.544233297901, 4806.975965120152, 4879.878003049881, 4958.553730164303, 3362.193073662352, 3560.092176495029, 3613.0, 3613.1509095362567, 3622.8550857965915, 607.1014897950969, 608.9391060893964, 628.5286035473395, 641.1920979565781, 648.7307767276621, 671.2113266911359, 693.4313862632694, 694.6804469943781, 695.7425752471618, 722.6025685872748, 8794.20852123312, 9954.900450995543, 9998.350107243006, 10173.898261017295, 10420.739481513023, 572.6163470474792, 594.7442599682179, 625.978090766821, 656.212544946057, 670.6981858163846, 4533.206688829508, 4846.345743324677, 4902.583280421204, 4906.828261010919, 4952.579030782424, 122186.0, 127051.0, 127135.0, 128323.0, 129546.0, 67983.0, 69322.65338673274, 99918.5004074975, 102603.48698256462, 103360.0, 94102.52948735212, 96133.5193324029, 96663.51668241614, 96937.69904956296, 97684.0, 8307.6676932922, 8637.69768058115, 8734.126587341216, 8858.73423797287, 9123.589438475152, 48131.63078584606, 49673.75163124306, 49806.75096624494, 50572.747136264086, 50627.0, 73362.0, 75103.0, 76979.0, 77756.0, 79142.6042869782, 11319.943400282946, 11432.314061156358, 11453.427328633368, 11525.308481491138, 11740.178187526792, 12422.0, 12811.679708007374, 12849.935750321189, 12932.676683082622, 12986.935065324613, 11932.917759082975, 12546.247225166155, 12546.87453125457, 12658.367081646065, 12767.170133941265, 11737.0, 12126.636200913987, 12286.447109880255, 12347.365555473203, 12839.293838838954, 11778.293302401884, 12176.884223036404, 12266.080043996557, 12495.812562811747, 12773.425195866394, 9857.852132217879, 10428.791424171322, 10490.160787136858, 10716.491661519469, 10751.731206719895, 9182.449053056838, 10334.896651033694, 10427.322224055411, 10428.739281517719, 10504.0], "value": 7395.659769900634, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 111.0, 113.0, 111.0, 110.0, 111.0, 110.0, 111.0, 112.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 123.0, 124.0, 174.0, 129.0, 128.0, 123.0, 125.0, 161.0, 128.0], "value": 137.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 170.0, 170.0, 173.0, 163.0, 169.0, 162.0, 162.0, 164.0], "value": 166.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 79.0, 108.0, 76.0, 77.0, 76.0, 78.0, 105.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 114.0, 83.0, 82.0, 84.0, 100.0, 83.0, 83.0, 105.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 118.0, 120.0, 117.0, 119.0, 118.0, 117.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 147.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 97.0, 97.0, 95.0, 96.0, 96.0, 97.0, 97.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 53.0, 53.0, 55.0, 53.0, 56.0, 54.0, 53.0, 54.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 63.0, 62.0, 62.0, 62.0, 61.0, 63.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 81.0, 82.0, 80.0, 80.0, 80.0, 81.0, 80.0, 89.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 146.0, 134.0, 139.0, 137.0, 137.0, 144.0, 147.0, 174.0, 145.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 164.0, 176.0, 165.0, 166.0, 165.0, 164.0, 165.0, 164.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 71.0, 74.0, 67.0, 72.0, 70.0, 66.0, 66.0, 66.0], "value": 68.9, "unit": "score"}]}]} 16:14:40 INFO - Return code: 0 16:14:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:14:40 ERROR - # TBPL SUCCESS # 16:14:40 INFO - Running post-action listener: _resource_record_post_action 16:14:40 INFO - [mozharness: 2016-10-13 23:14:40.644552Z] Finished run-tests step (success) 16:14:40 INFO - Running post-run listener: _resource_record_post_run 16:14:40 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400093184; Read time: 12; Write time: 438632 16:14:40 INFO - TinderboxPrint: CPU usage
13.4% 16:14:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:14:40 INFO - TinderboxPrint: I/O write bytes / time
400,093,184 / 438,632 16:14:40 INFO - TinderboxPrint: CPU idle
8,257.8 (86.6%) 16:14:40 INFO - TinderboxPrint: CPU user
1,215.8 (12.7%) 16:14:40 INFO - TinderboxPrint: Swap in / out
0 / 0 16:14:40 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110387200; Read time: 0; Write time: 155828 16:14:40 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 289091584; Read time: 0; Write time: 282796 16:14:41 INFO - Running post-run listener: _upload_blobber_files 16:14:41 INFO - Blob upload gear active. 16:14:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:14:41 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 16:14:41 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:14:41 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:14:41 INFO - (blobuploader) - INFO - Open directory for files ... 16:14:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:14:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:14:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:44 INFO - (blobuploader) - INFO - Done attempting. 16:14:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:14:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:14:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:45 INFO - (blobuploader) - INFO - Done attempting. 16:14:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:14:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:14:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:46 INFO - (blobuploader) - INFO - Done attempting. 16:14:46 INFO - (blobuploader) - INFO - Iteration through files over. 16:14:46 INFO - Return code: 0 16:14:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:14:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:14:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28ee52aa37e429f31ac1e7b9851d2ca16d6fc1bb30e74583565bec07c6d9049dacda355e795b034b4f15eedd7b21a18c53603d8af3390a21b54c4830a09e5975", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81e3a558334c0f6477dfad7c47712f42e004e52ff292d08ecb8de5290ef6aeafe1f856ba8e013f80b4c081027cfdcfca93e8cb9f924cff0fe030d026deebd1aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63c6a2f67b989e471e4be47190b8b9f89d091275d7ef7f065d4131412ad38b0a351752794ffad283f1fa701c9b7aa8f848d86956775f7ad14116502cdca5e6e4"} 16:14:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:14:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:14:46 INFO - Contents: 16:14:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28ee52aa37e429f31ac1e7b9851d2ca16d6fc1bb30e74583565bec07c6d9049dacda355e795b034b4f15eedd7b21a18c53603d8af3390a21b54c4830a09e5975", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81e3a558334c0f6477dfad7c47712f42e004e52ff292d08ecb8de5290ef6aeafe1f856ba8e013f80b4c081027cfdcfca93e8cb9f924cff0fe030d026deebd1aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63c6a2f67b989e471e4be47190b8b9f89d091275d7ef7f065d4131412ad38b0a351752794ffad283f1fa701c9b7aa8f848d86956775f7ad14116502cdca5e6e4"} 16:14:46 INFO - Running post-run listener: copy_logs_to_upload_dir 16:14:46 INFO - Copying logs to upload dir... 16:14:46 INFO - mkdir: /builds/slave/test/build/upload/logs 16:14:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.614184 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-13 16:14:46.311930) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 16:14:46.315575) ========= 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=5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28ee52aa37e429f31ac1e7b9851d2ca16d6fc1bb30e74583565bec07c6d9049dacda355e795b034b4f15eedd7b21a18c53603d8af3390a21b54c4830a09e5975", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81e3a558334c0f6477dfad7c47712f42e004e52ff292d08ecb8de5290ef6aeafe1f856ba8e013f80b4c081027cfdcfca93e8cb9f924cff0fe030d026deebd1aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63c6a2f67b989e471e4be47190b8b9f89d091275d7ef7f065d4131412ad38b0a351752794ffad283f1fa701c9b7aa8f848d86956775f7ad14116502cdca5e6e4"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011589 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28ee52aa37e429f31ac1e7b9851d2ca16d6fc1bb30e74583565bec07c6d9049dacda355e795b034b4f15eedd7b21a18c53603d8af3390a21b54c4830a09e5975", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81e3a558334c0f6477dfad7c47712f42e004e52ff292d08ecb8de5290ef6aeafe1f856ba8e013f80b4c081027cfdcfca93e8cb9f924cff0fe030d026deebd1aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63c6a2f67b989e471e4be47190b8b9f89d091275d7ef7f065d4131412ad38b0a351752794ffad283f1fa701c9b7aa8f848d86956775f7ad14116502cdca5e6e4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 16:14:46.340393) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 16:14:46.340713) ========= 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=5bd038846534b2fdfa68eeae000001e2-1476399248.192675-1350549632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 16:14:46.425194) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 16:14:46.425559) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 16:14:46.425973) ========= ========= Total master_lag: 0.16 =========