builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1476753726.71 results: success (0) buildid: 20161017182151 builduid: c933546eba9b46e8af8c952895cc0d84 revision: 7ef1bb3238671037ae8ef82e05ba665ddb14f592 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:06.714175) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:06.714643) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:06.715145) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:06.734261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:06.734529) ========= 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=3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-17 18:22:07-- 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% 101M=0s 2016-10-17 18:22:07 (101 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119783 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:06.869804) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:06.870331) ========= 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=3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021316 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:06.934911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 18:22:06.935332) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 7ef1bb3238671037ae8ef82e05ba665ddb14f592 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 7ef1bb3238671037ae8ef82e05ba665ddb14f592 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-17 18:22:07,693 truncating revision to first 12 chars 2016-10-17 18:22:07,693 Setting DEBUG logging. 2016-10-17 18:22:07,693 attempt 1/10 2016-10-17 18:22:07,693 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/7ef1bb323867?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 18:22:08,800 unpacking tar archive at: autoland-7ef1bb323867/testing/mozharness/ program finished with exit code 0 elapsedTime=1.447337 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 18:22:08.396730) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:08.397095) ========= script_repo_revision: 7ef1bb3238671037ae8ef82e05ba665ddb14f592 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:08.397623) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:08.398056) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 18:22:08.407997) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-17 18:22:08.408415) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:22:09 INFO - MultiFileLogger online at 20161017 18:22:09 in /builds/slave/test 18:22:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 18:22:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:22:09 INFO - {'append_to_log': False, 18:22:09 INFO - 'base_work_dir': '/builds/slave/test', 18:22:09 INFO - 'blob_upload_branch': 'Autoland', 18:22:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:22:09 INFO - 'branch': 'Autoland', 18:22:09 INFO - 'buildbot_json_path': 'buildprops.json', 18:22:09 INFO - 'config_files': ('talos/linux_config.py',), 18:22:09 INFO - 'default_actions': ('clobber', 18:22:09 INFO - 'read-buildbot-config', 18:22:09 INFO - 'download-and-extract', 18:22:09 INFO - 'populate-webroot', 18:22:09 INFO - 'create-virtualenv', 18:22:09 INFO - 'install', 18:22:09 INFO - 'run-tests'), 18:22:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:22:09 INFO - 'download_minidump_stackwalk': True, 18:22:09 INFO - 'download_symbols': 'ondemand', 18:22:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:22:09 INFO - 'tooltool.py': '/tools/tooltool.py', 18:22:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:22:09 INFO - '/tools/misc-python/virtualenv.py')}, 18:22:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:22:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:22:09 INFO - 'installer_path': 'installer.exe', 18:22:09 INFO - 'log_level': 'info', 18:22:09 INFO - 'log_name': 'talos', 18:22:09 INFO - 'log_to_console': True, 18:22:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:22:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:22:09 INFO - 'opt_config_files': (), 18:22:09 INFO - 'pip_index': False, 18:22:09 INFO - 'sps_profile': False, 18:22:09 INFO - 'sps_profile_interval': 0, 18:22:09 INFO - 'suite': 'dromaeojs', 18:22:09 INFO - 'system_bits': '32', 18:22:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:22:09 INFO - 'title': 'talos-linux64-ix-059', 18:22:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:22:09 INFO - 'use_talos_json': True, 18:22:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:22:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:22:09 INFO - 'work_dir': 'build'} 18:22:09 INFO - [mozharness: 2016-10-18 01:22:09.274584Z] Running clobber step. 18:22:09 INFO - Running pre-action listener: _resource_record_pre_action 18:22:09 INFO - Running main action method: clobber 18:22:09 INFO - rmtree: /builds/slave/test/build 18:22:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:22:09 INFO - Running post-action listener: _resource_record_post_action 18:22:09 INFO - [mozharness: 2016-10-18 01:22:09.747951Z] Finished clobber step (success) 18:22:09 INFO - [mozharness: 2016-10-18 01:22:09.748053Z] Running read-buildbot-config step. 18:22:09 INFO - Running pre-action listener: _resource_record_pre_action 18:22:09 INFO - Running main action method: read_buildbot_config 18:22:09 INFO - Using buildbot properties: 18:22:09 INFO - { 18:22:09 INFO - "project": "", 18:22:09 INFO - "product": "firefox", 18:22:09 INFO - "script_repo_revision": "production", 18:22:09 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 18:22:09 INFO - "repository": "", 18:22:09 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 18:22:09 INFO - "buildid": "20161017182151", 18:22:09 INFO - "stage_platform": "linux64-pgo", 18:22:09 INFO - "basedir": "/builds/slave/test", 18:22:09 INFO - "buildnumber": 366, 18:22:09 INFO - "platform": "ubuntu64_hw", 18:22:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:22:09 INFO - "slavebuilddir": "test", 18:22:09 INFO - "branch": "autoland", 18:22:09 INFO - "revision": "7ef1bb3238671037ae8ef82e05ba665ddb14f592", 18:22:09 INFO - "slavename": "talos-linux64-ix-059", 18:22:09 INFO - "builduid": "c933546eba9b46e8af8c952895cc0d84", 18:22:09 INFO - "repo_path": "integration/autoland" 18:22:09 INFO - } 18:22:09 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:22:09 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 18:22:09 INFO - Running post-action listener: _resource_record_post_action 18:22:09 INFO - [mozharness: 2016-10-18 01:22:09.750419Z] Finished read-buildbot-config step (success) 18:22:09 INFO - [mozharness: 2016-10-18 01:22:09.750507Z] Running download-and-extract step. 18:22:09 INFO - Running pre-action listener: _resource_record_pre_action 18:22:09 INFO - Running main action method: download_and_extract 18:22:09 INFO - mkdir: /builds/slave/test/build/tests 18:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:09 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:22:09 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:22:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:22:09 INFO - Downloaded 1361 bytes. 18:22:09 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:22:09 INFO - Using the following test package requirements: 18:22:09 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:22:09 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:22:09 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:22:09 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:09 INFO - u'jsshell-linux-x86_64.zip'], 18:22:09 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:22:09 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:22:09 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:22:09 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:22:09 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:22:09 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:22:09 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:22:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:22:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:22:09 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:22:09 INFO - Http code: 200 18:22:09 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 18:22:09 INFO - x-amz-cf-id: hof9y_YRuxDVdA4QB5OkIiYAtvFf4GHD_6IinzlUyMpRttPeoCg7eg== 18:22:09 INFO - x-amz-replication-status: COMPLETED 18:22:09 INFO - x-amz-version-id: tifiHnfUmAIdxiPUpTamnPt7_1o0nAer 18:22:10 INFO - Expected file size: 22090271 18:22:10 INFO - Obtained file size: 22090271 18:22:14 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:22:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:22:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:22:14 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:22:14 INFO - Http code: 200 18:22:14 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 18:22:14 INFO - x-amz-cf-id: HMG9u3iu9lH3wxuiH2ujtszsRDmcvYAQSK002nVdVIfFmuIXWXAJmw== 18:22:14 INFO - x-amz-replication-status: COMPLETED 18:22:14 INFO - x-amz-version-id: tifiHnfUmAIdxiPUpTamnPt7_1o0nAer 18:22:15 INFO - Expected file size: 22090271 18:22:15 INFO - Obtained file size: 22090271 18:22:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:22:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:22:20 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:22:20 INFO - Http code: 200 18:22:20 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 18:22:20 INFO - x-amz-cf-id: vpQZm6udQgvWuuybYrCoe_unnQB5WdjivE5Ge-N0VdvYYtPTblR1PQ== 18:22:20 INFO - x-amz-replication-status: COMPLETED 18:22:20 INFO - x-amz-version-id: MdTEavWu7nDdrXSW3WO0r.sLDrQYoWvd 18:22:21 INFO - Expected file size: 14409028 18:22:21 INFO - Obtained file size: 14409028 18:22:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:21 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:22:21 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:22:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:22:23 INFO - Downloaded 59508353 bytes. 18:22:23 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:22:23 INFO - mkdir: /builds/slave/test/properties 18:22:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:22:23 INFO - Writing to file /builds/slave/test/properties/build_url 18:22:23 INFO - Contents: 18:22:23 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:22:23 INFO - Running post-action listener: _resource_record_post_action 18:22:23 INFO - Running post-action listener: set_extra_try_arguments 18:22:23 INFO - [mozharness: 2016-10-18 01:22:23.508914Z] Finished download-and-extract step (success) 18:22:23 INFO - [mozharness: 2016-10-18 01:22:23.509141Z] Running populate-webroot step. 18:22:23 INFO - Running pre-action listener: _resource_record_pre_action 18:22:23 INFO - Running main action method: populate_webroot 18:22:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:22:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:22:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:22:23 INFO - '--tppagecycles', 18:22:23 INFO - '7'], 18:22:23 INFO - 'tests': ['tsvgm']}}, 18:22:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:22:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:22:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:22:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:22:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:23 INFO - 'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:22:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:22:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:23 INFO - 'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['damp', 'tps']}, 18:22:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:23 INFO - 'tests': ['damp', 'tps']}, 18:22:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['dromaeo_dom']}, 18:22:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:22:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['basic_compositor_video']}, 18:22:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:22:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['a11yr', 18:22:23 INFO - 'ts_paint', 18:22:23 INFO - 'tpaint', 18:22:23 INFO - 'sessionrestore', 18:22:23 INFO - 'sessionrestore_no_auto_restore', 18:22:23 INFO - 'tabpaint']}, 18:22:23 INFO - 'other-e10s': {'tests': ['a11yr', 18:22:23 INFO - 'ts_paint', 18:22:23 INFO - 'tpaint', 18:22:23 INFO - 'sessionrestore', 18:22:23 INFO - 'sessionrestore_no_auto_restore', 18:22:23 INFO - 'tabpaint']}, 18:22:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:22:23 INFO - 'ts_paint', 18:22:23 INFO - 'tpaint', 18:22:23 INFO - 'sessionrestore', 18:22:23 INFO - 'sessionrestore_no_auto_restore', 18:22:23 INFO - 'tabpaint']}, 18:22:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:22:23 INFO - 'ts_paint', 18:22:23 INFO - 'tpaint', 18:22:23 INFO - 'sessionrestore', 18:22:23 INFO - 'sessionrestore_no_auto_restore', 18:22:23 INFO - 'tabpaint']}, 18:22:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['a11yr', 18:22:23 INFO - 'ts_paint', 18:22:23 INFO - 'tpaint', 18:22:23 INFO - 'sessionrestore', 18:22:23 INFO - 'sessionrestore_no_auto_restore', 18:22:23 INFO - 'tabpaint']}, 18:22:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['a11yr', 18:22:23 INFO - 'ts_paint', 18:22:23 INFO - 'tpaint', 18:22:23 INFO - 'sessionrestore', 18:22:23 INFO - 'sessionrestore_no_auto_restore', 18:22:23 INFO - 'tabpaint']}, 18:22:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['tsvgx', 18:22:23 INFO - 'tsvgr_opacity', 18:22:23 INFO - 'tart', 18:22:23 INFO - 'tscrollx', 18:22:23 INFO - 'cart']}, 18:22:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:22:23 INFO - 'tsvgr_opacity', 18:22:23 INFO - 'tart', 18:22:23 INFO - 'tscrollx', 18:22:23 INFO - 'cart']}, 18:22:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:23 INFO - 'talos_options': ['--disable-e10s'], 18:22:23 INFO - 'tests': ['tp5o']}, 18:22:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:23 INFO - 'tests': ['tp5o']}, 18:22:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:23 INFO - 'talos_options': ['--disable-e10s', 18:22:23 INFO - '--xperf_path', 18:22:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:22:23 INFO - 'tests': ['tp5n']}, 18:22:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:23 INFO - 'talos_options': ['--xperf_path', 18:22:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:22:23 INFO - 'tests': ['tp5n']}}, 18:22:23 INFO - 'talos.zip': {'path': '', 18:22:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:22:23 INFO - Running post-action listener: _resource_record_post_action 18:22:23 INFO - [mozharness: 2016-10-18 01:22:23.531423Z] Finished populate-webroot step (success) 18:22:23 INFO - [mozharness: 2016-10-18 01:22:23.531518Z] Running create-virtualenv step. 18:22:23 INFO - Running pre-action listener: _resource_record_pre_action 18:22:23 INFO - Running main action method: create_virtualenv 18:22:23 INFO - Creating virtualenv /builds/slave/test/build/venv 18:22:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:22:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:22:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:22:23 INFO - Using real prefix '/usr' 18:22:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:22:24 INFO - Installing distribute.............................................................................................................................................................................................done. 18:22:26 INFO - Installing pip.................done. 18:22:26 INFO - Return code: 0 18:22:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:22:26 INFO - Reading from file tmpfile_stdout 18:22:26 INFO - Output received: 18:22:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:22:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9284c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2842790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283f930>, '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 0x2840830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2840cc0>, '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': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:22:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:22:26 INFO - Using env: {'DISPLAY': ':0', 18:22:26 INFO - 'HOME': '/home/cltbld', 18:22:26 INFO - 'LANG': 'en_US.UTF-8', 18:22:26 INFO - 'LANGUAGE': 'en_US:en', 18:22:26 INFO - 'LOGNAME': 'cltbld', 18:22:26 INFO - 'MAIL': '/var/mail/cltbld', 18:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:26 INFO - 'MOZ_NO_REMOTE': '1', 18:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:26 INFO - 'NO_EM_RESTART': '1', 18:22:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:26 INFO - 'PWD': '/builds/slave/test', 18:22:26 INFO - 'SHELL': '/bin/bash', 18:22:26 INFO - 'SHLVL': '1', 18:22:26 INFO - 'TERM': 'linux', 18:22:26 INFO - 'TMOUT': '86400', 18:22:26 INFO - 'USER': 'cltbld', 18:22:26 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 18:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:26 INFO - '_': '/tools/buildbot/bin/python'} 18:22:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:22:26 INFO - Cleaning up... 18:22:26 INFO - Return code: 0 18:22:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9284c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2842790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283f930>, '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 0x2840830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2840cc0>, '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': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:22:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:22:26 INFO - Using env: {'DISPLAY': ':0', 18:22:26 INFO - 'HOME': '/home/cltbld', 18:22:26 INFO - 'LANG': 'en_US.UTF-8', 18:22:26 INFO - 'LANGUAGE': 'en_US:en', 18:22:26 INFO - 'LOGNAME': 'cltbld', 18:22:26 INFO - 'MAIL': '/var/mail/cltbld', 18:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:26 INFO - 'MOZ_NO_REMOTE': '1', 18:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:26 INFO - 'NO_EM_RESTART': '1', 18:22:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:26 INFO - 'PWD': '/builds/slave/test', 18:22:26 INFO - 'SHELL': '/bin/bash', 18:22:26 INFO - 'SHLVL': '1', 18:22:26 INFO - 'TERM': 'linux', 18:22:26 INFO - 'TMOUT': '86400', 18:22:26 INFO - 'USER': 'cltbld', 18:22:26 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 18:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:26 INFO - '_': '/tools/buildbot/bin/python'} 18:22:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:26 INFO - Downloading/unpacking psutil>=3.1.1 18:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:22:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:22:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:22:28 INFO - Installing collected packages: psutil 18:22:28 INFO - Running setup.py install for psutil 18:22:28 INFO - building 'psutil._psutil_linux' extension 18:22:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:22:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:22:29 INFO - building 'psutil._psutil_posix' extension 18:22:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:22:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:22:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:22:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:22:29 INFO - Successfully installed psutil 18:22:29 INFO - Cleaning up... 18:22:29 INFO - Return code: 0 18:22:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9284c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2842790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283f930>, '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 0x2840830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2840cc0>, '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': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:22:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:22:29 INFO - Using env: {'DISPLAY': ':0', 18:22:29 INFO - 'HOME': '/home/cltbld', 18:22:29 INFO - 'LANG': 'en_US.UTF-8', 18:22:29 INFO - 'LANGUAGE': 'en_US:en', 18:22:29 INFO - 'LOGNAME': 'cltbld', 18:22:29 INFO - 'MAIL': '/var/mail/cltbld', 18:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:29 INFO - 'MOZ_NO_REMOTE': '1', 18:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:29 INFO - 'NO_EM_RESTART': '1', 18:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:29 INFO - 'PWD': '/builds/slave/test', 18:22:29 INFO - 'SHELL': '/bin/bash', 18:22:29 INFO - 'SHLVL': '1', 18:22:29 INFO - 'TERM': 'linux', 18:22:29 INFO - 'TMOUT': '86400', 18:22:29 INFO - 'USER': 'cltbld', 18:22:29 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 18:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:29 INFO - '_': '/tools/buildbot/bin/python'} 18:22:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:22:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:22:31 INFO - Installing collected packages: mozsystemmonitor 18:22:31 INFO - Running setup.py install for mozsystemmonitor 18:22:31 INFO - Successfully installed mozsystemmonitor 18:22:31 INFO - Cleaning up... 18:22:31 INFO - Return code: 0 18:22:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9284c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2842790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283f930>, '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 0x2840830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2840cc0>, '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': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:22:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:22:31 INFO - Using env: {'DISPLAY': ':0', 18:22:31 INFO - 'HOME': '/home/cltbld', 18:22:31 INFO - 'LANG': 'en_US.UTF-8', 18:22:31 INFO - 'LANGUAGE': 'en_US:en', 18:22:31 INFO - 'LOGNAME': 'cltbld', 18:22:31 INFO - 'MAIL': '/var/mail/cltbld', 18:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:31 INFO - 'MOZ_NO_REMOTE': '1', 18:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:31 INFO - 'NO_EM_RESTART': '1', 18:22:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:31 INFO - 'PWD': '/builds/slave/test', 18:22:31 INFO - 'SHELL': '/bin/bash', 18:22:31 INFO - 'SHLVL': '1', 18:22:31 INFO - 'TERM': 'linux', 18:22:31 INFO - 'TMOUT': '86400', 18:22:31 INFO - 'USER': 'cltbld', 18:22:31 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 18:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:31 INFO - '_': '/tools/buildbot/bin/python'} 18:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:31 INFO - Downloading/unpacking jsonschema==2.5.1 18:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:22:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:33 INFO - Downloading functools32-3.2.3-2.tar.gz 18:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:22:34 INFO - warning: no files found matching '*.txt' 18:22:34 INFO - no previously-included directories found matching 'build' 18:22:34 INFO - no previously-included directories found matching 'dist' 18:22:34 INFO - no previously-included directories found matching '.git*' 18:22:34 INFO - Installing collected packages: jsonschema, functools32 18:22:34 INFO - Running setup.py install for functools32 18:22:34 INFO - warning: no files found matching '*.txt' 18:22:34 INFO - no previously-included directories found matching 'build' 18:22:34 INFO - no previously-included directories found matching 'dist' 18:22:34 INFO - no previously-included directories found matching '.git*' 18:22:34 INFO - Successfully installed jsonschema functools32 18:22:34 INFO - Cleaning up... 18:22:34 INFO - Return code: 0 18:22:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9284c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2842790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283f930>, '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 0x2840830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2840cc0>, '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': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:22:34 INFO - Using env: {'DISPLAY': ':0', 18:22:34 INFO - 'HOME': '/home/cltbld', 18:22:34 INFO - 'LANG': 'en_US.UTF-8', 18:22:34 INFO - 'LANGUAGE': 'en_US:en', 18:22:34 INFO - 'LOGNAME': 'cltbld', 18:22:34 INFO - 'MAIL': '/var/mail/cltbld', 18:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:34 INFO - 'MOZ_NO_REMOTE': '1', 18:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:34 INFO - 'NO_EM_RESTART': '1', 18:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:34 INFO - 'PWD': '/builds/slave/test', 18:22:34 INFO - 'SHELL': '/bin/bash', 18:22:34 INFO - 'SHLVL': '1', 18:22:34 INFO - 'TERM': 'linux', 18:22:34 INFO - 'TMOUT': '86400', 18:22:34 INFO - 'USER': 'cltbld', 18:22:34 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 18:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:34 INFO - '_': '/tools/buildbot/bin/python'} 18:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:22:34 INFO - Cleaning up... 18:22:34 INFO - Return code: 0 18:22:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9284c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2842790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283f930>, '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 0x2840830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2840cc0>, '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': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:22:34 INFO - Using env: {'DISPLAY': ':0', 18:22:34 INFO - 'HOME': '/home/cltbld', 18:22:34 INFO - 'LANG': 'en_US.UTF-8', 18:22:34 INFO - 'LANGUAGE': 'en_US:en', 18:22:34 INFO - 'LOGNAME': 'cltbld', 18:22:34 INFO - 'MAIL': '/var/mail/cltbld', 18:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:34 INFO - 'MOZ_NO_REMOTE': '1', 18:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:34 INFO - 'NO_EM_RESTART': '1', 18:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:34 INFO - 'PWD': '/builds/slave/test', 18:22:34 INFO - 'SHELL': '/bin/bash', 18:22:34 INFO - 'SHLVL': '1', 18:22:34 INFO - 'TERM': 'linux', 18:22:34 INFO - 'TMOUT': '86400', 18:22:34 INFO - 'USER': 'cltbld', 18:22:34 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 18:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:34 INFO - '_': '/tools/buildbot/bin/python'} 18:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:34 INFO - Downloading/unpacking blobuploader==1.2.4 18:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:36 INFO - Downloading blobuploader-1.2.4.tar.gz 18:22:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:22:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:22:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:37 INFO - Downloading docopt-0.6.1.tar.gz 18:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:22:37 INFO - Installing collected packages: blobuploader, requests, docopt 18:22:37 INFO - Running setup.py install for blobuploader 18:22:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:22:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:22:37 INFO - Running setup.py install for requests 18:22:37 INFO - Running setup.py install for docopt 18:22:37 INFO - Successfully installed blobuploader requests docopt 18:22:37 INFO - Cleaning up... 18:22:38 INFO - Return code: 0 18:22:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9284c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2842790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283f930>, '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 0x2840830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2840cc0>, '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': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:22:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:22:38 INFO - Using env: {'DISPLAY': ':0', 18:22:38 INFO - 'HOME': '/home/cltbld', 18:22:38 INFO - 'LANG': 'en_US.UTF-8', 18:22:38 INFO - 'LANGUAGE': 'en_US:en', 18:22:38 INFO - 'LOGNAME': 'cltbld', 18:22:38 INFO - 'MAIL': '/var/mail/cltbld', 18:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:38 INFO - 'MOZ_NO_REMOTE': '1', 18:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:38 INFO - 'NO_EM_RESTART': '1', 18:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:38 INFO - 'PWD': '/builds/slave/test', 18:22:38 INFO - 'SHELL': '/bin/bash', 18:22:38 INFO - 'SHLVL': '1', 18:22:38 INFO - 'TERM': 'linux', 18:22:38 INFO - 'TMOUT': '86400', 18:22:38 INFO - 'USER': 'cltbld', 18:22:38 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 18:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:38 INFO - '_': '/tools/buildbot/bin/python'} 18:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:22:38 INFO - Running setup.py (path:/tmp/pip-UOyFEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:22:38 INFO - Running setup.py (path:/tmp/pip-Lg8Oew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:22:38 INFO - Running setup.py (path:/tmp/pip-bt1DsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:22:38 INFO - Running setup.py (path:/tmp/pip-sXtJPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:22:38 INFO - Running setup.py (path:/tmp/pip-7Seklx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:22:38 INFO - Running setup.py (path:/tmp/pip-sL50Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:22:38 INFO - Running setup.py (path:/tmp/pip-rnEFnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:22:38 INFO - Running setup.py (path:/tmp/pip-jrKJoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:22:38 INFO - Running setup.py (path:/tmp/pip-VnGDqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:22:38 INFO - Running setup.py (path:/tmp/pip-yHoTHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:22:38 INFO - Running setup.py (path:/tmp/pip-tg6xMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:22:39 INFO - Running setup.py (path:/tmp/pip-eOIi7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:22:39 INFO - Running setup.py (path:/tmp/pip-jQsxNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:22:39 INFO - Running setup.py (path:/tmp/pip-oMIb9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:39 INFO - Running setup.py (path:/tmp/pip-xj4jlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:22:39 INFO - Running setup.py (path:/tmp/pip-cknnJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:22:39 INFO - Running setup.py (path:/tmp/pip-gOmw6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:22:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:22:39 INFO - Running setup.py install for manifestparser 18:22:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:22:39 INFO - Running setup.py install for mozcrash 18:22:39 INFO - Running setup.py install for mozdebug 18:22:39 INFO - Running setup.py install for mozdevice 18:22:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:22:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:22:39 INFO - Running setup.py install for mozfile 18:22:40 INFO - Running setup.py install for mozhttpd 18:22:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Running setup.py install for mozinfo 18:22:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Running setup.py install for mozInstall 18:22:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Running setup.py install for mozleak 18:22:40 INFO - Running setup.py install for mozlog 18:22:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Running setup.py install for moznetwork 18:22:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Running setup.py install for mozprocess 18:22:40 INFO - Running setup.py install for mozprofile 18:22:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Running setup.py install for mozrunner 18:22:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Running setup.py install for mozscreenshot 18:22:41 INFO - Running setup.py install for moztest 18:22:41 INFO - Running setup.py install for mozversion 18:22:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:22:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:22:41 INFO - Cleaning up... 18:22:41 INFO - Return code: 0 18:22:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9284c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2842790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283f930>, '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 0x2840830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2840cc0>, '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': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:22:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:22:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:22:41 INFO - Using env: {'DISPLAY': ':0', 18:22:41 INFO - 'HOME': '/home/cltbld', 18:22:41 INFO - 'LANG': 'en_US.UTF-8', 18:22:41 INFO - 'LANGUAGE': 'en_US:en', 18:22:41 INFO - 'LOGNAME': 'cltbld', 18:22:41 INFO - 'MAIL': '/var/mail/cltbld', 18:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:41 INFO - 'MOZ_NO_REMOTE': '1', 18:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:41 INFO - 'NO_EM_RESTART': '1', 18:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:41 INFO - 'PWD': '/builds/slave/test', 18:22:41 INFO - 'SHELL': '/bin/bash', 18:22:41 INFO - 'SHLVL': '1', 18:22:41 INFO - 'TERM': 'linux', 18:22:41 INFO - 'TMOUT': '86400', 18:22:41 INFO - 'USER': 'cltbld', 18:22:41 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 18:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:41 INFO - '_': '/tools/buildbot/bin/python'} 18:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:22:41 INFO - Running setup.py (path:/tmp/pip-14906t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:22:41 INFO - Running setup.py (path:/tmp/pip-AQNvRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:22:41 INFO - Running setup.py (path:/tmp/pip-WdWeSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:22:41 INFO - Running setup.py (path:/tmp/pip-yBPP_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:22:41 INFO - Running setup.py (path:/tmp/pip-K2YbkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:22:41 INFO - Running setup.py (path:/tmp/pip-iOdQBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:22:41 INFO - Running setup.py (path:/tmp/pip-8Hu0ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:22:42 INFO - Running setup.py (path:/tmp/pip-9982OR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:22:42 INFO - Running setup.py (path:/tmp/pip-N1fb6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:22:42 INFO - Running setup.py (path:/tmp/pip-E4G8uU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:22:42 INFO - Running setup.py (path:/tmp/pip-2OVJGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:22:42 INFO - Running setup.py (path:/tmp/pip-khYVc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:22:42 INFO - Running setup.py (path:/tmp/pip-GQfW8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:22:42 INFO - Running setup.py (path:/tmp/pip-WCIhdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:42 INFO - Running setup.py (path:/tmp/pip-Pibigt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:22:42 INFO - Running setup.py (path:/tmp/pip-WgPbDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:22:42 INFO - Running setup.py (path:/tmp/pip-xlL5Ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:22:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:44 INFO - Downloading blessings-1.6.tar.gz 18:22:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:22:44 INFO - Installing collected packages: blessings 18:22:44 INFO - Running setup.py install for blessings 18:22:44 INFO - Successfully installed blessings 18:22:44 INFO - Cleaning up... 18:22:44 INFO - Return code: 0 18:22:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:22:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:22:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:22:45 INFO - Reading from file tmpfile_stdout 18:22:45 INFO - Current package versions: 18:22:45 INFO - argparse == 1.2.1 18:22:45 INFO - blessings == 1.6 18:22:45 INFO - blobuploader == 1.2.4 18:22:45 INFO - docopt == 0.6.1 18:22:45 INFO - functools32 == 3.2.3-2 18:22:45 INFO - jsonschema == 2.5.1 18:22:45 INFO - manifestparser == 1.1 18:22:45 INFO - mozInstall == 1.12 18:22:45 INFO - mozcrash == 0.17 18:22:45 INFO - mozdebug == 0.1 18:22:45 INFO - mozdevice == 0.48 18:22:45 INFO - mozfile == 1.2 18:22:45 INFO - mozhttpd == 0.7 18:22:45 INFO - mozinfo == 0.9 18:22:45 INFO - mozleak == 0.1 18:22:45 INFO - mozlog == 3.4 18:22:45 INFO - moznetwork == 0.27 18:22:45 INFO - mozprocess == 0.23 18:22:45 INFO - mozprofile == 0.28 18:22:45 INFO - mozrunner == 6.12 18:22:45 INFO - mozscreenshot == 0.1 18:22:45 INFO - mozsystemmonitor == 0.3 18:22:45 INFO - moztest == 0.7 18:22:45 INFO - mozversion == 1.4 18:22:45 INFO - psutil == 3.1.1 18:22:45 INFO - requests == 1.2.3 18:22:45 INFO - wsgiref == 0.1.2 18:22:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9284c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2842790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283f930>, '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 0x2840830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2840cc0>, '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': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:22:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:22:45 INFO - Using env: {'DISPLAY': ':0', 18:22:45 INFO - 'HOME': '/home/cltbld', 18:22:45 INFO - 'LANG': 'en_US.UTF-8', 18:22:45 INFO - 'LANGUAGE': 'en_US:en', 18:22:45 INFO - 'LOGNAME': 'cltbld', 18:22:45 INFO - 'MAIL': '/var/mail/cltbld', 18:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:45 INFO - 'MOZ_NO_REMOTE': '1', 18:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:45 INFO - 'NO_EM_RESTART': '1', 18:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:45 INFO - 'PWD': '/builds/slave/test', 18:22:45 INFO - 'SHELL': '/bin/bash', 18:22:45 INFO - 'SHLVL': '1', 18:22:45 INFO - 'TERM': 'linux', 18:22:45 INFO - 'TMOUT': '86400', 18:22:45 INFO - 'USER': 'cltbld', 18:22:45 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 18:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:45 INFO - '_': '/tools/buildbot/bin/python'} 18:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:22:45 INFO - Cleaning up... 18:22:45 INFO - Return code: 0 18:22:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9284c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2842790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283f930>, '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 0x2840830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2840cc0>, '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': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:22:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:22:45 INFO - Using env: {'DISPLAY': ':0', 18:22:45 INFO - 'HOME': '/home/cltbld', 18:22:45 INFO - 'LANG': 'en_US.UTF-8', 18:22:45 INFO - 'LANGUAGE': 'en_US:en', 18:22:45 INFO - 'LOGNAME': 'cltbld', 18:22:45 INFO - 'MAIL': '/var/mail/cltbld', 18:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:45 INFO - 'MOZ_NO_REMOTE': '1', 18:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:45 INFO - 'NO_EM_RESTART': '1', 18:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:45 INFO - 'PWD': '/builds/slave/test', 18:22:45 INFO - 'SHELL': '/bin/bash', 18:22:45 INFO - 'SHLVL': '1', 18:22:45 INFO - 'TERM': 'linux', 18:22:45 INFO - 'TMOUT': '86400', 18:22:45 INFO - 'USER': 'cltbld', 18:22:45 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 18:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:45 INFO - '_': '/tools/buildbot/bin/python'} 18:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:22:45 INFO - Cleaning up... 18:22:45 INFO - Return code: 0 18:22:45 INFO - Running post-action listener: _resource_record_post_action 18:22:45 INFO - Running post-action listener: _start_resource_monitoring 18:22:45 INFO - Starting resource monitoring. 18:22:45 INFO - [mozharness: 2016-10-18 01:22:45.642496Z] Finished create-virtualenv step (success) 18:22:45 INFO - [mozharness: 2016-10-18 01:22:45.642951Z] Running install step. 18:22:45 INFO - Running pre-action listener: _resource_record_pre_action 18:22:45 INFO - Running main action method: install 18:22:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:22:45 INFO - Reading from file tmpfile_stdout 18:22:45 INFO - Detecting whether we're running mozinstall >=1.0... 18:22:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:22:45 INFO - Reading from file tmpfile_stdout 18:22:45 INFO - Output received: 18:22:45 INFO - Usage: mozinstall [options] installer 18:22:45 INFO - Options: 18:22:45 INFO - -h, --help show this help message and exit 18:22:45 INFO - -d DEST, --destination=DEST 18:22:45 INFO - Directory to install application into. [default: 18:22:45 INFO - "/builds/slave/test"] 18:22:45 INFO - --app=APP Application being installed. [default: firefox] 18:22:45 INFO - mkdir: /builds/slave/test/build/application 18:22:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:23:02 INFO - Reading from file tmpfile_stdout 18:23:02 INFO - Output received: 18:23:02 INFO - /builds/slave/test/build/application/firefox/firefox 18:23:02 INFO - Running post-action listener: _resource_record_post_action 18:23:02 INFO - [mozharness: 2016-10-18 01:23:02.891273Z] Finished install step (success) 18:23:02 INFO - [mozharness: 2016-10-18 01:23:02.891611Z] Running run-tests step. 18:23:02 INFO - Running pre-action listener: _resource_record_pre_action 18:23:02 INFO - Running main action method: run_tests 18:23:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:23:02 INFO - Python 2.7.3 18:23:02 INFO - Return code: 0 18:23:02 INFO - grabbing minidump binary from tooltool 18:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:02 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283f930>, '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 0x2840830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2840cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:23:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:23:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:23:02 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:23:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:23:02 INFO - Return code: 0 18:23:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:23:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:23:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:23:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:23:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:23:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:23:02 INFO - Using env: {'DISPLAY': ':0', 18:23:02 INFO - 'HOME': '/home/cltbld', 18:23:02 INFO - 'LANG': 'en_US.UTF-8', 18:23:02 INFO - 'LANGUAGE': 'en_US:en', 18:23:02 INFO - 'LOGNAME': 'cltbld', 18:23:02 INFO - 'MAIL': '/var/mail/cltbld', 18:23:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:23:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:02 INFO - 'MOZ_NO_REMOTE': '1', 18:23:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:02 INFO - 'NO_EM_RESTART': '1', 18:23:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:02 INFO - 'PWD': '/builds/slave/test', 18:23:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:23:02 INFO - 'SHELL': '/bin/bash', 18:23:02 INFO - 'SHLVL': '1', 18:23:02 INFO - 'TERM': 'linux', 18:23:02 INFO - 'TMOUT': '86400', 18:23:02 INFO - 'USER': 'cltbld', 18:23:02 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289', 18:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:02 INFO - '_': '/tools/buildbot/bin/python'} 18:23:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:23:03 INFO - mozversion application_buildid: 20161017153001 18:23:03 INFO - mozversion application_changeset: 7ef1bb3238671037ae8ef82e05ba665ddb14f592 18:23:03 INFO - mozversion application_display_name: Nightly 18:23:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:23:03 INFO - mozversion application_name: Firefox 18:23:03 INFO - mozversion application_remotingname: firefox 18:23:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 18:23:03 INFO - mozversion application_vendor: Mozilla 18:23:03 INFO - mozversion application_version: 52.0a1 18:23:03 INFO - mozversion platform_buildid: 20161017153001 18:23:03 INFO - mozversion platform_changeset: 7ef1bb3238671037ae8ef82e05ba665ddb14f592 18:23:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 18:23:03 INFO - mozversion platform_version: 52.0a1 18:23:03 INFO - using testdate: 1476753783 18:23:03 INFO - actual date: 1476753783 18:23:03 INFO - starting webserver on 'localhost:46197' 18:23:03 INFO - SUITE-START | Running 2 tests 18:23:03 INFO - TEST-START | dromaeo_css 18:23:03 INFO - operating with platform_type : linux_ 18:23:03 INFO - Initialising browser for dromaeo_css test... 18:23:03 INFO - TEST-INFO | started process 23666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmtNlwg/profile http://localhost:46197/getInfo.html) 18:23:06 INFO - PROCESS | 23666 | __metrics Screen width/height:1600/1200 18:23:06 INFO - PROCESS | 23666 | colorDepth:24 18:23:06 INFO - PROCESS | 23666 | Browser inner width/height: 1024/697 18:23:06 INFO - PROCESS | 23666 | __metrics 18:23:07 INFO - PROCESS | 23666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:23:07 INFO - PROCESS | 23666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:23:08 INFO - TEST-INFO | 23666: exit 0 18:23:08 INFO - Browser initialized. 18:23:08 INFO - Running cycle 1/1 for dromaeo_css test... 18:23:08 INFO - TEST-INFO | started process 23752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmtNlwg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:23:20 INFO - PROCESS | 23752 | RSS: Main: 172056576 18:23:20 INFO - PROCESS | 23752 | 18:24:12 INFO - PROCESS | 23752 | 1476753852349 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:26:23 INFO - PROCESS | 23752 | Cycle 1(1): loaded http://localhost:46197/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46197/tests/dromaeo/cssquery-ext.html) 18:26:24 INFO - PROCESS | 23752 | RSS: Main: 324706304 18:26:24 INFO - PROCESS | 23752 | 18:29:27 INFO - PROCESS | 23752 | Cycle 1(1): loaded http://localhost:46197/tests/dromaeo/cssquery-ext.html (next: http://localhost:46197/tests/dromaeo/cssquery-jquery.html) 18:29:27 INFO - PROCESS | 23752 | RSS: Main: 268677120 18:29:27 INFO - PROCESS | 23752 | 18:32:30 INFO - PROCESS | 23752 | Cycle 1(1): loaded http://localhost:46197/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46197/tests/dromaeo/cssquery-mootools.html) 18:32:30 INFO - PROCESS | 23752 | RSS: Main: 256393216 18:32:30 INFO - PROCESS | 23752 | 18:35:32 INFO - PROCESS | 23752 | Cycle 1(1): loaded http://localhost:46197/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46197/tests/dromaeo/cssquery-prototype.html) 18:35:33 INFO - PROCESS | 23752 | RSS: Main: 251502592 18:35:33 INFO - PROCESS | 23752 | 18:38:36 INFO - PROCESS | 23752 | Cycle 1(1): loaded http://localhost:46197/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46197/tests/dromaeo/cssquery-yui.html) 18:38:36 INFO - PROCESS | 23752 | RSS: Main: 215138304 18:38:36 INFO - PROCESS | 23752 | 18:41:39 INFO - PROCESS | 23752 | Cycle 1(1): loaded http://localhost:46197/tests/dromaeo/cssquery-yui.html (next: http://localhost:46197/tests/dromaeo/cssquery-dojo.html) 18:41:39 INFO - PROCESS | 23752 | RSS: Main: 308563968 18:41:39 INFO - PROCESS | 23752 | 18:41:39 INFO - PROCESS | 23752 | __start_tp_report 18:41:39 INFO - PROCESS | 23752 | _x_x_mozilla_page_load 18:41:39 INFO - PROCESS | 23752 | _x_x_mozilla_page_load_details 18:41:39 INFO - PROCESS | 23752 | |i|pagename|runs| 18:41:39 INFO - PROCESS | 23752 | |0;dojo.html;2931.5749216363624;2993.9221880123146;3017.7284044436024;3053.541968704694;3064.4483992881287;5142.460041695625;5199.324087868572;5217.321748172737;5300.734963251836;5417.431169727176;5258.947410525893;5260.8158714445;5348.732563371826;5369.060414427469;5431.049566325887;4745.264484004984;4751.548602882721;4791.640626952975;4811.783469743852;4845.152098382769;4787.593054590364;4812.879678008043;4862.319275301443;4864.854054378375;4923.655344125913;4653.767311634405;4829.710217386968;4830.903381932377;4845.975770121145;4945.554900058994;4681.040386720714;4742.549457801503;4761.309610106549;4769.165396055676;4771.403574553181;4740.762961851894;4743.739094349809;4744.833930812405;4791.904161916777;4825.324454576362;5210.6613070150315;5253.658512196695;5256.9737151314;5262.210668399771;5263.078961181778;5362.142057270857;5383.838484845461;5385.569154467633;5491.505764481216;5599.216109744639;5566.805161819317;5576.553875689935;5605.915911261334;5655.519280861132;5662.292213473316;5213.635045546814;5224.346956630421;5224.72302973999;5231.110711179109;5234.973825130888;5506.504414602705;5510;5681.119426488901;5694;5748.109043098327;5316.65441746293;5369.570434365241;5370.3287089113865;5409;5471.671699697951;5578.135389014709;5583.581231407661;5583.748731307101;5607;5645.774169033192;5552.472515111058;5555.944440555623;5561.5272701820795;5562.16567514876;5562.888742225133;5404.297441332602;5438.864028399322;5443.673379597237;5571.1086226203615;5581.441855814386;4300.03249268912;4303.63419109373;4305.892352691208;4306.246406878784;4308.0306930940915;3875.244327356195;3875.8837234883;3883.10688541637;3884.4561761353434;3884.9223015539533;5291.470852914755;5292.867678308073;5293.364796224478;5297.761600727977;5301.416844147141;5556.972215138899;5596.412376700469;5612.719364031782;5616.297962754656;5624.91562626561;5285.101532739443;5303.992241474108;5308.0445519806035;5310.283111779938;5312.096943519611;4783.258594917794;4788.04239152171;4817.253325734517;4819.879503012383;4843.321934929113;5862.267216597926;5865.472107510259;5869.706514674249;5870.354261031283;5874.206982057453;5419.729013549386;5631.915521267266;5634.464725851038;5636.323641163087;5641.887162256814;5639.125935480007;5843.474087332161;5916.615419997686;5923.822285331447;6013.428724271187;5591.944080559142;5592;5600.859978500407;5601.187827764869;5626.409227031103;5695.0603150481365;5714.200011998407;5718.542516598745;5723.542116630576;5724.0555308375315;5348.491893270133;5406.080966235828;5421.484958928895;5455.263539422127;5480.945190548044;5508.779648814163;5516.365617953987;5517.475839795213;5524.447555244444;5573.749181286771;5497.505224529811;5498.395176530498;5501.779928802963;5505.587080968863;5543.473370029841;5381.1121165007335;5415.918761218663;5479.643823151482;5535.3357597087;5547.722613869371;5488.204210389391;5488.396276409512;5490.890182196254;5529.723513824373;5549.278593782782 18:41:39 INFO - PROCESS | 23752 | |1;ext.html;543.3180102186323;593.4658807073633;609.0985341694291;611.2664802237314;632.91772069631;31515.369692606164;42668.57331426688;43594.34608480871;43674.12651746963;47601.52398476014;43385.78307108468;43776.781116094375;43806;43851.78074109625;43858;8133;8828.646854125844;8981.101889811032;8991.415557988743;8994.235489983359;7959.2836644701965;10488.947555262252;10763.461826908624;10767.515461804238;11056.502457389397;10942.781144377108;10996.890031099667;11002.394868282281;11003.22977391579;11006.944965275163;10762.677119686421;10788.892111078945;10816.945915270373;10834.187435942336;10845;10668.679939601825;10711.196660250513;10729.892701072968;10730.839037414446;10734.302270352402;42303;42313.57686423127;42319;42403;42777.144457110684;3362.899113026613;3427.456484841233;3544.9822750886083;3627.292677927805;3723.4228694552116;31799.20501987446;32178.678213218038;32319.83840080808;32419.189520261945;32880;4237.279662457358;4288.914221715549;4467.218236808546;4510.661700372485;4580.908381832378;202513;202523;202537;203555;205113;34832.82583587117;35866.82066589651;62149.68925155436;62936.68531657404;63067;34433.311333773185;35096.12259693528;35172.824135879666;35265.64734352624;35358.292834143685;13873.791893121612;13880.444782208599;13885.444582216598;13888.652783680287;13897.0966887152;11363.727254549123;11688.649340519798;12159.817602735966;12165.75668486643;12687.175333603287;8270.090290068089;8324.29243514296;8441.733739939058;8443.366747493963;8443.746687599381;3227.7740558160704;3252.3332716793;3267.591551056118;3294.2917272786467;3353.0611428799975;969.699393188114;992.6972273456665;1020.1481762728057;1041.682286902502;1056.3133962924007;31010;31695.84152079271;31761.841190793897;32434.35131297408;32652.83673581617;1044.3003187863997;1045.5660900726114;1063.984040239397;1077.0468135699805;1123.4102096399456;16256.431024914307;17140.914295428443;17143.399981000854;17181.883177593416;17266.913665431843;463986;467940;468497;471519;472608;57121.428785712444;57479.712601436724;57628.42371576231;57726.7113664429;57735.422645773004;1179.422083179236;1225.8651548329676;1250.8061250506187;1267.923924564529;1291.9612411627666;29358.559621605265;32826.50760238646;33064.50403243905;33283.50074748929;33578.097188273576;49974.25038624496;50427.243591345425;50519.74740126276;50522.49477505178;50568.49431505638;366745;366995;367547;368974;369541;27705;28085.43829123365;28239.858800705864;28251.717482824908;28736.712632873405;46647.533524665676;47160.7641961788;48807.511924880295;52400.47599524108;52846.47153528415;39683.60316396799;40491.79754101211;40698;41310.586894130676;42821.57178428176;41273.380899287135;41882.897560199686;42329.57670423256;42436.363454548824;42653.786731066146;40907;42051.36922946097;42555.3616695756;42566;42638;32295.35409291848;34532;35017;35262.47106293459;35290;27000.71882113375;27560.724392755816;27617;28284.854563691468;28810.27974300659 18:41:39 INFO - PROCESS | 23752 | |2;jquery.html;366.8862652577703;369.89642899987996;385.3449136468004;389.1205874723126;416.51476030424556;14270.785938210922;18046.639067218646;18917.52706182348;18999.145038473267;20251.898740506313;18652.440426787183;19132.234710611592;19369.22523099074;19493.610127797434;19536.609267814634;5482.122860342336;5754.568407369443;5757.280339957505;5757.740901659415;5757.740901659436;4176.14389050244;4270.081932384537;4389.868303950887;5611.831645050655;6377.553571250014;6399.93600063998;6401.967990160043;6408.327125651809;6408.6154830710075;6419.775307864225;6117;6254.8123556293385;6279.120923070774;6284.27730810958;6430.582012169218;5396.973015134939;5571.832845014656;5573.637713548606;5577.135543990688;5578.41426650204;21013.579728405348;21722.782772172235;23041.423964400856;23466.64800028001;23482.178123765756;2159;2168.7722789107233;2244.326701989413;2291.1293708390704;2809.1893822164157;9723.756906077333;10108.94945525275;10365.429901355423;10608.310459820086;10647.57409703611;1747.6242607839376;1851.2872544070494;1903.5057479878228;1908.7900330963582;1932.9130189141522;78135.60932195303;78395.6080219601;78900.60549697273;79664.60167699182;81486.18513814904;10459.215558833119;10612.20408469368;10819.621313253998;10835.241533092765;11005.394703291397;15241.847581524265;15243.314050867737;15289.9235503824;15295.617609559627;15321.310541025681;7740.7677769667;7932.484388514728;8137.349012079019;8138.064122625856;8247.546384948886;7630.847383052308;7805.609719514002;7964.123946365895;8020.5588692621295;8034.076081250731;4626.1210370029585;4638.257878739453;4646.372739680168;4659.370984916993;4731.651479328375;1824.042377751691;1881.2851116575887;1912.254220853868;1915.9042047897549;1938.8642795004214;913.6939125392935;966.12083004467;993.4039576254189;1003.3561565275552;1050.3120456101267;18930.81069189318;19341.323053693053;19446.180303856145;19563;19946.20215191405;972.8005758819424;985.1576901749045;991.7520619845038;1005.6982905128432;1043.9039009040478;10158.593656253666;10713.571457141627;10871.945640271906;10945.343279403261;10980.945095274472;410845;412608;427901;428066;428643;85637;86272.70590941141;86674;91300;92130.53934730284;997.2022382094295;1018.0989824005808;1066.7706443114769;1087.228068071678;1089.1504626391427;16140.273687683848;16879.493615191564;17984.550386240448;18048.917064976144;18082.276708931495;40813.591864080976;41116;41431.37852932269;41922.37116443317;42323.3651495234;51005;51453.22820157775;52214.73892630512;59019;60289.69855150696;8101.230383113595;8152.429329946846;8203.261706446448;8420.242178203991;8519.829603408021;9415.529223538659;12343.13598048128;12769.553065642658;12883.420246089136;12956.805647915477;11023.228374013743;11086.889131108586;11298.60454884108;11354.602588909349;11754.353510557;10876.456177191267;11099.889001110208;11181.32912025281;11191.216614837209;11209.495572699085;10946.17903657213;11423.828642570203;11471.770564588829;11531;11616.94191529037;7961.800954976172;8012.439129261129;8145.592720364077;8160.8775868360835;8484.787880303042;8579.742607721779;10557.63048293306;11367.943160284145;11461.942690286494;11921.761564768483 18:41:39 INFO - PROCESS | 23752 | |3;mootools.html;1326.728020755745;1421.403010735491;1473.4695509616536;1586.3892401425455;1762.6650936322098;7496.6251687415615;8338.332933365331;8675.219230269275;8675.436096653713;8935.1958323751;8810.07494213108;8840.071792461778;8895.777605559864;8900.732978010654;8904.688335908244;2303.216906251874;2330.743618202005;2333.439974406139;2335.532893421314;2338.1465764995737;2278.200221824756;2316.200910685811;2347.1784875293597;2347.2371479269223;2348.9530209395803;2283.828712846535;2293.7591552886956;2305.72331320241;2314.29414028722;2318.13070098713;2245.9438514037115;2246.9887650561805;2247.292102987562;2247.6291411917014;2256.2852232303403;2225.833062520301;2233.0286325448483;2239.55208958209;2243.1924507177405;2253.8084262837515;8507.872381914214;8606.268467180296;8624.180702833284;8675.913240867574;8734;5115.948840511584;5354.866128346784;5362.24928510005;5366.034113859504;5376.327959005124;3403.795772253648;3464.7921124732343;3504.246586983785;3510.613832478425;3566.821658917044;1049.1606714628342;1096.030013438105;2006.7792542820278;2017.0822275864446;2018.5054661607853;11596.188266821326;11696.766064678744;11732.17874748768;11745.882541174478;11798.292102473879;4180.205760905479;4238.682098842599;4361.847335343311;4370.650347972155;4418.337249412614;9136.269098472107;9199.4940278284;9206.355555111079;9215.124563166622;9217.262618990464;5010.5240002199735;5011.09800235961;5011.423686276052;5014.323066385991;5017.147084995559;4226.4928208615165;4346.326319420495;4691.038337140878;4756.072565849626;4891.095147397743;3621.8008009559726;3654.6528079832374;3707.3882809336696;3718.5165928429674;3774.1885494618787;1109.778044391125;1114.1198453222025;1119.798436281461;1125;1134.0587312530579;841.7759979279467;853.7609469348592;865.3293697384578;896.6010125494223;941.8869735631631;5650.378458369576;5687.090065589486;5771.451712087345;5803.361630220672;5928.644281343133;911.6626848066257;918.2653876898454;923.2198792020732;942.2179590939504;974.356924429887;3802.4486449465226;3872.1287710264965;3913.8238779255003;3979.9602003980167;4003.6187515307174;10577.62978295756;11076.446177691083;11079.889201107886;11095.44522773858;11142.665720028412;11041.723956900982;11043.72390690223;11047.447627618747;11063.336199827874;11064.557417703363;7614.961925190339;7933.651279282421;8001.839963200703;8040.8793868092025;8202.261796438468;5677.148427735872;5712.714364281853;5841.766329346949;5870.412958704095;5964.403559644001;9755.122039016522;9968.651097211563;10074.848877266993;10083.142932850496;10255.179585632983;9919.553620086968;10274.075333220046;10310.381377117397;10360.067593916583;10360.171186304926;7729.381649467917;7905.486143400661;7970.40221983342;7986.241307075818;8012.879806803019;8461.78845528842;8478.150583413673;8542.871856922275;8545.102764209669;8563.843881075974;7653.081630204411;7720;7730.11103723079;7764.961175194087;7929.603519824101;7348.008018917378;7356.301151390609;7358.889616655862;7409.073865766779;7547.660355283915;6784.253732089565;6900.2409734928115;6903.102596662402;6903.378695917391;6903.792886213421;4842.394700662418;4865.635077369141;4915.3855768029;4939.851804445872;5079.644424890223;4991;5009.749512524287;5224;5232.136697445031;5235.502627250406 18:41:39 INFO - PROCESS | 23752 | |4;prototype.html;318.01732646123475;326.7239182890458;327.25386119647203;334.8359303941068;342.33757678891334;5074.517920797528;5164.354455693038;5268.315119034525;5275.788968441268;5301.708406037671;5064.670796398241;5191.714455704935;5191.844244672666;5203.219517072441;5206.661566998152;4093.22228776533;4106.589341065885;4109;4117.773522456264;4119.649829764474;3885.5235010695897;4059.4316795648633;4098.8565400211;4099.856505022325;4105.4252404663375;4029.5567487576345;4043.3328500797334;4053.27041132596;4064;4064.2887494688457;4031.97984010081;4039.7476782197614;4056.7971601419813;4063.309237429644;4087.9795601021806;3624.782513049199;3625.6011838697723;3637.836297366625;3638.9818050909576;3641.1261297288725;5027.698338099725;5062.974685126551;5090.745462726886;5120.180771076647;5122.129238029544;4665.510121437268;4668.43978722552;4673;4687.484376718558;4690.061987602459;5450.174191645803;5457.263269458612;5464.508194262536;5481.698506582136;5497.388740348342;3858.961410385916;3951.38753493209;3967.8809635710977;3968.444417781513;3974.205158968218;5656.208130861683;5675.148727690838;5691.459311365414;5692.288463942007;5693.487586117228;4035.1929614077303;4040.9595904040584;4048.291548978917;4048.8785336439955;4064.7764372959773;4001.4998125234347;4056.006278461796;4075.1849630074103;4108.8356465741035;4120.505539335299;4585.908281834411;4637.559431853969;4659.627229821674;4660.836870709509;4677.2750223715375;5445.1611613812165;5467.671939683552;5468.152436372368;5474.835754927359;5501.257330260443;1265.6519457149172;1300.382318398772;1382.4401117547409;1392.1647011792843;1415.214555921453;940.1068984464649;957.3250858144991;971.140540621555;976.3556053004983;977.9559919803626;5224;5260.868478287997;5271.973640131775;5274.340707411574;5328.893422131536;5568.303962004749;5576.275084239023;5598.4961353477565;5604.3835178130375;5616.157576363578;5117.923231151536;5197.402298735694;5275.287836142148;5277.601435619564;5281.894362112736;2650.310919161032;2653.567073780137;2656.3624730064644;2668.5596876515156;2669.8932042718075;5104.804933878468;5106.591472682177;5134.640575159778;5170.482951704875;5182.300389447451;4870.407015093254;4958.404991400983;5067.797288108434;5068.949310506848;5090.185570308807;5149.2276158576515;5152.042223954873;5184.611154163528;5185.429602743695;5190.987757387274;4979.775910084128;4995.325631039763;4996.576660319814;5002.674826136289;5023.146065168857;4945.145570411096;5222.869428264324;5645.633033852787;5676.9432305678065;5681.602287839812;5933.199018132497;5941.22764040672;5943.779916259504;5945.256842894638;5954;4034.6080602192196;4083.2037752637953;4087.2234275487563;4097.078157414558;4098.057446787315;5417.918731218956;5430.456954304538;5685.658860468385;5698.572607054404;5719.542436605145;5327.733613319396;5400.975453745915;5492.80775172867;5498.367687715964;5533.972330138324;5476.205950137128;5478.8904221914545;5499.807506737245;5502.5597952164535;5514.724263786715;5286.550643195372;5405.648632838853;5465.754041068241;5473.151661492475;5474.863128421821;5485.4788795064405;5499;5506.81603455259;5515.448455154613;5516.475934786189;5383.757730902197;5389.2455056291365;5396.9190462142315;5422.725659469943;5429.701366424727 18:41:39 INFO - PROCESS | 23752 | |5;yui.html;732.780165950215;754.5133388964122;784.811645205151;788.3535500889274;832.9875051874221;15846.445374411884;16803.0758308293;16813.075280859546;16943.83056169438;17057.232424540893;15147.6970460591;15258.618534536643;15274.770878436804;15282.617934551641;15341.539753807376;661.163628010567;682.8975653651967;770.0489894979723;799.9760007199793;800.7157459102023;801.3549092980148;801.9518828870257;802.4823988527396;802.7070119406433;803.2008151888849;848.088305072047;851.4508142248246;851.6848765956573;852.2287329966359;853.3727710133047;691.0532570378589;712.9073220481304;832.4297855968681;846.7163500227431;850.5789634131145;624.7813265357134;626.2297374229723;630.1587380846576;630.7571584939831;631.2645767680647;15142.470013549473;15148.1668508232;15177.924110379488;15217.923910380488;15251.161186134757;13923.443062277496;14179.858201417957;14384.71230575393;14398.92800536001;14668.339924703307;12757.234565926074;12758.106932514727;13016.219026858418;13068.346582670829;13510.662233444144;4304.375865499516;4459.9331010034875;4474.791806212304;4481.57805688808;4609.631229501631;75739.24260757433;75813;76442.61778691127;76578.1710914452;76783;11053.668389948314;11070.446477676083;11167.776644467065;11393.544258229578;11543.653690389301;21801.563968720537;21829.345119646438;21937.34187974363;22057;22321.21875734374;8347.707830226034;8394.202550757669;8423.241908228289;8453.492790432594;8589;4435.246008178618;4438.778061096932;4565.56627120423;4576.771161441981;4657.0918670858855;3447.224374515714;3531.285866941043;3561.234334618018;3563.429851223792;3632.6730594246646;625.562106525434;636.9363063693594;641.112059797175;677.3971165662564;704.5490885832968;562.5752556819575;591.104476717773;651.547174713579;698.2389195776628;746.5110352718978;9377.812443751223;9671.90328096724;9678.854817177747;9827.17011676892;10123.898761012442;584.7777844419179;695.4193248637343;726.1866709285634;734.219483073813;747.6112421540769;4354.7822608870065;4455.554444555519;4543.432070991126;4773.198490475953;4775.331453596499;87393.56303218444;90877.54561227151;91963.54018229866;117362;120298.3985080069;86978;90185.09814901899;90993;91735.5413222943;92554;51585.16281604548;67106;77336.61331693418;78886;80258;9065.773355665897;10015.24885633595;10113.14038306752;10173.796524069328;10376.948115259376;47733;49113.508864910895;49539;49731.75134124306;50466.49533504618;66388.37368581432;67399.3260067393;70373;73933.63033184799;74283.25716742764;13107.803382949072;13454.798178027142;13498.460061597427;13711.177329360271;13746.587602371945;14766.261686915397;15040.849591503946;15368.615784605474;15642.296096675449;15895.841041589898;13282.203067815575;14056.048229871842;14186.304602125563;14471.27643617836;15180.544583662508;14134.50529231472;14269.357878895267;14371.92814035923;14660.70678586401;14668.55994320172;13216.506387828185;13443.731125377242;13878.653033673834;13934.79097813554;14821.777673334693;10633.680989570325;10922.50848711794;11045.171612128961;11071.944640276746;11742.295462272292;11254.94372528132;11832.585859494877;12129.150959432754;12222.388880555758;12434.689132771753 18:41:39 INFO - PROCESS | 23752 | __end_tp_report 18:41:39 INFO - PROCESS | 23752 | __start_cc_report 18:41:39 INFO - PROCESS | 23752 | _x_x_mozilla_cycle_collect,1482 18:41:39 INFO - PROCESS | 23752 | __end_cc_report 18:41:39 INFO - PROCESS | 23752 | __startTimestamp1476754899930__endTimestamp 18:41:39 INFO - PROCESS | 23752 | 18:41:39 INFO - PROCESS | 23752 | ------- Summary: start ------- 18:41:39 INFO - PROCESS | 23752 | Number of tests: 6 18:41:39 INFO - PROCESS | 23752 | 18:41:39 INFO - PROCESS | 23752 | [#0] dojo.html Cycles:165 Average:5213.79 Median:5406.08 stddev:587.33 (10.9%) stddev-sans-first:561.18 18:41:39 INFO - PROCESS | 23752 | Values: 2931.6 2993.9 3017.7 3053.5 3064.4 5142.5 5199.3 5217.3 5300.7 5417.4 5258.9 5260.8 5348.7 5369.1 5431.0 4745.3 4751.5 4791.6 4811.8 4845.2 4787.6 4812.9 4862.3 4864.9 4923.7 4653.8 4829.7 4830.9 4846.0 4945.6 4681.0 4742.5 4761.3 4769.2 4771.4 4740.8 4743.7 4744.8 4791.9 4825.3 5210.7 5253.7 5257.0 5262.2 5263.1 5362.1 5383.8 5385.6 5491.5 5599.2 5566.8 5576.6 5605.9 5655.5 5662.3 5213.6 5224.3 5224.7 5231.1 5235.0 5506.5 5510.0 5681.1 5694.0 5748.1 5316.7 5369.6 5370.3 5409.0 5471.7 5578.1 5583.6 5583.7 5607.0 5645.8 5552.5 5555.9 5561.5 5562.2 5562.9 5404.3 5438.9 5443.7 5571.1 5581.4 4300.0 4303.6 4305.9 4306.2 4308.0 3875.2 3875.9 3883.1 3884.5 3884.9 5291.5 5292.9 5293.4 5297.8 5301.4 5557.0 5596.4 5612.7 5616.3 5624.9 5285.1 5304.0 5308.0 5310.3 5312.1 4783.3 4788.0 4817.3 4819.9 4843.3 5862.3 5865.5 5869.7 5870.4 5874.2 5419.7 5631.9 5634.5 5636.3 5641.9 5639.1 5843.5 5916.6 5923.8 6013.4 5591.9 5592.0 5600.9 5601.2 5626.4 5695.1 5714.2 5718.5 5723.5 5724.1 5348.5 5406.1 5421.5 5455.3 5480.9 5508.8 5516.4 5517.5 5524.4 5573.7 5497.5 5498.4 5501.8 5505.6 5543.5 5381.1 5415.9 5479.6 5535.3 5547.7 5488.2 5488.4 5490.9 5529.7 5549.3 18:41:39 INFO - PROCESS | 23752 | 18:41:39 INFO - PROCESS | 23752 | [#1] ext.html Cycles:180 Average:51189.93 Median:35134.47 stddev:96379.08 (274.3%) stddev-sans-first:96574.43 18:41:39 INFO - PROCESS | 23752 | Values: 543.3 593.5 609.1 611.3 632.9 31515.4 42668.6 43594.3 43674.1 47601.5 43385.8 43776.8 43806.0 43851.8 43858.0 8133.0 8828.6 8981.1 8991.4 8994.2 7959.3 10488.9 10763.5 10767.5 11056.5 10942.8 10996.9 11002.4 11003.2 11006.9 10762.7 10788.9 10816.9 10834.2 10845.0 10668.7 10711.2 10729.9 10730.8 10734.3 42303.0 42313.6 42319.0 42403.0 42777.1 3362.9 3427.5 3545.0 3627.3 3723.4 31799.2 32178.7 32319.8 32419.2 32880.0 4237.3 4288.9 4467.2 4510.7 4580.9 202513.0 202523.0 202537.0 203555.0 205113.0 34832.8 35866.8 62149.7 62936.7 63067.0 34433.3 35096.1 35172.8 35265.6 35358.3 13873.8 13880.4 13885.4 13888.7 13897.1 11363.7 11688.6 12159.8 12165.8 12687.2 8270.1 8324.3 8441.7 8443.4 8443.7 3227.8 3252.3 3267.6 3294.3 3353.1 969.7 992.7 1020.1 1041.7 1056.3 31010.0 31695.8 31761.8 32434.4 32652.8 1044.3 1045.6 1064.0 1077.0 1123.4 16256.4 17140.9 17143.4 17181.9 17266.9 463986.0 467940.0 468497.0 471519.0 472608.0 57121.4 57479.7 57628.4 57726.7 57735.4 1179.4 1225.9 1250.8 1267.9 1292.0 29358.6 32826.5 33064.5 33283.5 33578.1 49974.3 50427.2 50519.7 50522.5 50568.5 366745.0 366995.0 367547.0 368974.0 369541.0 27705.0 28085.4 28239.9 28251.7 28736.7 46647.5 47160.8 48807.5 52400.5 52846.5 39683.6 40491.8 40698.0 41310.6 42821.6 41273.4 41882.9 42329.6 42436.4 42653.8 40907.0 42051.4 42555.4 42566.0 42638.0 32295.4 34532.0 35017.0 35262.5 35290.0 27000.7 27560.7 27617.0 28284.9 28810.3 18:41:39 INFO - PROCESS | 23752 | 18:41:39 INFO - PROCESS | 23752 | [#2] jquery.html Cycles:180 Average:26709.63 Median:368.39 stddev:69831.66 (18955.8%) stddev-sans-first:69999.55 18:41:39 INFO - PROCESS | 23752 | Values: 366.9 369.9 385.3 389.1 416.5 14270.8 18046.6 18917.5 18999.1 20251.9 18652.4 19132.2 19369.2 19493.6 19536.6 5482.1 5754.6 5757.3 5757.7 5757.7 4176.1 4270.1 4389.9 5611.8 6377.6 6399.9 6402.0 6408.3 6408.6 6419.8 6117.0 6254.8 6279.1 6284.3 6430.6 5397.0 5571.8 5573.6 5577.1 5578.4 21013.6 21722.8 23041.4 23466.6 23482.2 2159.0 2168.8 2244.3 2291.1 2809.2 9723.8 10108.9 10365.4 10608.3 10647.6 1747.6 1851.3 1903.5 1908.8 1932.9 78135.6 78395.6 78900.6 79664.6 81486.2 10459.2 10612.2 10819.6 10835.2 11005.4 15241.8 15243.3 15289.9 15295.6 15321.3 7740.8 7932.5 8137.3 8138.1 8247.5 7630.8 7805.6 7964.1 8020.6 8034.1 4626.1 4638.3 4646.4 4659.4 4731.7 1824.0 1881.3 1912.3 1915.9 1938.9 913.7 966.1 993.4 1003.4 1050.3 18930.8 19341.3 19446.2 19563.0 19946.2 972.8 985.2 991.8 1005.7 1043.9 10158.6 10713.6 10871.9 10945.3 10980.9 410845.0 412608.0 427901.0 428066.0 428643.0 85637.0 86272.7 86674.0 91300.0 92130.5 997.2 1018.1 1066.8 1087.2 1089.2 16140.3 16879.5 17984.6 18048.9 18082.3 40813.6 41116.0 41431.4 41922.4 42323.4 51005.0 51453.2 52214.7 59019.0 60289.7 8101.2 8152.4 8203.3 8420.2 8519.8 9415.5 12343.1 12769.6 12883.4 12956.8 11023.2 11086.9 11298.6 11354.6 11754.4 10876.5 11099.9 11181.3 11191.2 11209.5 10946.2 11423.8 11471.8 11531.0 11616.9 7961.8 8012.4 8145.6 8160.9 8484.8 8579.7 10557.6 11367.9 11461.9 11921.8 18:41:39 INFO - PROCESS | 23752 | 18:41:39 INFO - PROCESS | 23752 | [#3] mootools.html Cycles:180 Average:5697.15 Median:4965.43 stddev:3231.01 (65.1%) stddev-sans-first:3223.37 18:41:39 INFO - PROCESS | 23752 | Values: 1326.7 1421.4 1473.5 1586.4 1762.7 7496.6 8338.3 8675.2 8675.4 8935.2 8810.1 8840.1 8895.8 8900.7 8904.7 2303.2 2330.7 2333.4 2335.5 2338.1 2278.2 2316.2 2347.2 2347.2 2349.0 2283.8 2293.8 2305.7 2314.3 2318.1 2245.9 2247.0 2247.3 2247.6 2256.3 2225.8 2233.0 2239.6 2243.2 2253.8 8507.9 8606.3 8624.2 8675.9 8734.0 5115.9 5354.9 5362.2 5366.0 5376.3 3403.8 3464.8 3504.2 3510.6 3566.8 1049.2 1096.0 2006.8 2017.1 2018.5 11596.2 11696.8 11732.2 11745.9 11798.3 4180.2 4238.7 4361.8 4370.7 4418.3 9136.3 9199.5 9206.4 9215.1 9217.3 5010.5 5011.1 5011.4 5014.3 5017.1 4226.5 4346.3 4691.0 4756.1 4891.1 3621.8 3654.7 3707.4 3718.5 3774.2 1109.8 1114.1 1119.8 1125.0 1134.1 841.8 853.8 865.3 896.6 941.9 5650.4 5687.1 5771.5 5803.4 5928.6 911.7 918.3 923.2 942.2 974.4 3802.4 3872.1 3913.8 3980.0 4003.6 10577.6 11076.4 11079.9 11095.4 11142.7 11041.7 11043.7 11047.4 11063.3 11064.6 7615.0 7933.7 8001.8 8040.9 8202.3 5677.1 5712.7 5841.8 5870.4 5964.4 9755.1 9968.7 10074.8 10083.1 10255.2 9919.6 10274.1 10310.4 10360.1 10360.2 7729.4 7905.5 7970.4 7986.2 8012.9 8461.8 8478.2 8542.9 8545.1 8563.8 7653.1 7720.0 7730.1 7765.0 7929.6 7348.0 7356.3 7358.9 7409.1 7547.7 6784.3 6900.2 6903.1 6903.4 6903.8 4842.4 4865.6 4915.4 4939.9 5079.6 4991.0 5009.7 5224.0 5232.1 5235.5 18:41:39 INFO - PROCESS | 23752 | 18:41:39 INFO - PROCESS | 23752 | [#4] prototype.html Cycles:180 Average:4539.68 Median:5128.38 stddev:1323.68 (25.8%) stddev-sans-first:1288.90 18:41:39 INFO - PROCESS | 23752 | Values: 318.0 326.7 327.3 334.8 342.3 5074.5 5164.4 5268.3 5275.8 5301.7 5064.7 5191.7 5191.8 5203.2 5206.7 4093.2 4106.6 4109.0 4117.8 4119.6 3885.5 4059.4 4098.9 4099.9 4105.4 4029.6 4043.3 4053.3 4064.0 4064.3 4032.0 4039.7 4056.8 4063.3 4088.0 3624.8 3625.6 3637.8 3639.0 3641.1 5027.7 5063.0 5090.7 5120.2 5122.1 4665.5 4668.4 4673.0 4687.5 4690.1 5450.2 5457.3 5464.5 5481.7 5497.4 3859.0 3951.4 3967.9 3968.4 3974.2 5656.2 5675.1 5691.5 5692.3 5693.5 4035.2 4041.0 4048.3 4048.9 4064.8 4001.5 4056.0 4075.2 4108.8 4120.5 4585.9 4637.6 4659.6 4660.8 4677.3 5445.2 5467.7 5468.2 5474.8 5501.3 1265.7 1300.4 1382.4 1392.2 1415.2 940.1 957.3 971.1 976.4 978.0 5224.0 5260.9 5272.0 5274.3 5328.9 5568.3 5576.3 5598.5 5604.4 5616.2 5117.9 5197.4 5275.3 5277.6 5281.9 2650.3 2653.6 2656.4 2668.6 2669.9 5104.8 5106.6 5134.6 5170.5 5182.3 4870.4 4958.4 5067.8 5068.9 5090.2 5149.2 5152.0 5184.6 5185.4 5191.0 4979.8 4995.3 4996.6 5002.7 5023.1 4945.1 5222.9 5645.6 5676.9 5681.6 5933.2 5941.2 5943.8 5945.3 5954.0 4034.6 4083.2 4087.2 4097.1 4098.1 5417.9 5430.5 5685.7 5698.6 5719.5 5327.7 5401.0 5492.8 5498.4 5534.0 5476.2 5478.9 5499.8 5502.6 5514.7 5286.6 5405.6 5465.8 5473.2 5474.9 5485.5 5499.0 5506.8 5515.4 5516.5 5383.8 5389.2 5396.9 5422.7 5429.7 18:41:39 INFO - PROCESS | 23752 | 18:41:39 INFO - PROCESS | 23752 | [#5] yui.html Cycles:180 Average:19809.60 Median:4554.50 stddev:27121.49 (595.5%) stddev-sans-first:27159.74 18:41:39 INFO - PROCESS | 23752 | Values: 732.8 754.5 784.8 788.4 833.0 15846.4 16803.1 16813.1 16943.8 17057.2 15147.7 15258.6 15274.8 15282.6 15341.5 661.2 682.9 770.0 800.0 800.7 801.4 802.0 802.5 802.7 803.2 848.1 851.5 851.7 852.2 853.4 691.1 712.9 832.4 846.7 850.6 624.8 626.2 630.2 630.8 631.3 15142.5 15148.2 15177.9 15217.9 15251.2 13923.4 14179.9 14384.7 14398.9 14668.3 12757.2 12758.1 13016.2 13068.3 13510.7 4304.4 4459.9 4474.8 4481.6 4609.6 75739.2 75813.0 76442.6 76578.2 76783.0 11053.7 11070.4 11167.8 11393.5 11543.7 21801.6 21829.3 21937.3 22057.0 22321.2 8347.7 8394.2 8423.2 8453.5 8589.0 4435.2 4438.8 4565.6 4576.8 4657.1 3447.2 3531.3 3561.2 3563.4 3632.7 625.6 636.9 641.1 677.4 704.5 562.6 591.1 651.5 698.2 746.5 9377.8 9671.9 9678.9 9827.2 10123.9 584.8 695.4 726.2 734.2 747.6 4354.8 4455.6 4543.4 4773.2 4775.3 87393.6 90877.5 91963.5 117362.0 120298.4 86978.0 90185.1 90993.0 91735.5 92554.0 51585.2 67106.0 77336.6 78886.0 80258.0 9065.8 10015.2 10113.1 10173.8 10376.9 47733.0 49113.5 49539.0 49731.8 50466.5 66388.4 67399.3 70373.0 73933.6 74283.3 13107.8 13454.8 13498.5 13711.2 13746.6 14766.3 15040.8 15368.6 15642.3 15895.8 13282.2 14056.0 14186.3 14471.3 15180.5 14134.5 14269.4 14371.9 14660.7 14668.6 13216.5 13443.7 13878.7 13934.8 14821.8 10633.7 10922.5 11045.2 11071.9 11742.3 11254.9 11832.6 12129.2 12222.4 12434.7 18:41:39 INFO - PROCESS | 23752 | -------- Summary: end -------- 18:41:39 INFO - PROCESS | 23752 | 18:41:40 INFO - TEST-INFO | 23752: exit 0 18:41:40 INFO - TEST-OK | dromaeo_css | took 1117722ms 18:41:40 INFO - TEST-START | kraken 18:41:40 INFO - operating with platform_type : linux_ 18:41:40 INFO - Initialising browser for kraken test... 18:41:40 INFO - TEST-INFO | started process 24060 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppHwGKZ/profile http://localhost:46197/getInfo.html) 18:41:44 INFO - PROCESS | 24060 | __metrics Screen width/height:1600/1200 18:41:44 INFO - PROCESS | 24060 | colorDepth:24 18:41:44 INFO - PROCESS | 24060 | Browser inner width/height: 1024/697 18:41:44 INFO - PROCESS | 24060 | __metrics 18:41:45 INFO - PROCESS | 24060 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:41:45 INFO - PROCESS | 24060 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:41:45 INFO - PROCESS | 24060 | console.error: PushService: 18:41:45 INFO - PROCESS | 24060 | stateChangeProcessEnqueue: Error transitioning state 18:41:45 INFO - PROCESS | 24060 | UnknownError 18:41:46 INFO - TEST-INFO | 24060: exit 0 18:41:46 INFO - Browser initialized. 18:41:46 INFO - Running cycle 1/1 for kraken test... 18:41:46 INFO - TEST-INFO | started process 24141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppHwGKZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:41:58 INFO - PROCESS | 24141 | RSS: Main: 172060672 18:41:58 INFO - PROCESS | 24141 | 18:42:01 INFO - PROCESS | 24141 | Cycle 1(1): loaded http://localhost:46197/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46197/tests/kraken/driver.html?testName=audio-beat-detection) 18:42:01 INFO - PROCESS | 24141 | RSS: Main: 237387776 18:42:01 INFO - PROCESS | 24141 | 18:42:04 INFO - PROCESS | 24141 | Cycle 1(1): loaded http://localhost:46197/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46197/tests/kraken/driver.html?testName=audio-dft) 18:42:05 INFO - PROCESS | 24141 | RSS: Main: 215851008 18:42:05 INFO - PROCESS | 24141 | 18:42:08 INFO - PROCESS | 24141 | Cycle 1(1): loaded http://localhost:46197/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46197/tests/kraken/driver.html?testName=audio-fft) 18:42:08 INFO - PROCESS | 24141 | RSS: Main: 297385984 18:42:08 INFO - PROCESS | 24141 | 18:42:11 INFO - PROCESS | 24141 | Cycle 1(1): loaded http://localhost:46197/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46197/tests/kraken/driver.html?testName=audio-oscillator) 18:42:11 INFO - PROCESS | 24141 | RSS: Main: 208715776 18:42:11 INFO - PROCESS | 24141 | 18:42:13 INFO - PROCESS | 24141 | Cycle 1(1): loaded http://localhost:46197/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46197/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:42:14 INFO - PROCESS | 24141 | RSS: Main: 211578880 18:42:14 INFO - PROCESS | 24141 | 18:42:17 INFO - PROCESS | 24141 | Cycle 1(1): loaded http://localhost:46197/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46197/tests/kraken/driver.html?testName=imaging-darkroom) 18:42:17 INFO - PROCESS | 24141 | RSS: Main: 247996416 18:42:17 INFO - PROCESS | 24141 | 18:42:21 INFO - PROCESS | 24141 | Cycle 1(1): loaded http://localhost:46197/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46197/tests/kraken/driver.html?testName=imaging-desaturate) 18:42:21 INFO - PROCESS | 24141 | RSS: Main: 246886400 18:42:21 INFO - PROCESS | 24141 | 18:42:24 INFO - PROCESS | 24141 | Cycle 1(1): loaded http://localhost:46197/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46197/tests/kraken/driver.html?testName=json-parse-financial) 18:42:25 INFO - PROCESS | 24141 | RSS: Main: 245755904 18:42:25 INFO - PROCESS | 24141 | 18:42:26 INFO - PROCESS | 24141 | Cycle 1(1): loaded http://localhost:46197/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46197/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:42:27 INFO - PROCESS | 24141 | RSS: Main: 208101376 18:42:27 INFO - PROCESS | 24141 | 18:42:28 INFO - PROCESS | 24141 | Cycle 1(1): loaded http://localhost:46197/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46197/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:42:29 INFO - PROCESS | 24141 | RSS: Main: 215617536 18:42:29 INFO - PROCESS | 24141 | 18:42:31 INFO - PROCESS | 24141 | Cycle 1(1): loaded http://localhost:46197/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46197/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:42:32 INFO - PROCESS | 24141 | RSS: Main: 225193984 18:42:32 INFO - PROCESS | 24141 | 18:42:34 INFO - PROCESS | 24141 | Cycle 1(1): loaded http://localhost:46197/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46197/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:42:35 INFO - PROCESS | 24141 | RSS: Main: 233140224 18:42:35 INFO - PROCESS | 24141 | 18:42:38 INFO - PROCESS | 24141 | Cycle 1(1): loaded http://localhost:46197/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46197/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:42:38 INFO - PROCESS | 24141 | RSS: Main: 231256064 18:42:38 INFO - PROCESS | 24141 | 18:42:40 INFO - PROCESS | 24141 | Cycle 1(1): loaded http://localhost:46197/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46197/tests/kraken/driver.html?testName=ai-astar) 18:42:40 INFO - PROCESS | 24141 | RSS: Main: 281903104 18:42:40 INFO - PROCESS | 24141 | 18:42:40 INFO - PROCESS | 24141 | __start_tp_report 18:42:40 INFO - PROCESS | 24141 | _x_x_mozilla_page_load 18:42:40 INFO - PROCESS | 24141 | _x_x_mozilla_page_load_details 18:42:40 INFO - PROCESS | 24141 | |i|pagename|runs| 18:42:40 INFO - PROCESS | 24141 | |0;ai-astar;104;112;111;111;113;110;112;111;111;113 18:42:40 INFO - PROCESS | 24141 | |1;audio-beat-detection;144;133;124;153;126;127;124;125;158;125 18:42:40 INFO - PROCESS | 24141 | |2;audio-dft;162;161;162;162;160;161;162;163;161;162 18:42:40 INFO - PROCESS | 24141 | |3;audio-fft;77;75;76;122;76;78;77;76;98;75 18:42:40 INFO - PROCESS | 24141 | |4;audio-oscillator;83;82;125;83;83;82;103;83;84;116 18:42:40 INFO - PROCESS | 24141 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 18:42:40 INFO - PROCESS | 24141 | |6;imaging-darkroom;145;146;146;145;145;147;145;145;145;146 18:42:40 INFO - PROCESS | 24141 | |7;imaging-desaturate;85;85;85;85;85;85;84;84;85;84 18:42:40 INFO - PROCESS | 24141 | |8;json-parse-financial;53;51;52;52;52;52;52;52;52;53 18:42:40 INFO - PROCESS | 24141 | |9;json-stringify-tinderbox;59;59;58;59;58;59;60;60;60;59 18:42:40 INFO - PROCESS | 24141 | |10;stanford-crypto-aes;80;80;80;81;80;80;79;80;80;80 18:42:40 INFO - PROCESS | 24141 | |11;stanford-crypto-ccm;129;133;135;131;132;127;130;139;174;134 18:42:40 INFO - PROCESS | 24141 | |12;stanford-crypto-pbkdf2;171;170;169;170;171;167;168;166;170;171 18:42:40 INFO - PROCESS | 24141 | |13;stanford-crypto-sha256-iterative;67;70;68;66;66;66;74;74;66;67 18:42:40 INFO - PROCESS | 24141 | __end_tp_report 18:42:40 INFO - PROCESS | 24141 | __start_cc_report 18:42:40 INFO - PROCESS | 24141 | _x_x_mozilla_cycle_collect,1702 18:42:40 INFO - PROCESS | 24141 | __end_cc_report 18:42:40 INFO - PROCESS | 24141 | __startTimestamp1476754960822__endTimestamp 18:42:40 INFO - PROCESS | 24141 | 18:42:40 INFO - PROCESS | 24141 | ------- Summary: start ------- 18:42:40 INFO - PROCESS | 24141 | Number of tests: 14 18:42:40 INFO - PROCESS | 24141 | 18:42:40 INFO - PROCESS | 24141 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:2.57 (2.3%) stddev-sans-first:1.01 18:42:40 INFO - PROCESS | 24141 | Values: 104.0 112.0 111.0 111.0 113.0 110.0 112.0 111.0 111.0 113.0 18:42:40 INFO - PROCESS | 24141 | 18:42:40 INFO - PROCESS | 24141 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:130.00 stddev:12.97 (10.0%) stddev-sans-first:13.23 18:42:40 INFO - PROCESS | 24141 | Values: 144.0 133.0 124.0 153.0 126.0 127.0 124.0 125.0 158.0 125.0 18:42:40 INFO - PROCESS | 24141 | 18:42:40 INFO - PROCESS | 24141 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.84 (0.5%) stddev-sans-first:0.88 18:42:40 INFO - PROCESS | 24141 | Values: 162.0 161.0 162.0 162.0 160.0 161.0 162.0 163.0 161.0 162.0 18:42:40 INFO - PROCESS | 24141 | 18:42:40 INFO - PROCESS | 24141 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.50 stddev:15.34 (20.1%) stddev-sans-first:16.12 18:42:40 INFO - PROCESS | 24141 | Values: 77.0 75.0 76.0 122.0 76.0 78.0 77.0 76.0 98.0 75.0 18:42:40 INFO - PROCESS | 24141 | 18:42:40 INFO - PROCESS | 24141 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:83.00 stddev:16.24 (19.6%) stddev-sans-first:16.86 18:42:40 INFO - PROCESS | 24141 | Values: 83.0 82.0 125.0 83.0 83.0 82.0 103.0 83.0 84.0 116.0 18:42:40 INFO - PROCESS | 24141 | 18:42:40 INFO - PROCESS | 24141 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 18:42:40 INFO - PROCESS | 24141 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 18:42:40 INFO - PROCESS | 24141 | 18:42:40 INFO - PROCESS | 24141 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 18:42:40 INFO - PROCESS | 24141 | Values: 145.0 146.0 146.0 145.0 145.0 147.0 145.0 145.0 145.0 146.0 18:42:40 INFO - PROCESS | 24141 | 18:42:40 INFO - PROCESS | 24141 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 18:42:40 INFO - PROCESS | 24141 | Values: 85.0 85.0 85.0 85.0 85.0 85.0 84.0 84.0 85.0 84.0 18:42:40 INFO - PROCESS | 24141 | 18:42:40 INFO - PROCESS | 24141 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:0.57 (1.1%) stddev-sans-first:0.50 18:42:40 INFO - PROCESS | 24141 | Values: 53.0 51.0 52.0 52.0 52.0 52.0 52.0 52.0 52.0 53.0 18:42:40 INFO - PROCESS | 24141 | 18:42:40 INFO - PROCESS | 24141 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 18:42:40 INFO - PROCESS | 24141 | Values: 59.0 59.0 58.0 59.0 58.0 59.0 60.0 60.0 60.0 59.0 18:42:40 INFO - PROCESS | 24141 | 18:42:40 INFO - PROCESS | 24141 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:0.47 (0.6%) stddev-sans-first:0.50 18:42:40 INFO - PROCESS | 24141 | Values: 80.0 80.0 80.0 81.0 80.0 80.0 79.0 80.0 80.0 80.0 18:42:40 INFO - PROCESS | 24141 | 18:42:40 INFO - PROCESS | 24141 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:133.50 stddev:13.63 (10.2%) stddev-sans-first:14.19 18:42:40 INFO - PROCESS | 24141 | Values: 129.0 133.0 135.0 131.0 132.0 127.0 130.0 139.0 174.0 134.0 18:42:40 INFO - PROCESS | 24141 | 18:42:40 INFO - PROCESS | 24141 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:170.00 stddev:1.77 (1.0%) stddev-sans-first:1.76 18:42:40 INFO - PROCESS | 24141 | Values: 171.0 170.0 169.0 170.0 171.0 167.0 168.0 166.0 170.0 171.0 18:42:40 INFO - PROCESS | 24141 | 18:42:40 INFO - PROCESS | 24141 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:67.50 stddev:3.20 (4.7%) stddev-sans-first:3.36 18:42:40 INFO - PROCESS | 24141 | Values: 67.0 70.0 68.0 66.0 66.0 66.0 74.0 74.0 66.0 67.0 18:42:40 INFO - PROCESS | 24141 | -------- Summary: end -------- 18:42:40 INFO - PROCESS | 24141 | 18:42:42 INFO - TEST-INFO | 24141: exit 0 18:42:42 INFO - TEST-OK | kraken | took 61197ms 18:42:42 INFO - SUITE-END | took 1178s 18:42:42 INFO - Completed test suite (00:19:39) 18:42:42 INFO - javascript benchmark 18:42:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2931.5749216363624, 2993.9221880123146, 3017.7284044436024, 3053.541968704694, 3064.4483992881287, 5142.460041695625, 5199.324087868572, 5217.321748172737, 5300.734963251836, 5417.431169727176, 5258.947410525893, 5260.8158714445, 5348.732563371826, 5369.060414427469, 5431.049566325887, 4745.264484004984, 4751.548602882721, 4791.640626952975, 4811.783469743852, 4845.152098382769, 4787.593054590364, 4812.879678008043, 4862.319275301443, 4864.854054378375, 4923.655344125913, 4653.767311634405, 4829.710217386968, 4830.903381932377, 4845.975770121145, 4945.554900058994, 4681.040386720714, 4742.549457801503, 4761.309610106549, 4769.165396055676, 4771.403574553181, 4740.762961851894, 4743.739094349809, 4744.833930812405, 4791.904161916777, 4825.324454576362, 5210.6613070150315, 5253.658512196695, 5256.9737151314, 5262.210668399771, 5263.078961181778, 5362.142057270857, 5383.838484845461, 5385.569154467633, 5491.505764481216, 5599.216109744639, 5566.805161819317, 5576.553875689935, 5605.915911261334, 5655.519280861132, 5662.292213473316, 5213.635045546814, 5224.346956630421, 5224.72302973999, 5231.110711179109, 5234.973825130888, 5506.504414602705, 5510.0, 5681.119426488901, 5694.0, 5748.109043098327, 5316.65441746293, 5369.570434365241, 5370.3287089113865, 5409.0, 5471.671699697951, 5578.135389014709, 5583.581231407661, 5583.748731307101, 5607.0, 5645.774169033192, 5552.472515111058, 5555.944440555623, 5561.5272701820795, 5562.16567514876, 5562.888742225133, 5404.297441332602, 5438.864028399322, 5443.673379597237, 5571.1086226203615, 5581.441855814386, 4300.03249268912, 4303.63419109373, 4305.892352691208, 4306.246406878784, 4308.0306930940915, 3875.244327356195, 3875.8837234883, 3883.10688541637, 3884.4561761353434, 3884.9223015539533, 5291.470852914755, 5292.867678308073, 5293.364796224478, 5297.761600727977, 5301.416844147141, 5556.972215138899, 5596.412376700469, 5612.719364031782, 5616.297962754656, 5624.91562626561, 5285.101532739443, 5303.992241474108, 5308.0445519806035, 5310.283111779938, 5312.096943519611, 4783.258594917794, 4788.04239152171, 4817.253325734517, 4819.879503012383, 4843.321934929113, 5862.267216597926, 5865.472107510259, 5869.706514674249, 5870.354261031283, 5874.206982057453, 5419.729013549386, 5631.915521267266, 5634.464725851038, 5636.323641163087, 5641.887162256814, 5639.125935480007, 5843.474087332161, 5916.615419997686, 5923.822285331447, 6013.428724271187, 5591.944080559142, 5592.0, 5600.859978500407, 5601.187827764869, 5626.409227031103, 5695.0603150481365, 5714.200011998407, 5718.542516598745, 5723.542116630576, 5724.0555308375315, 5348.491893270133, 5406.080966235828, 5421.484958928895, 5455.263539422127, 5480.945190548044, 5508.779648814163, 5516.365617953987, 5517.475839795213, 5524.447555244444, 5573.749181286771, 5497.505224529811, 5498.395176530498, 5501.779928802963, 5505.587080968863, 5543.473370029841, 5381.1121165007335, 5415.918761218663, 5479.643823151482, 5535.3357597087, 5547.722613869371, 5488.204210389391, 5488.396276409512, 5490.890182196254, 5529.723513824373, 5549.278593782782], "value": 5174.2985472534765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.3180102186323, 593.4658807073633, 609.0985341694291, 611.2664802237314, 632.91772069631, 31515.369692606164, 42668.57331426688, 43594.34608480871, 43674.12651746963, 47601.52398476014, 43385.78307108468, 43776.781116094375, 43806.0, 43851.78074109625, 43858.0, 8133.0, 8828.646854125844, 8981.101889811032, 8991.415557988743, 8994.235489983359, 7959.2836644701965, 10488.947555262252, 10763.461826908624, 10767.515461804238, 11056.502457389397, 10942.781144377108, 10996.890031099667, 11002.394868282281, 11003.22977391579, 11006.944965275163, 10762.677119686421, 10788.892111078945, 10816.945915270373, 10834.187435942336, 10845.0, 10668.679939601825, 10711.196660250513, 10729.892701072968, 10730.839037414446, 10734.302270352402, 42303.0, 42313.57686423127, 42319.0, 42403.0, 42777.144457110684, 3362.899113026613, 3427.456484841233, 3544.9822750886083, 3627.292677927805, 3723.4228694552116, 31799.20501987446, 32178.678213218038, 32319.83840080808, 32419.189520261945, 32880.0, 4237.279662457358, 4288.914221715549, 4467.218236808546, 4510.661700372485, 4580.908381832378, 202513.0, 202523.0, 202537.0, 203555.0, 205113.0, 34832.82583587117, 35866.82066589651, 62149.68925155436, 62936.68531657404, 63067.0, 34433.311333773185, 35096.12259693528, 35172.824135879666, 35265.64734352624, 35358.292834143685, 13873.791893121612, 13880.444782208599, 13885.444582216598, 13888.652783680287, 13897.0966887152, 11363.727254549123, 11688.649340519798, 12159.817602735966, 12165.75668486643, 12687.175333603287, 8270.090290068089, 8324.29243514296, 8441.733739939058, 8443.366747493963, 8443.746687599381, 3227.7740558160704, 3252.3332716793, 3267.591551056118, 3294.2917272786467, 3353.0611428799975, 969.699393188114, 992.6972273456665, 1020.1481762728057, 1041.682286902502, 1056.3133962924007, 31010.0, 31695.84152079271, 31761.841190793897, 32434.35131297408, 32652.83673581617, 1044.3003187863997, 1045.5660900726114, 1063.984040239397, 1077.0468135699805, 1123.4102096399456, 16256.431024914307, 17140.914295428443, 17143.399981000854, 17181.883177593416, 17266.913665431843, 463986.0, 467940.0, 468497.0, 471519.0, 472608.0, 57121.428785712444, 57479.712601436724, 57628.42371576231, 57726.7113664429, 57735.422645773004, 1179.422083179236, 1225.8651548329676, 1250.8061250506187, 1267.923924564529, 1291.9612411627666, 29358.559621605265, 32826.50760238646, 33064.50403243905, 33283.50074748929, 33578.097188273576, 49974.25038624496, 50427.243591345425, 50519.74740126276, 50522.49477505178, 50568.49431505638, 366745.0, 366995.0, 367547.0, 368974.0, 369541.0, 27705.0, 28085.43829123365, 28239.858800705864, 28251.717482824908, 28736.712632873405, 46647.533524665676, 47160.7641961788, 48807.511924880295, 52400.47599524108, 52846.47153528415, 39683.60316396799, 40491.79754101211, 40698.0, 41310.586894130676, 42821.57178428176, 41273.380899287135, 41882.897560199686, 42329.57670423256, 42436.363454548824, 42653.786731066146, 40907.0, 42051.36922946097, 42555.3616695756, 42566.0, 42638.0, 32295.35409291848, 34532.0, 35017.0, 35262.47106293459, 35290.0, 27000.71882113375, 27560.724392755816, 27617.0, 28284.854563691468, 28810.27974300659], "value": 18624.72375300901, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.8862652577703, 369.89642899987996, 385.3449136468004, 389.1205874723126, 416.51476030424556, 14270.785938210922, 18046.639067218646, 18917.52706182348, 18999.145038473267, 20251.898740506313, 18652.440426787183, 19132.234710611592, 19369.22523099074, 19493.610127797434, 19536.609267814634, 5482.122860342336, 5754.568407369443, 5757.280339957505, 5757.740901659415, 5757.740901659436, 4176.14389050244, 4270.081932384537, 4389.868303950887, 5611.831645050655, 6377.553571250014, 6399.93600063998, 6401.967990160043, 6408.327125651809, 6408.6154830710075, 6419.775307864225, 6117.0, 6254.8123556293385, 6279.120923070774, 6284.27730810958, 6430.582012169218, 5396.973015134939, 5571.832845014656, 5573.637713548606, 5577.135543990688, 5578.41426650204, 21013.579728405348, 21722.782772172235, 23041.423964400856, 23466.64800028001, 23482.178123765756, 2159.0, 2168.7722789107233, 2244.326701989413, 2291.1293708390704, 2809.1893822164157, 9723.756906077333, 10108.94945525275, 10365.429901355423, 10608.310459820086, 10647.57409703611, 1747.6242607839376, 1851.2872544070494, 1903.5057479878228, 1908.7900330963582, 1932.9130189141522, 78135.60932195303, 78395.6080219601, 78900.60549697273, 79664.60167699182, 81486.18513814904, 10459.215558833119, 10612.20408469368, 10819.621313253998, 10835.241533092765, 11005.394703291397, 15241.847581524265, 15243.314050867737, 15289.9235503824, 15295.617609559627, 15321.310541025681, 7740.7677769667, 7932.484388514728, 8137.349012079019, 8138.064122625856, 8247.546384948886, 7630.847383052308, 7805.609719514002, 7964.123946365895, 8020.5588692621295, 8034.076081250731, 4626.1210370029585, 4638.257878739453, 4646.372739680168, 4659.370984916993, 4731.651479328375, 1824.042377751691, 1881.2851116575887, 1912.254220853868, 1915.9042047897549, 1938.8642795004214, 913.6939125392935, 966.12083004467, 993.4039576254189, 1003.3561565275552, 1050.3120456101267, 18930.81069189318, 19341.323053693053, 19446.180303856145, 19563.0, 19946.20215191405, 972.8005758819424, 985.1576901749045, 991.7520619845038, 1005.6982905128432, 1043.9039009040478, 10158.593656253666, 10713.571457141627, 10871.945640271906, 10945.343279403261, 10980.945095274472, 410845.0, 412608.0, 427901.0, 428066.0, 428643.0, 85637.0, 86272.70590941141, 86674.0, 91300.0, 92130.53934730284, 997.2022382094295, 1018.0989824005808, 1066.7706443114769, 1087.228068071678, 1089.1504626391427, 16140.273687683848, 16879.493615191564, 17984.550386240448, 18048.917064976144, 18082.276708931495, 40813.591864080976, 41116.0, 41431.37852932269, 41922.37116443317, 42323.3651495234, 51005.0, 51453.22820157775, 52214.73892630512, 59019.0, 60289.69855150696, 8101.230383113595, 8152.429329946846, 8203.261706446448, 8420.242178203991, 8519.829603408021, 9415.529223538659, 12343.13598048128, 12769.553065642658, 12883.420246089136, 12956.805647915477, 11023.228374013743, 11086.889131108586, 11298.60454884108, 11354.602588909349, 11754.353510557, 10876.456177191267, 11099.889001110208, 11181.32912025281, 11191.216614837209, 11209.495572699085, 10946.17903657213, 11423.828642570203, 11471.770564588829, 11531.0, 11616.94191529037, 7961.800954976172, 8012.439129261129, 8145.592720364077, 8160.8775868360835, 8484.787880303042, 8579.742607721779, 10557.63048293306, 11367.943160284145, 11461.942690286494, 11921.761564768483], "value": 9028.59307106097, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.728020755745, 1421.403010735491, 1473.4695509616536, 1586.3892401425455, 1762.6650936322098, 7496.6251687415615, 8338.332933365331, 8675.219230269275, 8675.436096653713, 8935.1958323751, 8810.07494213108, 8840.071792461778, 8895.777605559864, 8900.732978010654, 8904.688335908244, 2303.216906251874, 2330.743618202005, 2333.439974406139, 2335.532893421314, 2338.1465764995737, 2278.200221824756, 2316.200910685811, 2347.1784875293597, 2347.2371479269223, 2348.9530209395803, 2283.828712846535, 2293.7591552886956, 2305.72331320241, 2314.29414028722, 2318.13070098713, 2245.9438514037115, 2246.9887650561805, 2247.292102987562, 2247.6291411917014, 2256.2852232303403, 2225.833062520301, 2233.0286325448483, 2239.55208958209, 2243.1924507177405, 2253.8084262837515, 8507.872381914214, 8606.268467180296, 8624.180702833284, 8675.913240867574, 8734.0, 5115.948840511584, 5354.866128346784, 5362.24928510005, 5366.034113859504, 5376.327959005124, 3403.795772253648, 3464.7921124732343, 3504.246586983785, 3510.613832478425, 3566.821658917044, 1049.1606714628342, 1096.030013438105, 2006.7792542820278, 2017.0822275864446, 2018.5054661607853, 11596.188266821326, 11696.766064678744, 11732.17874748768, 11745.882541174478, 11798.292102473879, 4180.205760905479, 4238.682098842599, 4361.847335343311, 4370.650347972155, 4418.337249412614, 9136.269098472107, 9199.4940278284, 9206.355555111079, 9215.124563166622, 9217.262618990464, 5010.5240002199735, 5011.09800235961, 5011.423686276052, 5014.323066385991, 5017.147084995559, 4226.4928208615165, 4346.326319420495, 4691.038337140878, 4756.072565849626, 4891.095147397743, 3621.8008009559726, 3654.6528079832374, 3707.3882809336696, 3718.5165928429674, 3774.1885494618787, 1109.778044391125, 1114.1198453222025, 1119.798436281461, 1125.0, 1134.0587312530579, 841.7759979279467, 853.7609469348592, 865.3293697384578, 896.6010125494223, 941.8869735631631, 5650.378458369576, 5687.090065589486, 5771.451712087345, 5803.361630220672, 5928.644281343133, 911.6626848066257, 918.2653876898454, 923.2198792020732, 942.2179590939504, 974.356924429887, 3802.4486449465226, 3872.1287710264965, 3913.8238779255003, 3979.9602003980167, 4003.6187515307174, 10577.62978295756, 11076.446177691083, 11079.889201107886, 11095.44522773858, 11142.665720028412, 11041.723956900982, 11043.72390690223, 11047.447627618747, 11063.336199827874, 11064.557417703363, 7614.961925190339, 7933.651279282421, 8001.839963200703, 8040.8793868092025, 8202.261796438468, 5677.148427735872, 5712.714364281853, 5841.766329346949, 5870.412958704095, 5964.403559644001, 9755.122039016522, 9968.651097211563, 10074.848877266993, 10083.142932850496, 10255.179585632983, 9919.553620086968, 10274.075333220046, 10310.381377117397, 10360.067593916583, 10360.171186304926, 7729.381649467917, 7905.486143400661, 7970.40221983342, 7986.241307075818, 8012.879806803019, 8461.78845528842, 8478.150583413673, 8542.871856922275, 8545.102764209669, 8563.843881075974, 7653.081630204411, 7720.0, 7730.11103723079, 7764.961175194087, 7929.603519824101, 7348.008018917378, 7356.301151390609, 7358.889616655862, 7409.073865766779, 7547.660355283915, 6784.253732089565, 6900.2409734928115, 6903.102596662402, 6903.378695917391, 6903.792886213421, 4842.394700662418, 4865.635077369141, 4915.3855768029, 4939.851804445872, 5079.644424890223, 4991.0, 5009.749512524287, 5224.0, 5232.136697445031, 5235.502627250406], "value": 4575.715344774985, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.01732646123475, 326.7239182890458, 327.25386119647203, 334.8359303941068, 342.33757678891334, 5074.517920797528, 5164.354455693038, 5268.315119034525, 5275.788968441268, 5301.708406037671, 5064.670796398241, 5191.714455704935, 5191.844244672666, 5203.219517072441, 5206.661566998152, 4093.22228776533, 4106.589341065885, 4109.0, 4117.773522456264, 4119.649829764474, 3885.5235010695897, 4059.4316795648633, 4098.8565400211, 4099.856505022325, 4105.4252404663375, 4029.5567487576345, 4043.3328500797334, 4053.27041132596, 4064.0, 4064.2887494688457, 4031.97984010081, 4039.7476782197614, 4056.7971601419813, 4063.309237429644, 4087.9795601021806, 3624.782513049199, 3625.6011838697723, 3637.836297366625, 3638.9818050909576, 3641.1261297288725, 5027.698338099725, 5062.974685126551, 5090.745462726886, 5120.180771076647, 5122.129238029544, 4665.510121437268, 4668.43978722552, 4673.0, 4687.484376718558, 4690.061987602459, 5450.174191645803, 5457.263269458612, 5464.508194262536, 5481.698506582136, 5497.388740348342, 3858.961410385916, 3951.38753493209, 3967.8809635710977, 3968.444417781513, 3974.205158968218, 5656.208130861683, 5675.148727690838, 5691.459311365414, 5692.288463942007, 5693.487586117228, 4035.1929614077303, 4040.9595904040584, 4048.291548978917, 4048.8785336439955, 4064.7764372959773, 4001.4998125234347, 4056.006278461796, 4075.1849630074103, 4108.8356465741035, 4120.505539335299, 4585.908281834411, 4637.559431853969, 4659.627229821674, 4660.836870709509, 4677.2750223715375, 5445.1611613812165, 5467.671939683552, 5468.152436372368, 5474.835754927359, 5501.257330260443, 1265.6519457149172, 1300.382318398772, 1382.4401117547409, 1392.1647011792843, 1415.214555921453, 940.1068984464649, 957.3250858144991, 971.140540621555, 976.3556053004983, 977.9559919803626, 5224.0, 5260.868478287997, 5271.973640131775, 5274.340707411574, 5328.893422131536, 5568.303962004749, 5576.275084239023, 5598.4961353477565, 5604.3835178130375, 5616.157576363578, 5117.923231151536, 5197.402298735694, 5275.287836142148, 5277.601435619564, 5281.894362112736, 2650.310919161032, 2653.567073780137, 2656.3624730064644, 2668.5596876515156, 2669.8932042718075, 5104.804933878468, 5106.591472682177, 5134.640575159778, 5170.482951704875, 5182.300389447451, 4870.407015093254, 4958.404991400983, 5067.797288108434, 5068.949310506848, 5090.185570308807, 5149.2276158576515, 5152.042223954873, 5184.611154163528, 5185.429602743695, 5190.987757387274, 4979.775910084128, 4995.325631039763, 4996.576660319814, 5002.674826136289, 5023.146065168857, 4945.145570411096, 5222.869428264324, 5645.633033852787, 5676.9432305678065, 5681.602287839812, 5933.199018132497, 5941.22764040672, 5943.779916259504, 5945.256842894638, 5954.0, 4034.6080602192196, 4083.2037752637953, 4087.2234275487563, 4097.078157414558, 4098.057446787315, 5417.918731218956, 5430.456954304538, 5685.658860468385, 5698.572607054404, 5719.542436605145, 5327.733613319396, 5400.975453745915, 5492.80775172867, 5498.367687715964, 5533.972330138324, 5476.205950137128, 5478.8904221914545, 5499.807506737245, 5502.5597952164535, 5514.724263786715, 5286.550643195372, 5405.648632838853, 5465.754041068241, 5473.151661492475, 5474.863128421821, 5485.4788795064405, 5499.0, 5506.81603455259, 5515.448455154613, 5516.475934786189, 5383.757730902197, 5389.2455056291365, 5396.9190462142315, 5422.725659469943, 5429.701366424727], "value": 4120.272695763399, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.780165950215, 754.5133388964122, 784.811645205151, 788.3535500889274, 832.9875051874221, 15846.445374411884, 16803.0758308293, 16813.075280859546, 16943.83056169438, 17057.232424540893, 15147.6970460591, 15258.618534536643, 15274.770878436804, 15282.617934551641, 15341.539753807376, 661.163628010567, 682.8975653651967, 770.0489894979723, 799.9760007199793, 800.7157459102023, 801.3549092980148, 801.9518828870257, 802.4823988527396, 802.7070119406433, 803.2008151888849, 848.088305072047, 851.4508142248246, 851.6848765956573, 852.2287329966359, 853.3727710133047, 691.0532570378589, 712.9073220481304, 832.4297855968681, 846.7163500227431, 850.5789634131145, 624.7813265357134, 626.2297374229723, 630.1587380846576, 630.7571584939831, 631.2645767680647, 15142.470013549473, 15148.1668508232, 15177.924110379488, 15217.923910380488, 15251.161186134757, 13923.443062277496, 14179.858201417957, 14384.71230575393, 14398.92800536001, 14668.339924703307, 12757.234565926074, 12758.106932514727, 13016.219026858418, 13068.346582670829, 13510.662233444144, 4304.375865499516, 4459.9331010034875, 4474.791806212304, 4481.57805688808, 4609.631229501631, 75739.24260757433, 75813.0, 76442.61778691127, 76578.1710914452, 76783.0, 11053.668389948314, 11070.446477676083, 11167.776644467065, 11393.544258229578, 11543.653690389301, 21801.563968720537, 21829.345119646438, 21937.34187974363, 22057.0, 22321.21875734374, 8347.707830226034, 8394.202550757669, 8423.241908228289, 8453.492790432594, 8589.0, 4435.246008178618, 4438.778061096932, 4565.56627120423, 4576.771161441981, 4657.0918670858855, 3447.224374515714, 3531.285866941043, 3561.234334618018, 3563.429851223792, 3632.6730594246646, 625.562106525434, 636.9363063693594, 641.112059797175, 677.3971165662564, 704.5490885832968, 562.5752556819575, 591.104476717773, 651.547174713579, 698.2389195776628, 746.5110352718978, 9377.812443751223, 9671.90328096724, 9678.854817177747, 9827.17011676892, 10123.898761012442, 584.7777844419179, 695.4193248637343, 726.1866709285634, 734.219483073813, 747.6112421540769, 4354.7822608870065, 4455.554444555519, 4543.432070991126, 4773.198490475953, 4775.331453596499, 87393.56303218444, 90877.54561227151, 91963.54018229866, 117362.0, 120298.3985080069, 86978.0, 90185.09814901899, 90993.0, 91735.5413222943, 92554.0, 51585.16281604548, 67106.0, 77336.61331693418, 78886.0, 80258.0, 9065.773355665897, 10015.24885633595, 10113.14038306752, 10173.796524069328, 10376.948115259376, 47733.0, 49113.508864910895, 49539.0, 49731.75134124306, 50466.49533504618, 66388.37368581432, 67399.3260067393, 70373.0, 73933.63033184799, 74283.25716742764, 13107.803382949072, 13454.798178027142, 13498.460061597427, 13711.177329360271, 13746.587602371945, 14766.261686915397, 15040.849591503946, 15368.615784605474, 15642.296096675449, 15895.841041589898, 13282.203067815575, 14056.048229871842, 14186.304602125563, 14471.27643617836, 15180.544583662508, 14134.50529231472, 14269.357878895267, 14371.92814035923, 14660.70678586401, 14668.55994320172, 13216.506387828185, 13443.731125377242, 13878.653033673834, 13934.79097813554, 14821.777673334693, 10633.680989570325, 10922.50848711794, 11045.171612128961, 11071.944640276746, 11742.295462272292, 11254.94372528132, 11832.585859494877, 12129.150959432754, 12222.388880555758, 12434.689132771753], "value": 7538.465752615842, "unit": "score"}], "name": "dromaeo_css", "value": 7058.497060928024, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 111.0, 111.0, 113.0, 110.0, 112.0, 111.0, 111.0, 113.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 133.0, 124.0, 153.0, 126.0, 127.0, 124.0, 125.0, 158.0, 125.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 160.0, 161.0, 162.0, 163.0, 161.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 122.0, 76.0, 78.0, 77.0, 76.0, 98.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 125.0, 83.0, 83.0, 82.0, 103.0, 83.0, 84.0, 116.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 147.0, 145.0, 145.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 53.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 59.0, 58.0, 59.0, 60.0, 60.0, 60.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 81.0, 80.0, 80.0, 79.0, 80.0, 80.0, 80.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 133.0, 135.0, 131.0, 132.0, 127.0, 130.0, 139.0, 174.0, 134.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 169.0, 170.0, 171.0, 167.0, 168.0, 166.0, 170.0, 171.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 68.0, 66.0, 66.0, 66.0, 74.0, 74.0, 66.0, 67.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1494.2, "alertThreshold": 2.0}]} 18:42:42 INFO - Return code: 0 18:42:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:42:42 INFO - # TBPL SUCCESS # 18:42:42 INFO - Running post-action listener: _resource_record_post_action 18:42:42 INFO - [mozharness: 2016-10-18 01:42:42.643132Z] Finished run-tests step (success) 18:42:42 INFO - Running post-run listener: _resource_record_post_run 18:42:42 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 12288; Write bytes: 392896512; Read time: 240; Write time: 241088 18:42:42 INFO - TinderboxPrint: CPU usage
13.1% 18:42:42 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 240 18:42:42 INFO - TinderboxPrint: I/O write bytes / time
392,896,512 / 241,088 18:42:42 INFO - TinderboxPrint: CPU idle
8,294.0 (86.9%) 18:42:42 INFO - TinderboxPrint: CPU user
1,199.5 (12.6%) 18:42:42 INFO - TinderboxPrint: Swap in / out
0 / 0 18:42:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103727104; Read time: 0; Write time: 60504 18:42:42 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288845824; Read time: 232; Write time: 180580 18:42:43 INFO - Running post-run listener: _upload_blobber_files 18:42:43 INFO - Blob upload gear active. 18:42:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:42:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:42:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:42:43 INFO - (blobuploader) - INFO - Open directory for files ... 18:42:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:42:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:42:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:42:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:42:47 INFO - (blobuploader) - INFO - Done attempting. 18:42:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:42:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:42:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:42:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:42:47 INFO - (blobuploader) - INFO - Done attempting. 18:42:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:42:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:42:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:42:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:42:48 INFO - (blobuploader) - INFO - Done attempting. 18:42:48 INFO - (blobuploader) - INFO - Iteration through files over. 18:42:48 INFO - Return code: 0 18:42:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:42:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:42:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/74ccb04e72e261d207261354c3d75859ab7fc4cf28bb2565f6b4bc432f6548c9d8b8a2400c275b75e30ec5ae5a2909a74dd0144b0f38dd8b8c974ed5abc4aea6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6be14bac992cd1162c19b75c98f50abdfb7fda0220c2a9035fd24c4cc1091f61fa77ca87d384c5ba417671691bbcdd8edc566c1e2cb30953a2f80c74fefb5902", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4aa3cedf7aa258908695f1f7c653cd7a34b7a42a0695fc7851638b45abbf0f01e7ce86019097ad1aa7b33e30db57502a5e60ce534492f3fa23bf21cab2139a83"} 18:42:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:42:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:42:48 INFO - Contents: 18:42:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/74ccb04e72e261d207261354c3d75859ab7fc4cf28bb2565f6b4bc432f6548c9d8b8a2400c275b75e30ec5ae5a2909a74dd0144b0f38dd8b8c974ed5abc4aea6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6be14bac992cd1162c19b75c98f50abdfb7fda0220c2a9035fd24c4cc1091f61fa77ca87d384c5ba417671691bbcdd8edc566c1e2cb30953a2f80c74fefb5902", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4aa3cedf7aa258908695f1f7c653cd7a34b7a42a0695fc7851638b45abbf0f01e7ce86019097ad1aa7b33e30db57502a5e60ce534492f3fa23bf21cab2139a83"} 18:42:48 INFO - Running post-run listener: copy_logs_to_upload_dir 18:42:48 INFO - Copying logs to upload dir... 18:42:48 INFO - mkdir: /builds/slave/test/build/upload/logs 18:42:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.819079 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-17 18:42:48.227476) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 18:42:48.231083) ========= 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=3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/74ccb04e72e261d207261354c3d75859ab7fc4cf28bb2565f6b4bc432f6548c9d8b8a2400c275b75e30ec5ae5a2909a74dd0144b0f38dd8b8c974ed5abc4aea6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6be14bac992cd1162c19b75c98f50abdfb7fda0220c2a9035fd24c4cc1091f61fa77ca87d384c5ba417671691bbcdd8edc566c1e2cb30953a2f80c74fefb5902", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4aa3cedf7aa258908695f1f7c653cd7a34b7a42a0695fc7851638b45abbf0f01e7ce86019097ad1aa7b33e30db57502a5e60ce534492f3fa23bf21cab2139a83"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011421 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476743401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/74ccb04e72e261d207261354c3d75859ab7fc4cf28bb2565f6b4bc432f6548c9d8b8a2400c275b75e30ec5ae5a2909a74dd0144b0f38dd8b8c974ed5abc4aea6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6be14bac992cd1162c19b75c98f50abdfb7fda0220c2a9035fd24c4cc1091f61fa77ca87d384c5ba417671691bbcdd8edc566c1e2cb30953a2f80c74fefb5902", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4aa3cedf7aa258908695f1f7c653cd7a34b7a42a0695fc7851638b45abbf0f01e7ce86019097ad1aa7b33e30db57502a5e60ce534492f3fa23bf21cab2139a83"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 18:42:48.260080) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 18:42:48.260418) ========= 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=3a3620fb28aea1604ab609ef000001d2-1476753388.380194-650833289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 18:42:48.345312) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 18:42:48.345610) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 18:42:48.348952) ========= ========= Total master_lag: 0.17 =========