builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1479888997.61 results: success (0) buildid: 20161123001635 builduid: f845a64664974932a9fd525223995504 revision: ecb49ac1035745fe2c0efc76ec7c65096a34ab89 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 00:16:37.610372) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 00:16:37.610763) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 00:16:37.611224) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 00:16:37.654323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 00:16:37.655060) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-23 00:16:37-- 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% 220M=0s 2016-11-23 00:16:37 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103399 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 00:16:37.778975) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 00:16:37.779328) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019760 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 00:16:37.829463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-23 00:16:37.829817) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ecb49ac1035745fe2c0efc76ec7c65096a34ab89 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ecb49ac1035745fe2c0efc76ec7c65096a34ab89 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-23 00:16:38,043 truncating revision to first 12 chars 2016-11-23 00:16:38,043 Setting DEBUG logging. 2016-11-23 00:16:38,043 attempt 1/10 2016-11-23 00:16:38,044 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/ecb49ac10357?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 00:16:39,392 unpacking tar archive at: mozilla-inbound-ecb49ac10357/testing/mozharness/ program finished with exit code 0 elapsedTime=1.644324 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-23 00:16:39.488456) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 00:16:39.488776) ========= script_repo_revision: ecb49ac1035745fe2c0efc76ec7c65096a34ab89 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 00:16:39.489207) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 00:16:39.489542) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 00:16:39.499992) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-11-23 00:16:39.500411) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:16:39 INFO - MultiFileLogger online at 20161123 00:16:39 in /builds/slave/test 00:16:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 00:16:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:16:39 INFO - {'append_to_log': False, 00:16:39 INFO - 'base_work_dir': '/builds/slave/test', 00:16:39 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 00:16:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:16:39 INFO - 'branch': 'Mozilla-Inbound', 00:16:39 INFO - 'buildbot_json_path': 'buildprops.json', 00:16:39 INFO - 'config_files': ('talos/linux_config.py',), 00:16:39 INFO - 'default_actions': ('clobber', 00:16:39 INFO - 'read-buildbot-config', 00:16:39 INFO - 'download-and-extract', 00:16:39 INFO - 'populate-webroot', 00:16:39 INFO - 'create-virtualenv', 00:16:39 INFO - 'install', 00:16:39 INFO - 'run-tests'), 00:16:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:16:39 INFO - 'download_minidump_stackwalk': True, 00:16:39 INFO - 'download_symbols': 'ondemand', 00:16:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:16:39 INFO - 'tooltool.py': '/tools/tooltool.py', 00:16:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:16:39 INFO - '/tools/misc-python/virtualenv.py')}, 00:16:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:16:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:16:39 INFO - 'installer_path': 'installer.exe', 00:16:39 INFO - 'log_level': 'info', 00:16:39 INFO - 'log_name': 'talos', 00:16:39 INFO - 'log_to_console': True, 00:16:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:16:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:16:39 INFO - 'opt_config_files': (), 00:16:39 INFO - 'pip_index': False, 00:16:39 INFO - 'sps_profile': False, 00:16:39 INFO - 'sps_profile_interval': 0, 00:16:39 INFO - 'suite': 'dromaeojs-e10s', 00:16:39 INFO - 'system_bits': '32', 00:16:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:16:39 INFO - 'title': 'talos-linux64-ix-047', 00:16:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:16:39 INFO - 'use_talos_json': True, 00:16:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:16:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:16:39 INFO - 'work_dir': 'build'} 00:16:39 INFO - [mozharness: 2016-11-23 08:16:39.813565Z] Running clobber step. 00:16:39 INFO - Running pre-action listener: _resource_record_pre_action 00:16:39 INFO - Running main action method: clobber 00:16:39 INFO - rmtree: /builds/slave/test/build 00:16:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:16:40 INFO - Running post-action listener: _resource_record_post_action 00:16:40 INFO - [mozharness: 2016-11-23 08:16:40.267239Z] Finished clobber step (success) 00:16:40 INFO - [mozharness: 2016-11-23 08:16:40.267340Z] Running read-buildbot-config step. 00:16:40 INFO - Running pre-action listener: _resource_record_pre_action 00:16:40 INFO - Running main action method: read_buildbot_config 00:16:40 INFO - Using buildbot properties: 00:16:40 INFO - { 00:16:40 INFO - "project": "", 00:16:40 INFO - "product": "firefox", 00:16:40 INFO - "script_repo_revision": "production", 00:16:40 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 00:16:40 INFO - "repository": "", 00:16:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 00:16:40 INFO - "buildid": "20161123001635", 00:16:40 INFO - "stage_platform": "linux64-pgo", 00:16:40 INFO - "basedir": "/builds/slave/test", 00:16:40 INFO - "buildnumber": 1923, 00:16:40 INFO - "platform": "ubuntu64_hw", 00:16:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:16:40 INFO - "slavebuilddir": "test", 00:16:40 INFO - "branch": "mozilla-inbound", 00:16:40 INFO - "revision": "ecb49ac1035745fe2c0efc76ec7c65096a34ab89", 00:16:40 INFO - "slavename": "talos-linux64-ix-047", 00:16:40 INFO - "builduid": "f845a64664974932a9fd525223995504", 00:16:40 INFO - "repo_path": "integration/mozilla-inbound" 00:16:40 INFO - } 00:16:40 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 00:16:40 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 00:16:40 INFO - Running post-action listener: _resource_record_post_action 00:16:40 INFO - [mozharness: 2016-11-23 08:16:40.269681Z] Finished read-buildbot-config step (success) 00:16:40 INFO - [mozharness: 2016-11-23 08:16:40.269769Z] Running download-and-extract step. 00:16:40 INFO - Running pre-action listener: _resource_record_pre_action 00:16:40 INFO - Running main action method: download_and_extract 00:16:40 INFO - mkdir: /builds/slave/test/build/tests 00:16:40 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')]} 00:16:40 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 00:16:40 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 00:16:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:16:40 INFO - Downloaded 1361 bytes. 00:16:40 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 00:16:40 INFO - Using the following test package requirements: 00:16:40 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 00:16:40 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:16:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:16:40 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:16:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:16:40 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:16:40 INFO - u'jsshell-linux-x86_64.zip'], 00:16:40 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:16:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:16:40 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 00:16:40 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:16:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:16:40 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:16:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:16:40 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:16:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:16:40 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:16:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:16:40 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:16:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 00:16:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:16:40 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:16:40 INFO - Http code: 200 00:16:40 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 00:16:40 INFO - x-amz-cf-id: KDO1o267zDMVCDmIBeR-YJZEQbSUNDr-g-oxtKmLzOibL6IJSBbEGw== 00:16:40 INFO - x-amz-replication-status: COMPLETED 00:16:40 INFO - x-amz-version-id: X9CQgaZp4UlM7zCLAhUHcZaQQJqcVpNE 00:16:42 INFO - Expected file size: 21764645 00:16:42 INFO - Obtained file size: 21764645 00:16:46 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:16:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 00:16:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:16:46 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:16:46 INFO - Http code: 200 00:16:46 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 00:16:46 INFO - x-amz-cf-id: TMYcS-IPzZPiQT6fY8IbmXCFtV87lEe8G7Dw6qSREAZ1mHhXv5qv7A== 00:16:46 INFO - x-amz-replication-status: COMPLETED 00:16:46 INFO - x-amz-version-id: X9CQgaZp4UlM7zCLAhUHcZaQQJqcVpNE 00:16:46 INFO - Expected file size: 21764645 00:16:46 INFO - Obtained file size: 21764645 00:16:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 00:16:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:16:51 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 00:16:51 INFO - Http code: 200 00:16:51 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 00:16:51 INFO - x-amz-cf-id: 2IUnjCzvnv0nfoouJcXloPdlXYZGOZ5RsiGKJnMFA45owN-tduuAeQ== 00:16:51 INFO - x-amz-replication-status: COMPLETED 00:16:51 INFO - x-amz-version-id: tFZNkWKn1JBLCb6VI1bk1XEOMJ7W9eco 00:16:54 INFO - Expected file size: 14409506 00:16:54 INFO - Obtained file size: 14409506 00:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:16:54 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 00:16:54 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 00:16:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:16:58 INFO - Downloaded 59732436 bytes. 00:16:58 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 00:16:58 INFO - mkdir: /builds/slave/test/properties 00:16:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:16:58 INFO - Writing to file /builds/slave/test/properties/build_url 00:16:58 INFO - Contents: 00:16:58 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 00:16:59 INFO - Running post-action listener: _resource_record_post_action 00:16:59 INFO - Running post-action listener: set_extra_try_arguments 00:16:59 INFO - [mozharness: 2016-11-23 08:16:59.191489Z] Finished download-and-extract step (success) 00:16:59 INFO - [mozharness: 2016-11-23 08:16:59.191726Z] Running populate-webroot step. 00:16:59 INFO - Running pre-action listener: _resource_record_pre_action 00:16:59 INFO - Running main action method: populate_webroot 00:16:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:16:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:16:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:16:59 INFO - '--tppagecycles', 00:16:59 INFO - '7'], 00:16:59 INFO - 'tests': ['tsvgm']}}, 00:16:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:16:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:16:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:16:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:16:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:16:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:16:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 00:16:59 INFO - 'talos_options': ['--disable-e10s'], 00:16:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:16:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:16:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:16:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 00:16:59 INFO - 'talos_options': ['--disable-e10s'], 00:16:59 INFO - 'tests': ['damp', 'tps']}, 00:16:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:16:59 INFO - 'tests': ['damp', 'tps']}, 00:16:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:16:59 INFO - 'tests': ['dromaeo_dom']}, 00:16:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:16:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:16:59 INFO - 'tests': ['basic_compositor_video']}, 00:16:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:16:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:16:59 INFO - 'tests': ['a11yr', 00:16:59 INFO - 'ts_paint', 00:16:59 INFO - 'tpaint', 00:16:59 INFO - 'sessionrestore', 00:16:59 INFO - 'sessionrestore_no_auto_restore', 00:16:59 INFO - 'tabpaint']}, 00:16:59 INFO - 'other-e10s': {'tests': ['a11yr', 00:16:59 INFO - 'ts_paint', 00:16:59 INFO - 'tpaint', 00:16:59 INFO - 'sessionrestore', 00:16:59 INFO - 'sessionrestore_no_auto_restore', 00:16:59 INFO - 'tabpaint']}, 00:16:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:16:59 INFO - 'ts_paint', 00:16:59 INFO - 'tpaint', 00:16:59 INFO - 'sessionrestore', 00:16:59 INFO - 'sessionrestore_no_auto_restore', 00:16:59 INFO - 'tabpaint']}, 00:16:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:16:59 INFO - 'ts_paint', 00:16:59 INFO - 'tpaint', 00:16:59 INFO - 'sessionrestore', 00:16:59 INFO - 'sessionrestore_no_auto_restore', 00:16:59 INFO - 'tabpaint']}, 00:16:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:16:59 INFO - 'tests': ['a11yr', 00:16:59 INFO - 'ts_paint', 00:16:59 INFO - 'tpaint', 00:16:59 INFO - 'sessionrestore', 00:16:59 INFO - 'sessionrestore_no_auto_restore', 00:16:59 INFO - 'tabpaint']}, 00:16:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:16:59 INFO - 'tests': ['a11yr', 00:16:59 INFO - 'ts_paint', 00:16:59 INFO - 'tpaint', 00:16:59 INFO - 'sessionrestore', 00:16:59 INFO - 'sessionrestore_no_auto_restore', 00:16:59 INFO - 'tabpaint']}, 00:16:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:16:59 INFO - 'tests': ['tsvgx', 00:16:59 INFO - 'tsvgr_opacity', 00:16:59 INFO - 'tart', 00:16:59 INFO - 'tscrollx', 00:16:59 INFO - 'cart']}, 00:16:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:16:59 INFO - 'tsvgr_opacity', 00:16:59 INFO - 'tart', 00:16:59 INFO - 'tscrollx', 00:16:59 INFO - 'cart']}, 00:16:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 00:16:59 INFO - 'talos_options': ['--disable-e10s'], 00:16:59 INFO - 'tests': ['tp5o']}, 00:16:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:16:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 00:16:59 INFO - 'talos_options': ['--disable-e10s', 00:16:59 INFO - '--xperf_path', 00:16:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:16:59 INFO - 'tests': ['tp5n']}, 00:16:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:16:59 INFO - 'talos_options': ['--xperf_path', 00:16:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:16:59 INFO - 'tests': ['tp5n']}}, 00:16:59 INFO - 'talos.zip': {'path': '', 00:16:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:16:59 INFO - Running post-action listener: _resource_record_post_action 00:16:59 INFO - [mozharness: 2016-11-23 08:16:59.211246Z] Finished populate-webroot step (success) 00:16:59 INFO - [mozharness: 2016-11-23 08:16:59.211341Z] Running create-virtualenv step. 00:16:59 INFO - Running pre-action listener: _resource_record_pre_action 00:16:59 INFO - Running main action method: create_virtualenv 00:16:59 INFO - Creating virtualenv /builds/slave/test/build/venv 00:16:59 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 00:16:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:16:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:16:59 INFO - Using real prefix '/usr' 00:16:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:16:59 INFO - Installing distribute.............................................................................................................................................................................................done. 00:17:01 INFO - Installing pip.................done. 00:17:01 INFO - Return code: 0 00:17:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:17:01 INFO - Reading from file tmpfile_stdout 00:17:01 INFO - Output received: 00:17:01 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) 00:17:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:06 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 0x7fefce89ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2982130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a10fc0>, '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 0x2a11ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a12350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', '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 00:17:07 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 00:17:07 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 00:17:07 INFO - Using env: {'DISPLAY': ':0', 00:17:07 INFO - 'HOME': '/home/cltbld', 00:17:07 INFO - 'LANG': 'en_US.UTF-8', 00:17:07 INFO - 'LANGUAGE': 'en_US:en', 00:17:07 INFO - 'LOGNAME': 'cltbld', 00:17:07 INFO - 'MAIL': '/var/mail/cltbld', 00:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:07 INFO - 'MOZ_NO_REMOTE': '1', 00:17:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:07 INFO - 'NO_EM_RESTART': '1', 00:17:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:07 INFO - 'PWD': '/builds/slave/test', 00:17:07 INFO - 'SHELL': '/bin/bash', 00:17:07 INFO - 'SHLVL': '1', 00:17:07 INFO - 'TERM': 'linux', 00:17:07 INFO - 'TMOUT': '86400', 00:17:07 INFO - 'USER': 'cltbld', 00:17:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', 00:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:07 INFO - '_': '/tools/buildbot/bin/python'} 00:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:17:07 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 00:17:07 INFO - Cleaning up... 00:17:07 INFO - Return code: 0 00:17:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:17:07 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')]} 00:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:07 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')]} 00:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:07 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 0x7fefce89ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2982130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a10fc0>, '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 0x2a11ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a12350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', '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 00:17:07 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 00:17:07 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 00:17:07 INFO - Using env: {'DISPLAY': ':0', 00:17:07 INFO - 'HOME': '/home/cltbld', 00:17:07 INFO - 'LANG': 'en_US.UTF-8', 00:17:07 INFO - 'LANGUAGE': 'en_US:en', 00:17:07 INFO - 'LOGNAME': 'cltbld', 00:17:07 INFO - 'MAIL': '/var/mail/cltbld', 00:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:07 INFO - 'MOZ_NO_REMOTE': '1', 00:17:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:07 INFO - 'NO_EM_RESTART': '1', 00:17:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:07 INFO - 'PWD': '/builds/slave/test', 00:17:07 INFO - 'SHELL': '/bin/bash', 00:17:07 INFO - 'SHLVL': '1', 00:17:07 INFO - 'TERM': 'linux', 00:17:07 INFO - 'TMOUT': '86400', 00:17:07 INFO - 'USER': 'cltbld', 00:17:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', 00:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:07 INFO - '_': '/tools/buildbot/bin/python'} 00:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:17:07 INFO - Downloading/unpacking psutil>=3.1.1 00:17:07 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 00:17:07 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 00:17:07 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 00:17:07 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 00:17:07 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 00:17:07 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 00:17:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:17:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:17:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:17:09 INFO - Installing collected packages: psutil 00:17:09 INFO - Running setup.py install for psutil 00:17:09 INFO - building 'psutil._psutil_linux' extension 00:17:09 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 00:17:09 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 00:17:09 INFO - building 'psutil._psutil_posix' extension 00:17:09 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 00:17:09 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 00:17:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:17:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:17:09 INFO - Successfully installed psutil 00:17:09 INFO - Cleaning up... 00:17:10 INFO - Return code: 0 00:17:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:10 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 0x7fefce89ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2982130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a10fc0>, '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 0x2a11ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a12350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', '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 00:17:10 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 00:17:10 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 00:17:10 INFO - Using env: {'DISPLAY': ':0', 00:17:10 INFO - 'HOME': '/home/cltbld', 00:17:10 INFO - 'LANG': 'en_US.UTF-8', 00:17:10 INFO - 'LANGUAGE': 'en_US:en', 00:17:10 INFO - 'LOGNAME': 'cltbld', 00:17:10 INFO - 'MAIL': '/var/mail/cltbld', 00:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:10 INFO - 'MOZ_NO_REMOTE': '1', 00:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:10 INFO - 'NO_EM_RESTART': '1', 00:17:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:10 INFO - 'PWD': '/builds/slave/test', 00:17:10 INFO - 'SHELL': '/bin/bash', 00:17:10 INFO - 'SHLVL': '1', 00:17:10 INFO - 'TERM': 'linux', 00:17:10 INFO - 'TMOUT': '86400', 00:17:10 INFO - 'USER': 'cltbld', 00:17:10 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', 00:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:10 INFO - '_': '/tools/buildbot/bin/python'} 00:17:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:17:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:17:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:17:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:17:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:17:12 INFO - Installing collected packages: mozsystemmonitor 00:17:12 INFO - Running setup.py install for mozsystemmonitor 00:17:12 INFO - Successfully installed mozsystemmonitor 00:17:12 INFO - Cleaning up... 00:17:12 INFO - Return code: 0 00:17:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:12 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 0x7fefce89ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2982130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a10fc0>, '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 0x2a11ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a12350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', '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 00:17:12 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 00:17:12 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 00:17:12 INFO - Using env: {'DISPLAY': ':0', 00:17:12 INFO - 'HOME': '/home/cltbld', 00:17:12 INFO - 'LANG': 'en_US.UTF-8', 00:17:12 INFO - 'LANGUAGE': 'en_US:en', 00:17:12 INFO - 'LOGNAME': 'cltbld', 00:17:12 INFO - 'MAIL': '/var/mail/cltbld', 00:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:12 INFO - 'MOZ_NO_REMOTE': '1', 00:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:12 INFO - 'NO_EM_RESTART': '1', 00:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:12 INFO - 'PWD': '/builds/slave/test', 00:17:12 INFO - 'SHELL': '/bin/bash', 00:17:12 INFO - 'SHLVL': '1', 00:17:12 INFO - 'TERM': 'linux', 00:17:12 INFO - 'TMOUT': '86400', 00:17:12 INFO - 'USER': 'cltbld', 00:17:12 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', 00:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:12 INFO - '_': '/tools/buildbot/bin/python'} 00:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:17:12 INFO - Downloading/unpacking jsonschema==2.5.1 00:17:12 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 00:17:12 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 00:17:12 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 00:17:12 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 00:17:12 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 00:17:12 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 00:17:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:17:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:17:14 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 00:17:14 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 00:17:14 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 00:17:14 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 00:17:14 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 00:17:14 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 00:17:14 INFO - Downloading functools32-3.2.3-2.tar.gz 00:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:17:14 INFO - warning: no files found matching '*.txt' 00:17:14 INFO - no previously-included directories found matching 'build' 00:17:14 INFO - no previously-included directories found matching 'dist' 00:17:14 INFO - no previously-included directories found matching '.git*' 00:17:14 INFO - Installing collected packages: jsonschema, functools32 00:17:14 INFO - Running setup.py install for functools32 00:17:14 INFO - warning: no files found matching '*.txt' 00:17:14 INFO - no previously-included directories found matching 'build' 00:17:14 INFO - no previously-included directories found matching 'dist' 00:17:14 INFO - no previously-included directories found matching '.git*' 00:17:15 INFO - Successfully installed jsonschema functools32 00:17:15 INFO - Cleaning up... 00:17:15 INFO - Return code: 0 00:17:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:17:15 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')]} 00:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:15 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')]} 00:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:15 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 0x7fefce89ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2982130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a10fc0>, '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 0x2a11ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a12350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', '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 00:17:15 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 00:17:15 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 00:17:15 INFO - Using env: {'DISPLAY': ':0', 00:17:15 INFO - 'HOME': '/home/cltbld', 00:17:15 INFO - 'LANG': 'en_US.UTF-8', 00:17:15 INFO - 'LANGUAGE': 'en_US:en', 00:17:15 INFO - 'LOGNAME': 'cltbld', 00:17:15 INFO - 'MAIL': '/var/mail/cltbld', 00:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:15 INFO - 'MOZ_NO_REMOTE': '1', 00:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:15 INFO - 'NO_EM_RESTART': '1', 00:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:15 INFO - 'PWD': '/builds/slave/test', 00:17:15 INFO - 'SHELL': '/bin/bash', 00:17:15 INFO - 'SHLVL': '1', 00:17:15 INFO - 'TERM': 'linux', 00:17:15 INFO - 'TMOUT': '86400', 00:17:15 INFO - 'USER': 'cltbld', 00:17:15 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', 00:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:15 INFO - '_': '/tools/buildbot/bin/python'} 00:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:17:15 INFO - Cleaning up... 00:17:15 INFO - Return code: 0 00:17:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:17:15 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')]} 00:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:15 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')]} 00:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:15 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 0x7fefce89ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2982130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a10fc0>, '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 0x2a11ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a12350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', '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 00:17:15 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 00:17:15 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 00:17:15 INFO - Using env: {'DISPLAY': ':0', 00:17:15 INFO - 'HOME': '/home/cltbld', 00:17:15 INFO - 'LANG': 'en_US.UTF-8', 00:17:15 INFO - 'LANGUAGE': 'en_US:en', 00:17:15 INFO - 'LOGNAME': 'cltbld', 00:17:15 INFO - 'MAIL': '/var/mail/cltbld', 00:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:15 INFO - 'MOZ_NO_REMOTE': '1', 00:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:15 INFO - 'NO_EM_RESTART': '1', 00:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:15 INFO - 'PWD': '/builds/slave/test', 00:17:15 INFO - 'SHELL': '/bin/bash', 00:17:15 INFO - 'SHLVL': '1', 00:17:15 INFO - 'TERM': 'linux', 00:17:15 INFO - 'TMOUT': '86400', 00:17:15 INFO - 'USER': 'cltbld', 00:17:15 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', 00:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:15 INFO - '_': '/tools/buildbot/bin/python'} 00:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:17:15 INFO - Downloading/unpacking blobuploader==1.2.4 00:17:15 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 00:17:15 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 00:17:15 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 00:17:15 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 00:17:15 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 00:17:15 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 00:17:17 INFO - Downloading blobuploader-1.2.4.tar.gz 00:17:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:17:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:17:17 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 00:17:17 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 00:17:17 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 00:17:17 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 00:17:17 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 00:17:17 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 00:17:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:17:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:17:18 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 00:17:18 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 00:17:18 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 00:17:18 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 00:17:18 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 00:17:18 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 00:17:18 INFO - Downloading docopt-0.6.1.tar.gz 00:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:17:18 INFO - Installing collected packages: blobuploader, requests, docopt 00:17:18 INFO - Running setup.py install for blobuploader 00:17:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:17:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:17:18 INFO - Running setup.py install for requests 00:17:18 INFO - Running setup.py install for docopt 00:17:18 INFO - Successfully installed blobuploader requests docopt 00:17:18 INFO - Cleaning up... 00:17:18 INFO - Return code: 0 00:17:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:18 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 0x7fefce89ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2982130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a10fc0>, '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 0x2a11ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a12350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', '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 00:17:18 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 00:17:18 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 00:17:18 INFO - Using env: {'DISPLAY': ':0', 00:17:18 INFO - 'HOME': '/home/cltbld', 00:17:18 INFO - 'LANG': 'en_US.UTF-8', 00:17:18 INFO - 'LANGUAGE': 'en_US:en', 00:17:18 INFO - 'LOGNAME': 'cltbld', 00:17:18 INFO - 'MAIL': '/var/mail/cltbld', 00:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:18 INFO - 'MOZ_NO_REMOTE': '1', 00:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:18 INFO - 'NO_EM_RESTART': '1', 00:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:18 INFO - 'PWD': '/builds/slave/test', 00:17:18 INFO - 'SHELL': '/bin/bash', 00:17:18 INFO - 'SHLVL': '1', 00:17:18 INFO - 'TERM': 'linux', 00:17:18 INFO - 'TMOUT': '86400', 00:17:18 INFO - 'USER': 'cltbld', 00:17:18 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', 00:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:18 INFO - '_': '/tools/buildbot/bin/python'} 00:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:17:19 INFO - Running setup.py (path:/tmp/pip-sgnA1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:17:19 INFO - Running setup.py (path:/tmp/pip-y7eY8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:17:19 INFO - Running setup.py (path:/tmp/pip-uv8Ck8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:17:19 INFO - Running setup.py (path:/tmp/pip-UeK_oH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:17:19 INFO - Running setup.py (path:/tmp/pip-W7brnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:17:19 INFO - Running setup.py (path:/tmp/pip-1VKecp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:17:19 INFO - Running setup.py (path:/tmp/pip-ANBuyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:17:19 INFO - Running setup.py (path:/tmp/pip-rQ9OT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:17:19 INFO - Running setup.py (path:/tmp/pip-UVs8Xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:17:19 INFO - Running setup.py (path:/tmp/pip-OOrmkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:17:19 INFO - Running setup.py (path:/tmp/pip-NbGGdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:17:19 INFO - Running setup.py (path:/tmp/pip-z3ar9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:17:20 INFO - Running setup.py (path:/tmp/pip-Z4Bx2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:17:20 INFO - Running setup.py (path:/tmp/pip-Tu5ytk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:17:20 INFO - Running setup.py (path:/tmp/pip-hhuXYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:17:20 INFO - Running setup.py (path:/tmp/pip-Bhm7xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:17:20 INFO - Running setup.py (path:/tmp/pip-sMCkZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:17:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:17:20 INFO - Running setup.py install for manifestparser 00:17:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:17:20 INFO - Running setup.py install for mozcrash 00:17:20 INFO - Running setup.py install for mozdebug 00:17:20 INFO - Running setup.py install for mozdevice 00:17:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:17:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:17:20 INFO - Running setup.py install for mozfile 00:17:20 INFO - Running setup.py install for mozhttpd 00:17:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:17:20 INFO - Running setup.py install for mozinfo 00:17:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:17:21 INFO - Running setup.py install for mozInstall 00:17:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:17:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:17:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:17:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:17:21 INFO - Running setup.py install for mozleak 00:17:21 INFO - Running setup.py install for mozlog 00:17:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:17:21 INFO - Running setup.py install for moznetwork 00:17:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:17:21 INFO - Running setup.py install for mozprocess 00:17:21 INFO - Running setup.py install for mozprofile 00:17:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:17:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:17:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:17:21 INFO - Running setup.py install for mozrunner 00:17:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:17:21 INFO - Running setup.py install for mozscreenshot 00:17:21 INFO - Running setup.py install for moztest 00:17:22 INFO - Running setup.py install for mozversion 00:17:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:17:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:17:22 INFO - Cleaning up... 00:17:22 INFO - Return code: 0 00:17:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:17:22 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')]} 00:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:22 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')]} 00:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:22 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 0x7fefce89ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2982130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a10fc0>, '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 0x2a11ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a12350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', '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 00:17:22 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 00:17:22 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 00:17:22 INFO - Using env: {'DISPLAY': ':0', 00:17:22 INFO - 'HOME': '/home/cltbld', 00:17:22 INFO - 'LANG': 'en_US.UTF-8', 00:17:22 INFO - 'LANGUAGE': 'en_US:en', 00:17:22 INFO - 'LOGNAME': 'cltbld', 00:17:22 INFO - 'MAIL': '/var/mail/cltbld', 00:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:22 INFO - 'MOZ_NO_REMOTE': '1', 00:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:22 INFO - 'NO_EM_RESTART': '1', 00:17:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:22 INFO - 'PWD': '/builds/slave/test', 00:17:22 INFO - 'SHELL': '/bin/bash', 00:17:22 INFO - 'SHLVL': '1', 00:17:22 INFO - 'TERM': 'linux', 00:17:22 INFO - 'TMOUT': '86400', 00:17:22 INFO - 'USER': 'cltbld', 00:17:22 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', 00:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:22 INFO - '_': '/tools/buildbot/bin/python'} 00:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:17:22 INFO - Running setup.py (path:/tmp/pip-8QltDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:17:22 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)) 00:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:17:22 INFO - Running setup.py (path:/tmp/pip-TYFqr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:17:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 00:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:17:22 INFO - Running setup.py (path:/tmp/pip-Qro450-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:17:22 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)) 00:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:17:22 INFO - Running setup.py (path:/tmp/pip-6JXIX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:17:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 00:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:17:22 INFO - Running setup.py (path:/tmp/pip-DN28dE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:17:22 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)) 00:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:17:22 INFO - Running setup.py (path:/tmp/pip-ru2Sa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:17:22 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)) 00:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:17:22 INFO - Running setup.py (path:/tmp/pip-LzS3kT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:17:22 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)) 00:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:17:22 INFO - Running setup.py (path:/tmp/pip-jWJcs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:17:22 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)) 00:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:17:22 INFO - Running setup.py (path:/tmp/pip-Ouu9_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:17:23 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)) 00:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:17:23 INFO - Running setup.py (path:/tmp/pip-1pH8g3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:17:23 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)) 00:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:17:23 INFO - Running setup.py (path:/tmp/pip-RVi5u5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:17:23 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)) 00:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:17:23 INFO - Running setup.py (path:/tmp/pip-xg2_zB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:17:23 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)) 00:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:17:23 INFO - Running setup.py (path:/tmp/pip-VdV49H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:17:23 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)) 00:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:17:23 INFO - Running setup.py (path:/tmp/pip-OER9I6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 00:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:17:23 INFO - Running setup.py (path:/tmp/pip-qLFwCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:17:23 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)) 00:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:17:23 INFO - Running setup.py (path:/tmp/pip-MYUSYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:17:23 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)) 00:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:17:23 INFO - Running setup.py (path:/tmp/pip-AeMjLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:17:23 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)) 00:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:17:23 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)) 00:17:23 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:17:23 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:17:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:17:23 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 00:17:23 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 00:17:23 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 00:17:23 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 00:17:23 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 00:17:23 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 00:17:25 INFO - Downloading blessings-1.6.tar.gz 00:17:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:17:25 INFO - Installing collected packages: blessings 00:17:25 INFO - Running setup.py install for blessings 00:17:25 INFO - Successfully installed blessings 00:17:25 INFO - Cleaning up... 00:17:25 INFO - Return code: 0 00:17:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:17:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:17:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:17:26 INFO - Reading from file tmpfile_stdout 00:17:26 INFO - Current package versions: 00:17:26 INFO - argparse == 1.2.1 00:17:26 INFO - blessings == 1.6 00:17:26 INFO - blobuploader == 1.2.4 00:17:26 INFO - docopt == 0.6.1 00:17:26 INFO - functools32 == 3.2.3-2 00:17:26 INFO - jsonschema == 2.5.1 00:17:26 INFO - manifestparser == 1.1 00:17:26 INFO - mozInstall == 1.12 00:17:26 INFO - mozcrash == 1.0 00:17:26 INFO - mozdebug == 0.1 00:17:26 INFO - mozdevice == 0.49 00:17:26 INFO - mozfile == 1.2 00:17:26 INFO - mozhttpd == 0.7 00:17:26 INFO - mozinfo == 0.9 00:17:26 INFO - mozleak == 0.1 00:17:26 INFO - mozlog == 3.4 00:17:26 INFO - moznetwork == 0.27 00:17:26 INFO - mozprocess == 0.23 00:17:26 INFO - mozprofile == 0.28 00:17:26 INFO - mozrunner == 6.13 00:17:26 INFO - mozscreenshot == 0.1 00:17:26 INFO - mozsystemmonitor == 0.3 00:17:26 INFO - moztest == 0.7 00:17:26 INFO - mozversion == 1.4 00:17:26 INFO - psutil == 3.1.1 00:17:26 INFO - requests == 1.2.3 00:17:26 INFO - wsgiref == 0.1.2 00:17:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:17: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')]} 00:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17: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')]} 00:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:26 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 0x7fefce89ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2982130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a10fc0>, '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 0x2a11ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a12350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', '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 00:17:26 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 00:17:26 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 00:17:26 INFO - Using env: {'DISPLAY': ':0', 00:17:26 INFO - 'HOME': '/home/cltbld', 00:17:26 INFO - 'LANG': 'en_US.UTF-8', 00:17:26 INFO - 'LANGUAGE': 'en_US:en', 00:17:26 INFO - 'LOGNAME': 'cltbld', 00:17:26 INFO - 'MAIL': '/var/mail/cltbld', 00:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:26 INFO - 'MOZ_NO_REMOTE': '1', 00:17:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:26 INFO - 'NO_EM_RESTART': '1', 00:17:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:26 INFO - 'PWD': '/builds/slave/test', 00:17:26 INFO - 'SHELL': '/bin/bash', 00:17:26 INFO - 'SHLVL': '1', 00:17:26 INFO - 'TERM': 'linux', 00:17:26 INFO - 'TMOUT': '86400', 00:17:26 INFO - 'USER': 'cltbld', 00:17:26 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', 00:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:26 INFO - '_': '/tools/buildbot/bin/python'} 00:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:17:26 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)) 00:17:26 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)) 00:17:26 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)) 00:17:26 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)) 00:17:26 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)) 00:17:26 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)) 00:17:26 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)) 00:17:26 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)) 00:17:26 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)) 00:17:26 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)) 00:17:26 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)) 00:17:26 INFO - Cleaning up... 00:17:26 INFO - Return code: 0 00:17:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:17: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')]} 00:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17: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')]} 00:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefce89ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2982130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a10fc0>, '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 0x2a11ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a12350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', '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 00:17: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', 'jsonschema'] in /builds/slave/test/build 00:17: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 jsonschema 00:17:26 INFO - Using env: {'DISPLAY': ':0', 00:17:26 INFO - 'HOME': '/home/cltbld', 00:17:26 INFO - 'LANG': 'en_US.UTF-8', 00:17:26 INFO - 'LANGUAGE': 'en_US:en', 00:17:26 INFO - 'LOGNAME': 'cltbld', 00:17:26 INFO - 'MAIL': '/var/mail/cltbld', 00:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:26 INFO - 'MOZ_NO_REMOTE': '1', 00:17:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:26 INFO - 'NO_EM_RESTART': '1', 00:17:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:26 INFO - 'PWD': '/builds/slave/test', 00:17:26 INFO - 'SHELL': '/bin/bash', 00:17:26 INFO - 'SHLVL': '1', 00:17:26 INFO - 'TERM': 'linux', 00:17:26 INFO - 'TMOUT': '86400', 00:17:26 INFO - 'USER': 'cltbld', 00:17:26 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', 00:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:26 INFO - '_': '/tools/buildbot/bin/python'} 00:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:17:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:17:26 INFO - Cleaning up... 00:17:26 INFO - Return code: 0 00:17:26 INFO - Running post-action listener: _resource_record_post_action 00:17:26 INFO - Running post-action listener: _start_resource_monitoring 00:17:26 INFO - Starting resource monitoring. 00:17:26 INFO - [mozharness: 2016-11-23 08:17:26.543385Z] Finished create-virtualenv step (success) 00:17:26 INFO - [mozharness: 2016-11-23 08:17:26.543902Z] Running install step. 00:17:26 INFO - Running pre-action listener: _resource_record_pre_action 00:17:26 INFO - Running main action method: install 00:17:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:17:26 INFO - Reading from file tmpfile_stdout 00:17:26 INFO - Detecting whether we're running mozinstall >=1.0... 00:17:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:17:26 INFO - Reading from file tmpfile_stdout 00:17:26 INFO - Output received: 00:17:26 INFO - Usage: mozinstall [options] installer 00:17:26 INFO - Options: 00:17:26 INFO - -h, --help show this help message and exit 00:17:26 INFO - -d DEST, --destination=DEST 00:17:26 INFO - Directory to install application into. [default: 00:17:26 INFO - "/builds/slave/test"] 00:17:26 INFO - --app=APP Application being installed. [default: firefox] 00:17:26 INFO - mkdir: /builds/slave/test/build/application 00:17:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:17:43 INFO - Reading from file tmpfile_stdout 00:17:43 INFO - Output received: 00:17:43 INFO - /builds/slave/test/build/application/firefox/firefox 00:17:43 INFO - Running post-action listener: _resource_record_post_action 00:17:43 INFO - [mozharness: 2016-11-23 08:17:43.772751Z] Finished install step (success) 00:17:43 INFO - [mozharness: 2016-11-23 08:17:43.773029Z] Running run-tests step. 00:17:43 INFO - Running pre-action listener: _resource_record_pre_action 00:17:43 INFO - Running main action method: run_tests 00:17:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:17:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:17:43 INFO - Python 2.7.3 00:17:43 INFO - Return code: 0 00:17:43 INFO - grabbing minidump binary from tooltool 00:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:17:43 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 0x2a10fc0>, '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 0x2a11ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a12350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:17:43 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 00:17:43 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 00:17:43 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 00:17:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:17:43 INFO - Return code: 0 00:17:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:17:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:17:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:17:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:17:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:17:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 00:17:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 00:17:43 INFO - Using env: {'DISPLAY': ':0', 00:17:43 INFO - 'HOME': '/home/cltbld', 00:17:43 INFO - 'LANG': 'en_US.UTF-8', 00:17:43 INFO - 'LANGUAGE': 'en_US:en', 00:17:43 INFO - 'LOGNAME': 'cltbld', 00:17:43 INFO - 'MAIL': '/var/mail/cltbld', 00:17:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:17:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:43 INFO - 'MOZ_NO_REMOTE': '1', 00:17:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:43 INFO - 'NO_EM_RESTART': '1', 00:17:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:43 INFO - 'PWD': '/builds/slave/test', 00:17:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:17:43 INFO - 'SHELL': '/bin/bash', 00:17:43 INFO - 'SHLVL': '1', 00:17:43 INFO - 'TERM': 'linux', 00:17:43 INFO - 'TMOUT': '86400', 00:17:43 INFO - 'USER': 'cltbld', 00:17:43 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146', 00:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:43 INFO - '_': '/tools/buildbot/bin/python'} 00:17:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 00:17:44 INFO - mozversion application_buildid: 20161122213013 00:17:44 INFO - mozversion application_changeset: ecb49ac1035745fe2c0efc76ec7c65096a34ab89 00:17:44 INFO - mozversion application_display_name: Nightly 00:17:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:17:44 INFO - mozversion application_name: Firefox 00:17:44 INFO - mozversion application_remotingname: firefox 00:17:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:17:44 INFO - mozversion application_vendor: Mozilla 00:17:44 INFO - mozversion application_version: 53.0a1 00:17:44 INFO - mozversion platform_buildid: 20161122213013 00:17:44 INFO - mozversion platform_changeset: ecb49ac1035745fe2c0efc76ec7c65096a34ab89 00:17:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:17:44 INFO - mozversion platform_version: 53.0a1 00:17:44 INFO - using testdate: 1479889064 00:17:44 INFO - actual date: 1479889064 00:17:44 INFO - starting webserver on 'localhost:45427' 00:17:44 INFO - SUITE-START | Running 2 tests 00:17:44 INFO - TEST-START | dromaeo_css 00:17:44 INFO - operating with platform_type : linux_ 00:17:44 INFO - Initialising browser for dromaeo_css test... 00:17:44 INFO - TEST-INFO | started process 13986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu8ZdZ0/profile http://localhost:45427/getInfo.html) 00:17:48 INFO - PROCESS | 13986 | __metrics Screen width/height:1600/1200 00:17:48 INFO - PROCESS | 13986 | colorDepth:24 00:17:48 INFO - PROCESS | 13986 | Browser inner width/height: 1024/697 00:17:48 INFO - PROCESS | 13986 | __metrics 00:17:49 ERROR - PROCESS | 13986 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3198: TypeError: this.tabs is undefined 00:17:49 INFO - TEST-INFO | 13986: exit 0 00:17:49 INFO - Browser initialized. 00:17:49 INFO - Running cycle 1/1 for dromaeo_css test... 00:17:49 INFO - TEST-INFO | started process 14108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu8ZdZ0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:18:02 INFO - PROCESS | 14108 | RSS: Main: 185114624 00:18:02 INFO - PROCESS | 14108 | 00:18:51 INFO - PROCESS | 14108 | 1479889131783 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] 00:21:03 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:45427/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45427/tests/dromaeo/cssquery-ext.html) 00:21:04 INFO - PROCESS | 14108 | RSS: Main: 193716224 00:21:04 INFO - PROCESS | 14108 | 00:24:07 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:45427/tests/dromaeo/cssquery-ext.html (next: http://localhost:45427/tests/dromaeo/cssquery-jquery.html) 00:24:07 INFO - PROCESS | 14108 | RSS: Main: 196046848 00:24:07 INFO - PROCESS | 14108 | 00:27:09 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:45427/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45427/tests/dromaeo/cssquery-mootools.html) 00:27:10 INFO - PROCESS | 14108 | RSS: Main: 199151616 00:27:10 INFO - PROCESS | 14108 | 00:30:12 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:45427/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45427/tests/dromaeo/cssquery-prototype.html) 00:30:13 INFO - PROCESS | 14108 | RSS: Main: 201175040 00:30:13 INFO - PROCESS | 14108 | 00:33:15 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:45427/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45427/tests/dromaeo/cssquery-yui.html) 00:33:16 INFO - PROCESS | 14108 | RSS: Main: 199729152 00:33:16 INFO - PROCESS | 14108 | 00:36:18 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:45427/tests/dromaeo/cssquery-yui.html (next: http://localhost:45427/tests/dromaeo/cssquery-dojo.html) 00:36:19 INFO - PROCESS | 14108 | RSS: Main: 202743808 00:36:19 INFO - PROCESS | 14108 | 00:36:19 INFO - PROCESS | 14108 | __start_tp_report 00:36:19 INFO - PROCESS | 14108 | _x_x_mozilla_page_load 00:36:19 INFO - PROCESS | 14108 | _x_x_mozilla_page_load_details 00:36:19 INFO - PROCESS | 14108 | |i|pagename|runs| 00:36:19 INFO - PROCESS | 14108 | |0;dojo.html;3082.2140354209673;3113.361760839028;3118.2672072063046;3142.1359126240272;3148.0241125251173;5455.890882182354;5481.506664400204;5535.086710692731;5536.972315138423;5562.221289019541;5491.752871120799;5556.9444305556935;5577.8605534861645;5582.609217354787;5589.049861523541;4955.835378686006;4988.551030407262;5018.172001619729;5075.746212689369;5148.536631703146;4929.679570827902;5019.673721208128;5045.974770126144;5074.3657042869645;5078.009788091324;4960.404751429834;5073.797048118071;5079.060373830835;5085.669431486942;5116.232565115244;5025.949740502585;5099.4390617032095;5110.693358398508;5111.948880511184;5118.59051275897;4839.225723884161;4883.609311255091;4897.755112244374;4901.313816065754;4978.327925730016;5406.162044883049;5419;5461.590380721422;5476.397596264408;5493.148561972901;5920.526357891358;5928.199693041471;5929.436703513159;5929.8814023719715;5968.910466342965;5946.672932988684;5948.524118070544;5952.226210592638;5954.97022514889;5966.791162309341;5319.308489896327;5341.519263266325;5343.465653434703;5517.2551705519645;5519.641223320471;5943;5965.194698715618;6037.78867739627;6038.124471951543;6111.205543279434;5746.195532625436;5769.134629805479;5794.130880367894;5811.2445382100905;5828.912566311508;5894.852628684317;5895.823125306248;5898.941010589925;5906.3207731110615;5908.852278693067;5723.198752174699;5771.88456230873;5811.157382179645;5822.534197264209;5827.59206855516;5769.538436925036;5776.046952252916;5778;5795.88408231833;5813.418658134237;4440.156370289635;4470.709403888737;4495.9325610115875;4516.299973504112;4524.298733696282;3983.1237127831832;4012.498437695288;4012.779297138627;4021.6380525752825;4048.6963477739287;5475.6440831345835;5527.917081243784;5635.098384258499;5642.379338272786;5656.943430565724;5876.500497457679;5916.437938395846;5918.201042859245;5918.852028699231;5920.31916329619;5470;5610.438956104438;5628.099504079328;5656.688882111441;5706.4864162225595;5090.974545127251;5120.692758434506;5136.614753893473;5138.563222126161;5140.948590514122;5996.88006239864;6185.876282474415;6193.411625895533;6196.783112591128;6202.131701561695;5832.9708351457975;5887.3523912370465;5889.234399528034;5911.290645122613;5919.644821310735;6029.3669164737075;6089.908651370144;6103.267607886904;6136.570440069152;6159.84600384994;5751.223584816164;5757.568182386254;5794.681292528951;5798.246227990334;5846.532277417881;5909.763609455574;5915.142304365929;5915.763369465173;5917.142014407973;5924.585279030426;5490.91763623538;5597.944020559905;5601.831945041656;5722.542196624343;5781.653100813965;5736.770529178786;5739.110437882135;5741.368449470471;5770.971145144247;5788.160716696139;5682.204491371129;5707.857303567444;5714.999875021771;5724.656520608777;5728.455796699307;5686.2323586315315;5704.914426283692;5737.569682273763;5787.334456537552;5805.390434004369;5524.1989911463415;5608.943910561005;5707.6290041147195;5713.143028545585;5715.371309156073 00:36:19 INFO - PROCESS | 14108 | |1;ext.html;546.8523498655363;566.991495127573;579.5218944370893;582.0599731433736;601.4466690644607;39889.80055099724;41659.58340416595;41713.791431042875;44875.32687009697;44969.775151124195;42932.570674293245;43271;43299.13401731972;43367.13265734691;43425;8531.95734021329;8668.826623467527;8691.087435819243;10153;10429.16566674668;10334.431606261653;10355;10404.583816647362;10469.371837689725;10500.632477863277;10370.066693997538;10461.895381046206;10474;10485.475726213659;10513.264071514997;10413.895861041407;10490.265681402305;10491.895081049168;10514.526846291936;10514.894851051467;10376.94811525945;10381.84427233592;10445.529951152217;10453.790924181474;10474.528646210938;40265.396019059735;40334.39498407526;40529.18941621151;40709.59290407088;40785.38821917673;3135.3415782685665;3173.76196785242;3253.430649636304;3303.900882973515;3654.104744337628;28879.855600722072;29915.850420747975;30107.397852043054;30293.697063029307;30366.240843978856;4156.251874662559;4276.205741220632;4306.138772245564;4428.335749637548;4433.290673492225;333610;335210.2394880246;336775;338243;338585;58661;58944.41055589389;58993.41006589965;58998;59199.304090467966;60622.393776061675;60828.391716083155;61000.38999609947;61022.694886525285;61061;16599.50201493933;16848.073355965294;16901.915490422714;16965.066921319198;17000.234989425506;12181.634550963485;12440.377981100908;12457.377131143407;12859.42132604035;12919.418626161845;18634.25462981493;19495.8050419494;19531;19549.90225048894;19585.412437626896;6560.44236239925;7136.250693677193;7383.2985866342615;7389.66746496409;7440.85118297631;917.3349321741684;1009.6213919780082;1012.0739523336065;1067.8611780468646;1081.9404932728776;31319;31462.21344466361;31710.207244819063;31744;32110;1034.6120204923154;1084.414416215235;1105.3865104866716;1117.022605220432;1163.4357336691698;15183.468578599695;18172.36396726108;18450.169742361624;18471.90764046171;19199.808001920082;475681;495827;497120;498873;501684;59250;60071;60304;60504.39495605075;60564;1339.3035621476972;1346.7912473566612;1386.7850483175123;1389.2914613547366;1392.0812263905975;31004.844975774977;32456.67543324631;32672.50991235086;33212.50181247332;33412.498812518315;50533.74733126311;50838.74580627073;50903.236451453995;51066.744666276434;51300;440582;440896;443126;444512;446316;41147.58852411438;41315.7934210327;41345;41542.58457415508;41598.58401416068;39228.215435691694;43303.566964329955;43893;45766.771166145285;48863.755681221366;38955.61044389633;39662.2067558653;40201;41237.1752564953;41998.37002444905;39187.216255675296;39556.40665389964;39800.40299395569;40088;40277.597224028556;39725.80137099296;40538;40617.796911015255;40651;40881.59118408778;32944.34111317808;35725.821370892976;36231.27537449289;36738;36863.63136368602;27385.589216161374;27416.862915685295;27682.723172768016;27744.8612756943;27836.582451263654 00:36:19 INFO - PROCESS | 14108 | |2;jquery.html;385.7974563354239;394.2705993911266;401.34179944890377;405.2664676934748;423.68647201071195;13603.38784754686;17621.911890440544;17960.640787184282;19062.23751049958;19094.33169839056;16439.178041097955;16636.417725379582;16859.07275099872;16879.83120168798;17093.743593846102;5483.7532311046;5503.064479038553;5633.436656334375;5738.512226460756;5743.224664670279;5561.304836895388;5622.240997465331;5646.774129034834;5660.150977353389;5665.291838520185;5560.555155587544;5573.888522229553;5593.133064375008;5634.464725851038;5650.406707295737;5456.48163424476;5570.108782594765;5611.186377975171;5611.186377975191;5622.156676498517;4789.137955168068;4882.43851957026;4927.6304277179;4979.502049795028;5013.39839219296;22111.889440552855;22257.220997265016;22382;22697.886510567507;22881.54236915269;2290.415943934303;2320.013994052538;2385.642153676945;2412.963805542918;2908.665503467086;9959.352642078242;10605.73485662857;13279.402426890812;13505.729885402237;14375.28123593816;1787.2672204396135;1837.9724304135448;1845.9630807383912;1922.7596550431197;1959.206521358852;79116.60441697812;82068.58965705193;83569.16430835675;84884.57557712233;85948.57025714831;10957.780844383067;11130.49912753928;11174.10607151426;11183.608573699881;11426.542938282542;11929.880701193051;15113.54659360221;15266.236688165769;15312.157831319384;15373.615659608598;7707.845843083107;7733.304002639789;7958.960205198937;7985.321247693895;8016.358691304682;7643.159252482223;7679.769606911802;7765.922340776633;7902.446828721934;8006.679732810739;4045.7977101144825;4059.411385349108;4085.2850751118435;4090.3250963591267;4223.1553689261655;1963.1656545967905;1986.7185665245836;2008.357325655776;2020.6665900126316;2024.1903238704635;891.5096696816724;905.651324240159;973.532704301939;988.7528117970508;992.846108853129;17773.822261777474;19288.22847086129;19294.571589937976;19407.902960485106;19432.70850937237;945.8817647794026;954.656323723459;956.3257903178243;965.4014511003082;966.9750064931195;10140.2340899777;10800.027997480265;10811.459427028618;10921.290116142425;10927.726806829893;441601;453966;455311;456115.8272590079;461655;87691.56154219188;87899.56050219836;88403.55798221096;88795;91050;926.1988380051207;955.5317894231777;981.9214462842956;982.3516479123743;985.4678473624163;16496.17519124063;16522.339106435607;17236.913815430842;17389;17454.738178927073;40229.19541609093;40640.1871962565;41098.38352424776;41206.381904270864;41926.58073419227;54474;54789;54858.45141548693;55675.44324556865;56237.43762562322;8264.917350826414;8290.170982901662;8385.161483851565;8602.18279263469;8885.822283554164;11624.476898539417;11699.23954942926;12227.69430764238;12910;12920.418581164058;10757.46212689378;10815.729606759895;10942;10992.615258465916;11269.830952535882;10606.310589811637;10612.946935265274;10921.235513513977;10982.560697572007;11670.824937626112;10415.895841041493;10547;10695.465226738477;10860.837087443537;11357.148213883827;7252.818679533054;7367.300106489874;7496.437767167593;8003.599820009093;8548.401611887108;9959.352642078242;10748.623798167027;10924.235303528676;11012.17408694335;11945.402729863647 00:36:19 INFO - PROCESS | 14108 | |3;mootools.html;1451.731429685508;1473.6242258224154;1605.7109720250357;1719.688742315702;1721.440531827155;7692.769216923487;7959.442839001273;8145.674173033079;8783.648654053839;8847.938247410311;8271.627776750045;8541.658333666646;8558.657653693861;8810.118988101187;8811.559422028906;2332.3003099070297;2370.7984821290124;2371.0515793682493;2371.9644205336936;2373.2761507740133;2257.3566533537864;2326.0346956013236;2327.0691723310642;2329.1498603009863;2330.6132850953654;2291.8051965582945;2315.5947709150914;2339.6841426407386;2371.2412028150998;2377.595808712523;2290.576243394977;2302.631578947369;2316.3166865774638;2320.953580928389;2338.543983923136;2263;2284.805791507724;2285.5543169082034;2288.233441797;2289.5878741826464;8545.786355341104;8686.782830429227;8756.255718263956;8759.868601970975;8762.299016078698;5144.56271216947;5262.631615786897;5306.442823503554;5309.867253318659;5312.043832110218;3092.8762849485993;3109.8134111953354;3413.2832105257676;3427.7086447651977;3433.210361616817;1074.371492676785;1096.9177311701653;1117.4133579870552;1134.8014097532898;1154.9307041577533;12010.579629712918;12027.93986030073;12094.516219351304;12098.939505302505;12111.999999999913;4451.243288640874;4628.768561571908;4722.645801564828;4735.881602959885;4750.524947505291;10019.79960400788;10083.294169408071;10091.091801737879;10095.848562271573;10128.848067278997;5339.359276886721;5342.813001544927;5348.491893270133;5349.251104845324;5359.062164121263;4319.611234988866;4348.543402942645;4744.667873248839;4816.54242846936;4903.607711383081;3736.8886579083273;3791.7345785795283;3844.442555829389;3949.4865667463046;3989.58109398509;1251.9374031298398;1253.2417887178308;1254.5358217459416;1266.4997326056157;1285.1774864086992;809.2110192562204;917.8852643419573;927.679950417105;929.6002718830968;941.5951141009294;5889.440503152194;5930.7924222652;6020.307664618537;6069.787557435557;6102.359252278536;466.9626429885601;487.8511106344578;490.80367852858427;499.18134259813934;980.1864452504404;3821.6942644588366;4085;4132.037282290948;4144.233316836395;4155.58444155582;10524.736881577868;10610.469476526143;10661.84007239892;10866.945665271782;10867.29362591429;10716.839247411139;10719.303245289031;10748.193885458622;10760.892391076146;10807.78384432307;7709.229077092358;7956.602169891482;7998.680052797823;8017.158198389202;8188.344932405394;5465.234867118527;5620.662760234399;5679.17651940458;5888.263967004124;5976.103584462366;9712.125908668253;9813.852792208265;9909.900900990899;9983.500824958577;9995.800083998134;9660.75848103803;9897.901020989699;10163.441010744184;10163.7459063524;10200.438975856103;8012.5192488450875;8160.714374996846;8204.466709663853;8251;8355;8526.829463410573;8547;8560.357973152162;8586;8602.956985215034;7308.744193953399;7498.850022999619;7536.5101268417375;7758.107817601048;7826.569538675428;7307;7323.048003759477;7361.447891408059;7409.37020353276;7423.888641670487;7009;7037.225905150532;7107.715691372287;7139.32176443237;7141.321574450419;5026.346574945233;5075.375879718455;5134.974325128351;5208;5382.838514844561;5175.508326708957;5232.581393488588;5248.475152484721;5306.097963346318;5392.5416339611575 00:36:19 INFO - PROCESS | 14108 | |4;prototype.html;311.49848743522926;319.1988109844291;327.3730805507453;329.47119872604486;329.89485224497935;5352.357717073947;5392.218128371389;5409.43200963899;5471.753771080301;5486.259354987075;5329.813456529013;5347.465253474651;5380.784768609261;5382.461753824616;5385.542228910547;4196.328587426013;4199.3281075028;4236.449261595988;4238.173556156551;4240.745555266679;3986.0034991252187;4140.275451795924;4224.936625950613;4227.936580951288;4232.640225580829;4163.542010378856;4164.666826653875;4167.666586673059;4179.540250572434;4185.393117997888;4154.52222994355;4163.167366526692;4169.353750168729;4187.20443115807;4220.113776107021;3675.4119340905327;3685.636314563602;3691.003429074135;3695.9630403695887;3696.796676182809;5198.506141916512;5283.788648454057;5284.6564973277;5302.814401495968;5321.201819727034;4740.7007601313335;4772.880677983044;4774.73738944358;4776.617870570346;4776.737279449629;5507.586930980153;5575.609707320489;5577.972110139464;5629.549636029108;5632.07070833312;3897.142628621699;3947.5460322063045;3962.128331767007;3967.920641587152;3994.2610617035944;5796.681182534959;5799.507041901444;5805;5825.126231065332;5898.233229680114;4126.216018956388;4147.52303485103;4159.542450330461;4159.668905950067;4166.562510936369;4072.7759973201164;4140.399642051885;4144.689148313889;4177.394277829759;4186.183694179666;4726.527347265246;4738.360321356642;4747.2879068140055;4759.904801903943;4767.141914455431;5645.927273817962;5668.69179423641;5684.687342196219;5684.8863022739315;5712.285964254468;1319.0371029148582;1344.6571124363224;1368.493657346788;1385.5081446086695;1387.126110550367;933.3000249812641;938.2540880000416;939.7829810395417;956.5695437053354;962.8988956159502;5226.863881670967;5248.55664692205;5251;5298.576113910955;5309.867253318698;5632.605717599728;5641;5644.689542075225;5650.886982260332;5662.631928924607;5110.95225478776;5157.329547158845;5210.192420174879;5218.930119325529;5304.363476382781;2932.9441401095587;2936.7797415193945;2960.955585666217;2973;2982.7331228266676;5768.163616275617;5772.278465191851;5794.50746686528;5800.274965629296;5810.535157187415;5488.69812160327;5619.325680918316;5636.774529018875;5651.406602306781;5684.658920464785;5742.885142297131;5748.396418376094;5755.251817263729;5770.884582308414;5788.884222315446;5272.367315922113;5454.0002998349955;5539.612227144061;5598.440155984369;5613.316005198506;5464.22412715861;5474.644148130359;5506;5528.170774383874;5542.722863856871;5789.305283366023;5828.242328497268;5841.737121829443;5846.590738648424;5849.502792262705;3885.1452680410266;3983.66138878187;3984.3425834736945;3988.922990792528;4008.518977722575;5611.438856114356;5620.915686264628;5629.099344104923;5632.522144894737;5646.632968857011;5631.915521267102;5638.379778224474;5692.7722891083895;5696;5701.201831743476;5649.548036157015;5649.887002259849;5671.319441667027;5681.375048744552;5717.513446503855;5511.779528818803;5645.745941432728;5656.717164141694;5667.518260947865;5690.260266165372;5699;5700;5705.001624715741;5716.771329146954;5747.017279038725;5387.838364849061;5572.721363931868;5588.804391846266;5616.21373007771;5661.603687741818 00:36:19 INFO - PROCESS | 14108 | |5;yui.html;691.3673988300706;707.4764674141136;707.8442742596627;734.614327478074;741;13598.524051658194;14209.218492982882;14223.217723025255;14377.568672939802;14453.63865903353;13680;13884.166949983008;13910.095843770174;13914.234717090556;14292.499762508314;776.4875182379631;797.3501596199079;799.4883274704194;800.5156880087521;800.9639566219505;799.8120441696196;800.3557136505111;800.6117033238875;801.3829351399419;802.1457148137245;847.7075408983891;848.3043903998723;855.4738835616082;855.9529225892604;856.5888373580685;850.0649285785648;851.8509260879352;852.4586887326561;852.8550146475114;852.923236908675;615.1019511513196;619.157945194535;619.752099160335;620.981370558884;621.1459243540132;14165.433382664783;14184.361703723358;14208.715825683532;14228.217448040354;14296.499622513265;13201.669958251025;13279;13602.727945441036;13737.862621373759;13956;11047.944760276228;11348;11504.482298296596;11645.126615503787;11782.234154779911;3617.439296908983;3667.651573100551;3688.0964163780045;3699.500567423417;3709.684676802475;61291.693541532455;61695.383046169416;61824.38175618231;62160.378396215914;62466.37533624651;9904.653337133166;10015.69952901414;10184.592616295266;10219.693409197736;10248.333858299187;19585.804141958397;19710.310139145062;19743;19750.209991600463;19827;7817.609119544;7822.256885595859;7832.373410127176;7867.6066196689935;8181.918180818116;4398.604125628709;4456.9331460028125;4461.263891457873;4492.034212644232;4581.312803079565;3529.8588056477965;3590.533230679995;3592.946105808415;3617.6744093031753;3656.6526180012856;622.3372108704216;629.515273239603;631.8388810853203;634.926983396906;652.9640869752114;644.1414740169853;700.5201437015661;714.4355958792496;725.5956344985885;738.8374557597427;9263.37786401981;9425.764355891157;9518.666846660471;9652.581033612569;10066.54700538463;559.8264537993235;666.9099671544279;694.7950354645392;696.6516741629185;711.6157275071404;4276.8289268429535;4599.425071866017;4603.516630753789;4616.722996620214;4637.513061128533;88742.55628721815;89215;89564;91240;92003.53998229966;47952;53967.73016134894;73623;73773;76232.61883690656;67134.32865671281;67415.3258467409;69588.65205674041;70202;71779;8835.160659737314;9200.861987070066;9214.817626522596;9260.768480787765;9315.72052838416;40355.59644403518;43439;43891.78054109709;44856.32715509335;44909.550904490534;57030;59112.70443647754;59779;59982.70008649929;61853.381466184765;11440.599579014695;11441.942790285995;11892.405379731152;12073.818892716441;12933.741325173256;13569.321533923461;13916.791248131489;14012.929935350257;14020.649483762987;14169;12467.87532124667;12847.807282890952;13171.678948416496;13257.204567725967;13545.390457429243;12797.616071517868;12822.487100515875;13132.540361087316;13177.47290108385;13187.340632968506;12989.545365912149;13003.349832508526;13009.479620815062;13141;13327.600171994856;10155.492225388552;10635.8936410638;10703.625373111903;10803.649543807023;11080.722981925517;10934.835977460185;10980.176486763365;11001.22991390595;11112.833307500556;11256.549738010715 00:36:19 INFO - PROCESS | 14108 | __end_tp_report 00:36:19 INFO - PROCESS | 14108 | __start_cc_report 00:36:19 INFO - PROCESS | 14108 | _x_x_mozilla_cycle_collect,319 00:36:19 INFO - PROCESS | 14108 | __end_cc_report 00:36:19 INFO - PROCESS | 14108 | __startTimestamp1479890179114__endTimestamp 00:36:19 INFO - PROCESS | 14108 | 00:36:19 INFO - PROCESS | 14108 | ------- Summary: start ------- 00:36:19 INFO - PROCESS | 14108 | Number of tests: 6 00:36:19 INFO - PROCESS | 14108 | 00:36:19 INFO - PROCESS | 14108 | [#0] dojo.html Cycles:165 Average:5468.32 Median:5706.49 stddev:627.46 (11.0%) stddev-sans-first:600.82 00:36:19 INFO - PROCESS | 14108 | Values: 3082.2 3113.4 3118.3 3142.1 3148.0 5455.9 5481.5 5535.1 5537.0 5562.2 5491.8 5556.9 5577.9 5582.6 5589.0 4955.8 4988.6 5018.2 5075.7 5148.5 4929.7 5019.7 5046.0 5074.4 5078.0 4960.4 5073.8 5079.1 5085.7 5116.2 5025.9 5099.4 5110.7 5111.9 5118.6 4839.2 4883.6 4897.8 4901.3 4978.3 5406.2 5419.0 5461.6 5476.4 5493.1 5920.5 5928.2 5929.4 5929.9 5968.9 5946.7 5948.5 5952.2 5955.0 5966.8 5319.3 5341.5 5343.5 5517.3 5519.6 5943.0 5965.2 6037.8 6038.1 6111.2 5746.2 5769.1 5794.1 5811.2 5828.9 5894.9 5895.8 5898.9 5906.3 5908.9 5723.2 5771.9 5811.2 5822.5 5827.6 5769.5 5776.0 5778.0 5795.9 5813.4 4440.2 4470.7 4495.9 4516.3 4524.3 3983.1 4012.5 4012.8 4021.6 4048.7 5475.6 5527.9 5635.1 5642.4 5656.9 5876.5 5916.4 5918.2 5918.9 5920.3 5470.0 5610.4 5628.1 5656.7 5706.5 5091.0 5120.7 5136.6 5138.6 5140.9 5996.9 6185.9 6193.4 6196.8 6202.1 5833.0 5887.4 5889.2 5911.3 5919.6 6029.4 6089.9 6103.3 6136.6 6159.8 5751.2 5757.6 5794.7 5798.2 5846.5 5909.8 5915.1 5915.8 5917.1 5924.6 5490.9 5597.9 5601.8 5722.5 5781.7 5736.8 5739.1 5741.4 5771.0 5788.2 5682.2 5707.9 5715.0 5724.7 5728.5 5686.2 5704.9 5737.6 5787.3 5805.4 5524.2 5608.9 5707.6 5713.1 5715.4 00:36:19 INFO - PROCESS | 14108 | 00:36:19 INFO - PROCESS | 14108 | [#1] ext.html Cycles:180 Average:59197.55 Median:37909.62 stddev:113522.99 (299.5%) stddev-sans-first:113756.04 00:36:19 INFO - PROCESS | 14108 | Values: 546.9 567.0 579.5 582.1 601.4 39889.8 41659.6 41713.8 44875.3 44969.8 42932.6 43271.0 43299.1 43367.1 43425.0 8532.0 8668.8 8691.1 10153.0 10429.2 10334.4 10355.0 10404.6 10469.4 10500.6 10370.1 10461.9 10474.0 10485.5 10513.3 10413.9 10490.3 10491.9 10514.5 10514.9 10376.9 10381.8 10445.5 10453.8 10474.5 40265.4 40334.4 40529.2 40709.6 40785.4 3135.3 3173.8 3253.4 3303.9 3654.1 28879.9 29915.9 30107.4 30293.7 30366.2 4156.3 4276.2 4306.1 4428.3 4433.3 333610.0 335210.2 336775.0 338243.0 338585.0 58661.0 58944.4 58993.4 58998.0 59199.3 60622.4 60828.4 61000.4 61022.7 61061.0 16599.5 16848.1 16901.9 16965.1 17000.2 12181.6 12440.4 12457.4 12859.4 12919.4 18634.3 19495.8 19531.0 19549.9 19585.4 6560.4 7136.3 7383.3 7389.7 7440.9 917.3 1009.6 1012.1 1067.9 1081.9 31319.0 31462.2 31710.2 31744.0 32110.0 1034.6 1084.4 1105.4 1117.0 1163.4 15183.5 18172.4 18450.2 18471.9 19199.8 475681.0 495827.0 497120.0 498873.0 501684.0 59250.0 60071.0 60304.0 60504.4 60564.0 1339.3 1346.8 1386.8 1389.3 1392.1 31004.8 32456.7 32672.5 33212.5 33412.5 50533.7 50838.7 50903.2 51066.7 51300.0 440582.0 440896.0 443126.0 444512.0 446316.0 41147.6 41315.8 41345.0 41542.6 41598.6 39228.2 43303.6 43893.0 45766.8 48863.8 38955.6 39662.2 40201.0 41237.2 41998.4 39187.2 39556.4 39800.4 40088.0 40277.6 39725.8 40538.0 40617.8 40651.0 40881.6 32944.3 35725.8 36231.3 36738.0 36863.6 27385.6 27416.9 27682.7 27744.9 27836.6 00:36:19 INFO - PROCESS | 14108 | 00:36:19 INFO - PROCESS | 14108 | [#2] jquery.html Cycles:180 Average:27563.85 Median:22362.74 stddev:75025.81 (335.5%) stddev-sans-first:75208.52 00:36:19 INFO - PROCESS | 14108 | Values: 385.8 394.3 401.3 405.3 423.7 13603.4 17621.9 17960.6 19062.2 19094.3 16439.2 16636.4 16859.1 16879.8 17093.7 5483.8 5503.1 5633.4 5738.5 5743.2 5561.3 5622.2 5646.8 5660.2 5665.3 5560.6 5573.9 5593.1 5634.5 5650.4 5456.5 5570.1 5611.2 5611.2 5622.2 4789.1 4882.4 4927.6 4979.5 5013.4 22111.9 22257.2 22382.0 22697.9 22881.5 2290.4 2320.0 2385.6 2413.0 2908.7 9959.4 10605.7 13279.4 13505.7 14375.3 1787.3 1838.0 1846.0 1922.8 1959.2 79116.6 82068.6 83569.2 84884.6 85948.6 10957.8 11130.5 11174.1 11183.6 11426.5 11929.9 15113.5 15266.2 15312.2 15373.6 7707.8 7733.3 7959.0 7985.3 8016.4 7643.2 7679.8 7765.9 7902.4 8006.7 4045.8 4059.4 4085.3 4090.3 4223.2 1963.2 1986.7 2008.4 2020.7 2024.2 891.5 905.7 973.5 988.8 992.8 17773.8 19288.2 19294.6 19407.9 19432.7 945.9 954.7 956.3 965.4 967.0 10140.2 10800.0 10811.5 10921.3 10927.7 441601.0 453966.0 455311.0 456115.8 461655.0 87691.6 87899.6 88403.6 88795.0 91050.0 926.2 955.5 981.9 982.4 985.5 16496.2 16522.3 17236.9 17389.0 17454.7 40229.2 40640.2 41098.4 41206.4 41926.6 54474.0 54789.0 54858.5 55675.4 56237.4 8264.9 8290.2 8385.2 8602.2 8885.8 11624.5 11699.2 12227.7 12910.0 12920.4 10757.5 10815.7 10942.0 10992.6 11269.8 10606.3 10612.9 10921.2 10982.6 11670.8 10415.9 10547.0 10695.5 10860.8 11357.1 7252.8 7367.3 7496.4 8003.6 8548.4 9959.4 10748.6 10924.2 11012.2 11945.4 00:36:19 INFO - PROCESS | 14108 | 00:36:19 INFO - PROCESS | 14108 | [#3] mootools.html Cycles:180 Average:5728.75 Median:2701.39 stddev:3248.42 (120.2%) stddev-sans-first:3241.63 00:36:19 INFO - PROCESS | 14108 | Values: 1451.7 1473.6 1605.7 1719.7 1721.4 7692.8 7959.4 8145.7 8783.6 8847.9 8271.6 8541.7 8558.7 8810.1 8811.6 2332.3 2370.8 2371.1 2372.0 2373.3 2257.4 2326.0 2327.1 2329.1 2330.6 2291.8 2315.6 2339.7 2371.2 2377.6 2290.6 2302.6 2316.3 2321.0 2338.5 2263.0 2284.8 2285.6 2288.2 2289.6 8545.8 8686.8 8756.3 8759.9 8762.3 5144.6 5262.6 5306.4 5309.9 5312.0 3092.9 3109.8 3413.3 3427.7 3433.2 1074.4 1096.9 1117.4 1134.8 1154.9 12010.6 12027.9 12094.5 12098.9 12112.0 4451.2 4628.8 4722.6 4735.9 4750.5 10019.8 10083.3 10091.1 10095.8 10128.8 5339.4 5342.8 5348.5 5349.3 5359.1 4319.6 4348.5 4744.7 4816.5 4903.6 3736.9 3791.7 3844.4 3949.5 3989.6 1251.9 1253.2 1254.5 1266.5 1285.2 809.2 917.9 927.7 929.6 941.6 5889.4 5930.8 6020.3 6069.8 6102.4 467.0 487.9 490.8 499.2 980.2 3821.7 4085.0 4132.0 4144.2 4155.6 10524.7 10610.5 10661.8 10866.9 10867.3 10716.8 10719.3 10748.2 10760.9 10807.8 7709.2 7956.6 7998.7 8017.2 8188.3 5465.2 5620.7 5679.2 5888.3 5976.1 9712.1 9813.9 9909.9 9983.5 9995.8 9660.8 9897.9 10163.4 10163.7 10200.4 8012.5 8160.7 8204.5 8251.0 8355.0 8526.8 8547.0 8560.4 8586.0 8603.0 7308.7 7498.9 7536.5 7758.1 7826.6 7307.0 7323.0 7361.4 7409.4 7423.9 7009.0 7037.2 7107.7 7139.3 7141.3 5026.3 5075.4 5135.0 5208.0 5382.8 5175.5 5232.6 5248.5 5306.1 5392.5 00:36:19 INFO - PROCESS | 14108 | 00:36:19 INFO - PROCESS | 14108 | [#4] prototype.html Cycles:180 Average:4691.69 Median:5384.00 stddev:1380.01 (25.6%) stddev-sans-first:1344.14 00:36:19 INFO - PROCESS | 14108 | Values: 311.5 319.2 327.4 329.5 329.9 5352.4 5392.2 5409.4 5471.8 5486.3 5329.8 5347.5 5380.8 5382.5 5385.5 4196.3 4199.3 4236.4 4238.2 4240.7 3986.0 4140.3 4224.9 4227.9 4232.6 4163.5 4164.7 4167.7 4179.5 4185.4 4154.5 4163.2 4169.4 4187.2 4220.1 3675.4 3685.6 3691.0 3696.0 3696.8 5198.5 5283.8 5284.7 5302.8 5321.2 4740.7 4772.9 4774.7 4776.6 4776.7 5507.6 5575.6 5578.0 5629.5 5632.1 3897.1 3947.5 3962.1 3967.9 3994.3 5796.7 5799.5 5805.0 5825.1 5898.2 4126.2 4147.5 4159.5 4159.7 4166.6 4072.8 4140.4 4144.7 4177.4 4186.2 4726.5 4738.4 4747.3 4759.9 4767.1 5645.9 5668.7 5684.7 5684.9 5712.3 1319.0 1344.7 1368.5 1385.5 1387.1 933.3 938.3 939.8 956.6 962.9 5226.9 5248.6 5251.0 5298.6 5309.9 5632.6 5641.0 5644.7 5650.9 5662.6 5111.0 5157.3 5210.2 5218.9 5304.4 2932.9 2936.8 2961.0 2973.0 2982.7 5768.2 5772.3 5794.5 5800.3 5810.5 5488.7 5619.3 5636.8 5651.4 5684.7 5742.9 5748.4 5755.3 5770.9 5788.9 5272.4 5454.0 5539.6 5598.4 5613.3 5464.2 5474.6 5506.0 5528.2 5542.7 5789.3 5828.2 5841.7 5846.6 5849.5 3885.1 3983.7 3984.3 3988.9 4008.5 5611.4 5620.9 5629.1 5632.5 5646.6 5631.9 5638.4 5692.8 5696.0 5701.2 5649.5 5649.9 5671.3 5681.4 5717.5 5511.8 5645.7 5656.7 5667.5 5690.3 5699.0 5700.0 5705.0 5716.8 5747.0 5387.8 5572.7 5588.8 5616.2 5661.6 00:36:19 INFO - PROCESS | 14108 | 00:36:19 INFO - PROCESS | 14108 | [#5] yui.html Cycles:180 Average:17305.52 Median:4590.37 stddev:22789.79 (496.5%) stddev-sans-first:22819.58 00:36:19 INFO - PROCESS | 14108 | Values: 691.4 707.5 707.8 734.6 741.0 13598.5 14209.2 14223.2 14377.6 14453.6 13680.0 13884.2 13910.1 13914.2 14292.5 776.5 797.4 799.5 800.5 801.0 799.8 800.4 800.6 801.4 802.1 847.7 848.3 855.5 856.0 856.6 850.1 851.9 852.5 852.9 852.9 615.1 619.2 619.8 621.0 621.1 14165.4 14184.4 14208.7 14228.2 14296.5 13201.7 13279.0 13602.7 13737.9 13956.0 11047.9 11348.0 11504.5 11645.1 11782.2 3617.4 3667.7 3688.1 3699.5 3709.7 61291.7 61695.4 61824.4 62160.4 62466.4 9904.7 10015.7 10184.6 10219.7 10248.3 19585.8 19710.3 19743.0 19750.2 19827.0 7817.6 7822.3 7832.4 7867.6 8181.9 4398.6 4456.9 4461.3 4492.0 4581.3 3529.9 3590.5 3592.9 3617.7 3656.7 622.3 629.5 631.8 634.9 653.0 644.1 700.5 714.4 725.6 738.8 9263.4 9425.8 9518.7 9652.6 10066.5 559.8 666.9 694.8 696.7 711.6 4276.8 4599.4 4603.5 4616.7 4637.5 88742.6 89215.0 89564.0 91240.0 92003.5 47952.0 53967.7 73623.0 73773.0 76232.6 67134.3 67415.3 69588.7 70202.0 71779.0 8835.2 9200.9 9214.8 9260.8 9315.7 40355.6 43439.0 43891.8 44856.3 44909.6 57030.0 59112.7 59779.0 59982.7 61853.4 11440.6 11441.9 11892.4 12073.8 12933.7 13569.3 13916.8 14012.9 14020.6 14169.0 12467.9 12847.8 13171.7 13257.2 13545.4 12797.6 12822.5 13132.5 13177.5 13187.3 12989.5 13003.3 13009.5 13141.0 13327.6 10155.5 10635.9 10703.6 10803.6 11080.7 10934.8 10980.2 11001.2 11112.8 11256.5 00:36:19 INFO - PROCESS | 14108 | -------- Summary: end -------- 00:36:19 INFO - PROCESS | 14108 | 00:36:20 INFO - TEST-INFO | 14108: exit 0 00:36:20 INFO - TEST-OK | dromaeo_css | took 1116089ms 00:36:20 INFO - TEST-START | kraken 00:36:20 INFO - operating with platform_type : linux_ 00:36:20 INFO - Initialising browser for kraken test... 00:36:20 INFO - TEST-INFO | started process 14453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB0LJWj/profile http://localhost:45427/getInfo.html) 00:36:24 INFO - PROCESS | 14453 | __metrics Screen width/height:1600/1200 00:36:24 INFO - PROCESS | 14453 | colorDepth:24 00:36:24 INFO - PROCESS | 14453 | Browser inner width/height: 1024/697 00:36:24 INFO - PROCESS | 14453 | __metrics 00:36:25 ERROR - PROCESS | 14453 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3198: TypeError: this.tabs is undefined 00:36:26 INFO - TEST-INFO | 14453: exit 0 00:36:26 INFO - Browser initialized. 00:36:26 INFO - Running cycle 1/1 for kraken test... 00:36:26 INFO - TEST-INFO | started process 14578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB0LJWj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:36:38 INFO - PROCESS | 14578 | RSS: Main: 185344000 00:36:38 INFO - PROCESS | 14578 | 00:36:40 INFO - PROCESS | 14578 | Cycle 1(1): loaded http://localhost:45427/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45427/tests/kraken/driver.html?testName=audio-beat-detection) 00:36:41 INFO - PROCESS | 14578 | RSS: Main: 198746112 00:36:41 INFO - PROCESS | 14578 | 00:36:44 INFO - PROCESS | 14578 | Cycle 1(1): loaded http://localhost:45427/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45427/tests/kraken/driver.html?testName=audio-dft) 00:36:45 INFO - PROCESS | 14578 | RSS: Main: 196567040 00:36:45 INFO - PROCESS | 14578 | 00:36:47 INFO - PROCESS | 14578 | Cycle 1(1): loaded http://localhost:45427/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45427/tests/kraken/driver.html?testName=audio-fft) 00:36:48 INFO - PROCESS | 14578 | RSS: Main: 193040384 00:36:48 INFO - PROCESS | 14578 | 00:36:50 INFO - PROCESS | 14578 | Cycle 1(1): loaded http://localhost:45427/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45427/tests/kraken/driver.html?testName=audio-oscillator) 00:36:51 INFO - PROCESS | 14578 | RSS: Main: 193339392 00:36:51 INFO - PROCESS | 14578 | 00:36:53 INFO - PROCESS | 14578 | Cycle 1(1): loaded http://localhost:45427/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45427/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:36:54 INFO - PROCESS | 14578 | RSS: Main: 193552384 00:36:54 INFO - PROCESS | 14578 | 00:36:57 INFO - PROCESS | 14578 | Cycle 1(1): loaded http://localhost:45427/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45427/tests/kraken/driver.html?testName=imaging-darkroom) 00:36:57 INFO - PROCESS | 14578 | RSS: Main: 199393280 00:36:57 INFO - PROCESS | 14578 | 00:37:01 INFO - PROCESS | 14578 | Cycle 1(1): loaded http://localhost:45427/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45427/tests/kraken/driver.html?testName=imaging-desaturate) 00:37:01 INFO - PROCESS | 14578 | RSS: Main: 195358720 00:37:01 INFO - PROCESS | 14578 | 00:37:04 INFO - PROCESS | 14578 | Cycle 1(1): loaded http://localhost:45427/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45427/tests/kraken/driver.html?testName=json-parse-financial) 00:37:05 INFO - PROCESS | 14578 | RSS: Main: 196485120 00:37:05 INFO - PROCESS | 14578 | 00:37:06 INFO - PROCESS | 14578 | Cycle 1(1): loaded http://localhost:45427/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45427/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:37:07 INFO - PROCESS | 14578 | RSS: Main: 196591616 00:37:07 INFO - PROCESS | 14578 | 00:37:09 INFO - PROCESS | 14578 | Cycle 1(1): loaded http://localhost:45427/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45427/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:37:09 INFO - PROCESS | 14578 | RSS: Main: 196866048 00:37:09 INFO - PROCESS | 14578 | 00:37:12 INFO - PROCESS | 14578 | Cycle 1(1): loaded http://localhost:45427/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45427/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:37:12 INFO - PROCESS | 14578 | RSS: Main: 196739072 00:37:12 INFO - PROCESS | 14578 | 00:37:15 INFO - PROCESS | 14578 | Cycle 1(1): loaded http://localhost:45427/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45427/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:37:16 INFO - PROCESS | 14578 | RSS: Main: 196636672 00:37:16 INFO - PROCESS | 14578 | 00:37:19 INFO - PROCESS | 14578 | Cycle 1(1): loaded http://localhost:45427/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45427/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:37:19 INFO - PROCESS | 14578 | RSS: Main: 197087232 00:37:19 INFO - PROCESS | 14578 | 00:37:21 INFO - PROCESS | 14578 | Cycle 1(1): loaded http://localhost:45427/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45427/tests/kraken/driver.html?testName=ai-astar) 00:37:21 INFO - PROCESS | 14578 | RSS: Main: 198041600 00:37:21 INFO - PROCESS | 14578 | 00:37:21 INFO - PROCESS | 14578 | __start_tp_report 00:37:21 INFO - PROCESS | 14578 | _x_x_mozilla_page_load 00:37:21 INFO - PROCESS | 14578 | _x_x_mozilla_page_load_details 00:37:21 INFO - PROCESS | 14578 | |i|pagename|runs| 00:37:21 INFO - PROCESS | 14578 | |0;ai-astar;104;113;112;112;112;112;112;112;113;111 00:37:21 INFO - PROCESS | 14578 | |1;audio-beat-detection;162;127;126;164;125;126;128;128;143;130 00:37:21 INFO - PROCESS | 14578 | |2;audio-dft;164;164;164;167;168;165;164;162;161;162 00:37:21 INFO - PROCESS | 14578 | |3;audio-fft;75;76;78;101;76;76;76;76;100;76 00:37:21 INFO - PROCESS | 14578 | |4;audio-oscillator;82;84;103;83;83;85;97;83;82;118 00:37:21 INFO - PROCESS | 14578 | |5;imaging-gaussian-blur;119;119;117;119;118;118;117;122;118;119 00:37:21 INFO - PROCESS | 14578 | |6;imaging-darkroom;146;147;146;147;146;147;147;147;147;147 00:37:21 INFO - PROCESS | 14578 | |7;imaging-desaturate;98;99;95;98;97;97;97;96;96;96 00:37:21 INFO - PROCESS | 14578 | |8;json-parse-financial;56;59;56;56;56;56;61;56;55;60 00:37:21 INFO - PROCESS | 14578 | |9;json-stringify-tinderbox;62;64;63;63;64;63;63;62;64;62 00:37:21 INFO - PROCESS | 14578 | |10;stanford-crypto-aes;88;82;87;87;82;80;82;81;82;94 00:37:21 INFO - PROCESS | 14578 | |11;stanford-crypto-ccm;142;140;137;131;151;133;150;136;176;134 00:37:21 INFO - PROCESS | 14578 | |12;stanford-crypto-pbkdf2;170;167;172;167;173;170;166;164;165;175 00:37:21 INFO - PROCESS | 14578 | |13;stanford-crypto-sha256-iterative;73;66;65;65;66;66;67;70;67;66 00:37:21 INFO - PROCESS | 14578 | __end_tp_report 00:37:21 INFO - PROCESS | 14578 | __start_cc_report 00:37:21 INFO - PROCESS | 14578 | _x_x_mozilla_cycle_collect,804 00:37:21 INFO - PROCESS | 14578 | __end_cc_report 00:37:21 INFO - PROCESS | 14578 | __startTimestamp1479890241658__endTimestamp 00:37:21 INFO - PROCESS | 14578 | 00:37:21 INFO - PROCESS | 14578 | ------- Summary: start ------- 00:37:21 INFO - PROCESS | 14578 | Number of tests: 14 00:37:21 INFO - PROCESS | 14578 | 00:37:21 INFO - PROCESS | 14578 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.63 (2.3%) stddev-sans-first:0.60 00:37:21 INFO - PROCESS | 14578 | Values: 104.0 113.0 112.0 112.0 112.0 112.0 112.0 112.0 113.0 111.0 00:37:21 INFO - PROCESS | 14578 | 00:37:21 INFO - PROCESS | 14578 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:129.00 stddev:15.18 (11.8%) stddev-sans-first:12.84 00:37:21 INFO - PROCESS | 14578 | Values: 162.0 127.0 126.0 164.0 125.0 126.0 128.0 128.0 143.0 130.0 00:37:21 INFO - PROCESS | 14578 | 00:37:21 INFO - PROCESS | 14578 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.18 (1.3%) stddev-sans-first:2.32 00:37:21 INFO - PROCESS | 14578 | Values: 164.0 164.0 164.0 167.0 168.0 165.0 164.0 162.0 161.0 162.0 00:37:21 INFO - PROCESS | 14578 | 00:37:21 INFO - PROCESS | 14578 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.00 stddev:10.31 (13.6%) stddev-sans-first:10.70 00:37:21 INFO - PROCESS | 14578 | Values: 75.0 76.0 78.0 101.0 76.0 76.0 76.0 76.0 100.0 76.0 00:37:21 INFO - PROCESS | 14578 | 00:37:21 INFO - PROCESS | 14578 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:83.00 stddev:12.19 (14.7%) stddev-sans-first:12.58 00:37:21 INFO - PROCESS | 14578 | Values: 82.0 84.0 103.0 83.0 83.0 85.0 97.0 83.0 82.0 118.0 00:37:21 INFO - PROCESS | 14578 | 00:37:21 INFO - PROCESS | 14578 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:119.00 stddev:1.43 (1.2%) stddev-sans-first:1.51 00:37:21 INFO - PROCESS | 14578 | Values: 119.0 119.0 117.0 119.0 118.0 118.0 117.0 122.0 118.0 119.0 00:37:21 INFO - PROCESS | 14578 | 00:37:21 INFO - PROCESS | 14578 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 00:37:21 INFO - PROCESS | 14578 | Values: 146.0 147.0 146.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 00:37:21 INFO - PROCESS | 14578 | 00:37:21 INFO - PROCESS | 14578 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:97.00 stddev:1.20 (1.2%) stddev-sans-first:1.20 00:37:21 INFO - PROCESS | 14578 | Values: 98.0 99.0 95.0 98.0 97.0 97.0 97.0 96.0 96.0 96.0 00:37:21 INFO - PROCESS | 14578 | 00:37:21 INFO - PROCESS | 14578 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:56.00 stddev:2.08 (3.7%) stddev-sans-first:2.17 00:37:21 INFO - PROCESS | 14578 | Values: 56.0 59.0 56.0 56.0 56.0 56.0 61.0 56.0 55.0 60.0 00:37:21 INFO - PROCESS | 14578 | 00:37:21 INFO - PROCESS | 14578 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 00:37:21 INFO - PROCESS | 14578 | Values: 62.0 64.0 63.0 63.0 64.0 63.0 63.0 62.0 64.0 62.0 00:37:21 INFO - PROCESS | 14578 | 00:37:21 INFO - PROCESS | 14578 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.50 stddev:4.38 (5.2%) stddev-sans-first:4.46 00:37:21 INFO - PROCESS | 14578 | Values: 88.0 82.0 87.0 87.0 82.0 80.0 82.0 81.0 82.0 94.0 00:37:21 INFO - PROCESS | 14578 | 00:37:21 INFO - PROCESS | 14578 | [#11] stanford-crypto-ccm Cycles:10 Average:143.00 Median:141.00 stddev:13.42 (9.5%) stddev-sans-first:14.23 00:37:21 INFO - PROCESS | 14578 | Values: 142.0 140.0 137.0 131.0 151.0 133.0 150.0 136.0 176.0 134.0 00:37:21 INFO - PROCESS | 14578 | 00:37:21 INFO - PROCESS | 14578 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.90 Median:170.00 stddev:3.67 (2.2%) stddev-sans-first:3.87 00:37:21 INFO - PROCESS | 14578 | Values: 170.0 167.0 172.0 167.0 173.0 170.0 166.0 164.0 165.0 175.0 00:37:21 INFO - PROCESS | 14578 | 00:37:21 INFO - PROCESS | 14578 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:66.50 stddev:2.51 (3.8%) stddev-sans-first:1.51 00:37:21 INFO - PROCESS | 14578 | Values: 73.0 66.0 65.0 65.0 66.0 66.0 67.0 70.0 67.0 66.0 00:37:21 INFO - PROCESS | 14578 | -------- Summary: end -------- 00:37:21 INFO - PROCESS | 14578 | 00:37:22 INFO - TEST-INFO | 14578: exit 0 00:37:22 INFO - TEST-OK | kraken | took 62687ms 00:37:22 INFO - SUITE-END | took 1178s 00:37:23 INFO - Completed test suite (00:19:39) 00:37:23 INFO - javascript benchmark 00:37:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7152.986576404431, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3082.2140354209673, 3113.361760839028, 3118.2672072063046, 3142.1359126240272, 3148.0241125251173, 5455.890882182354, 5481.506664400204, 5535.086710692731, 5536.972315138423, 5562.221289019541, 5491.752871120799, 5556.9444305556935, 5577.8605534861645, 5582.609217354787, 5589.049861523541, 4955.835378686006, 4988.551030407262, 5018.172001619729, 5075.746212689369, 5148.536631703146, 4929.679570827902, 5019.673721208128, 5045.974770126144, 5074.3657042869645, 5078.009788091324, 4960.404751429834, 5073.797048118071, 5079.060373830835, 5085.669431486942, 5116.232565115244, 5025.949740502585, 5099.4390617032095, 5110.693358398508, 5111.948880511184, 5118.59051275897, 4839.225723884161, 4883.609311255091, 4897.755112244374, 4901.313816065754, 4978.327925730016, 5406.162044883049, 5419.0, 5461.590380721422, 5476.397596264408, 5493.148561972901, 5920.526357891358, 5928.199693041471, 5929.436703513159, 5929.8814023719715, 5968.910466342965, 5946.672932988684, 5948.524118070544, 5952.226210592638, 5954.97022514889, 5966.791162309341, 5319.308489896327, 5341.519263266325, 5343.465653434703, 5517.2551705519645, 5519.641223320471, 5943.0, 5965.194698715618, 6037.78867739627, 6038.124471951543, 6111.205543279434, 5746.195532625436, 5769.134629805479, 5794.130880367894, 5811.2445382100905, 5828.912566311508, 5894.852628684317, 5895.823125306248, 5898.941010589925, 5906.3207731110615, 5908.852278693067, 5723.198752174699, 5771.88456230873, 5811.157382179645, 5822.534197264209, 5827.59206855516, 5769.538436925036, 5776.046952252916, 5778.0, 5795.88408231833, 5813.418658134237, 4440.156370289635, 4470.709403888737, 4495.9325610115875, 4516.299973504112, 4524.298733696282, 3983.1237127831832, 4012.498437695288, 4012.779297138627, 4021.6380525752825, 4048.6963477739287, 5475.6440831345835, 5527.917081243784, 5635.098384258499, 5642.379338272786, 5656.943430565724, 5876.500497457679, 5916.437938395846, 5918.201042859245, 5918.852028699231, 5920.31916329619, 5470.0, 5610.438956104438, 5628.099504079328, 5656.688882111441, 5706.4864162225595, 5090.974545127251, 5120.692758434506, 5136.614753893473, 5138.563222126161, 5140.948590514122, 5996.88006239864, 6185.876282474415, 6193.411625895533, 6196.783112591128, 6202.131701561695, 5832.9708351457975, 5887.3523912370465, 5889.234399528034, 5911.290645122613, 5919.644821310735, 6029.3669164737075, 6089.908651370144, 6103.267607886904, 6136.570440069152, 6159.84600384994, 5751.223584816164, 5757.568182386254, 5794.681292528951, 5798.246227990334, 5846.532277417881, 5909.763609455574, 5915.142304365929, 5915.763369465173, 5917.142014407973, 5924.585279030426, 5490.91763623538, 5597.944020559905, 5601.831945041656, 5722.542196624343, 5781.653100813965, 5736.770529178786, 5739.110437882135, 5741.368449470471, 5770.971145144247, 5788.160716696139, 5682.204491371129, 5707.857303567444, 5714.999875021771, 5724.656520608777, 5728.455796699307, 5686.2323586315315, 5704.914426283692, 5737.569682273763, 5787.334456537552, 5805.390434004369, 5524.1989911463415, 5608.943910561005, 5707.6290041147195, 5713.143028545585, 5715.371309156073], "value": 5425.019543737543, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.8523498655363, 566.991495127573, 579.5218944370893, 582.0599731433736, 601.4466690644607, 39889.80055099724, 41659.58340416595, 41713.791431042875, 44875.32687009697, 44969.775151124195, 42932.570674293245, 43271.0, 43299.13401731972, 43367.13265734691, 43425.0, 8531.95734021329, 8668.826623467527, 8691.087435819243, 10153.0, 10429.16566674668, 10334.431606261653, 10355.0, 10404.583816647362, 10469.371837689725, 10500.632477863277, 10370.066693997538, 10461.895381046206, 10474.0, 10485.475726213659, 10513.264071514997, 10413.895861041407, 10490.265681402305, 10491.895081049168, 10514.526846291936, 10514.894851051467, 10376.94811525945, 10381.84427233592, 10445.529951152217, 10453.790924181474, 10474.528646210938, 40265.396019059735, 40334.39498407526, 40529.18941621151, 40709.59290407088, 40785.38821917673, 3135.3415782685665, 3173.76196785242, 3253.430649636304, 3303.900882973515, 3654.104744337628, 28879.855600722072, 29915.850420747975, 30107.397852043054, 30293.697063029307, 30366.240843978856, 4156.251874662559, 4276.205741220632, 4306.138772245564, 4428.335749637548, 4433.290673492225, 333610.0, 335210.2394880246, 336775.0, 338243.0, 338585.0, 58661.0, 58944.41055589389, 58993.41006589965, 58998.0, 59199.304090467966, 60622.393776061675, 60828.391716083155, 61000.38999609947, 61022.694886525285, 61061.0, 16599.50201493933, 16848.073355965294, 16901.915490422714, 16965.066921319198, 17000.234989425506, 12181.634550963485, 12440.377981100908, 12457.377131143407, 12859.42132604035, 12919.418626161845, 18634.25462981493, 19495.8050419494, 19531.0, 19549.90225048894, 19585.412437626896, 6560.44236239925, 7136.250693677193, 7383.2985866342615, 7389.66746496409, 7440.85118297631, 917.3349321741684, 1009.6213919780082, 1012.0739523336065, 1067.8611780468646, 1081.9404932728776, 31319.0, 31462.21344466361, 31710.207244819063, 31744.0, 32110.0, 1034.6120204923154, 1084.414416215235, 1105.3865104866716, 1117.022605220432, 1163.4357336691698, 15183.468578599695, 18172.36396726108, 18450.169742361624, 18471.90764046171, 19199.808001920082, 475681.0, 495827.0, 497120.0, 498873.0, 501684.0, 59250.0, 60071.0, 60304.0, 60504.39495605075, 60564.0, 1339.3035621476972, 1346.7912473566612, 1386.7850483175123, 1389.2914613547366, 1392.0812263905975, 31004.844975774977, 32456.67543324631, 32672.50991235086, 33212.50181247332, 33412.498812518315, 50533.74733126311, 50838.74580627073, 50903.236451453995, 51066.744666276434, 51300.0, 440582.0, 440896.0, 443126.0, 444512.0, 446316.0, 41147.58852411438, 41315.7934210327, 41345.0, 41542.58457415508, 41598.58401416068, 39228.215435691694, 43303.566964329955, 43893.0, 45766.771166145285, 48863.755681221366, 38955.61044389633, 39662.2067558653, 40201.0, 41237.1752564953, 41998.37002444905, 39187.216255675296, 39556.40665389964, 39800.40299395569, 40088.0, 40277.597224028556, 39725.80137099296, 40538.0, 40617.796911015255, 40651.0, 40881.59118408778, 32944.34111317808, 35725.821370892976, 36231.27537449289, 36738.0, 36863.63136368602, 27385.589216161374, 27416.862915685295, 27682.723172768016, 27744.8612756943, 27836.582451263654], "value": 20482.354725793408, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.7974563354239, 394.2705993911266, 401.34179944890377, 405.2664676934748, 423.68647201071195, 13603.38784754686, 17621.911890440544, 17960.640787184282, 19062.23751049958, 19094.33169839056, 16439.178041097955, 16636.417725379582, 16859.07275099872, 16879.83120168798, 17093.743593846102, 5483.7532311046, 5503.064479038553, 5633.436656334375, 5738.512226460756, 5743.224664670279, 5561.304836895388, 5622.240997465331, 5646.774129034834, 5660.150977353389, 5665.291838520185, 5560.555155587544, 5573.888522229553, 5593.133064375008, 5634.464725851038, 5650.406707295737, 5456.48163424476, 5570.108782594765, 5611.186377975171, 5611.186377975191, 5622.156676498517, 4789.137955168068, 4882.43851957026, 4927.6304277179, 4979.502049795028, 5013.39839219296, 22111.889440552855, 22257.220997265016, 22382.0, 22697.886510567507, 22881.54236915269, 2290.415943934303, 2320.013994052538, 2385.642153676945, 2412.963805542918, 2908.665503467086, 9959.352642078242, 10605.73485662857, 13279.402426890812, 13505.729885402237, 14375.28123593816, 1787.2672204396135, 1837.9724304135448, 1845.9630807383912, 1922.7596550431197, 1959.206521358852, 79116.60441697812, 82068.58965705193, 83569.16430835675, 84884.57557712233, 85948.57025714831, 10957.780844383067, 11130.49912753928, 11174.10607151426, 11183.608573699881, 11426.542938282542, 11929.880701193051, 15113.54659360221, 15266.236688165769, 15312.157831319384, 15373.615659608598, 7707.845843083107, 7733.304002639789, 7958.960205198937, 7985.321247693895, 8016.358691304682, 7643.159252482223, 7679.769606911802, 7765.922340776633, 7902.446828721934, 8006.679732810739, 4045.7977101144825, 4059.411385349108, 4085.2850751118435, 4090.3250963591267, 4223.1553689261655, 1963.1656545967905, 1986.7185665245836, 2008.357325655776, 2020.6665900126316, 2024.1903238704635, 891.5096696816724, 905.651324240159, 973.532704301939, 988.7528117970508, 992.846108853129, 17773.822261777474, 19288.22847086129, 19294.571589937976, 19407.902960485106, 19432.70850937237, 945.8817647794026, 954.656323723459, 956.3257903178243, 965.4014511003082, 966.9750064931195, 10140.2340899777, 10800.027997480265, 10811.459427028618, 10921.290116142425, 10927.726806829893, 441601.0, 453966.0, 455311.0, 456115.8272590079, 461655.0, 87691.56154219188, 87899.56050219836, 88403.55798221096, 88795.0, 91050.0, 926.1988380051207, 955.5317894231777, 981.9214462842956, 982.3516479123743, 985.4678473624163, 16496.17519124063, 16522.339106435607, 17236.913815430842, 17389.0, 17454.738178927073, 40229.19541609093, 40640.1871962565, 41098.38352424776, 41206.381904270864, 41926.58073419227, 54474.0, 54789.0, 54858.45141548693, 55675.44324556865, 56237.43762562322, 8264.917350826414, 8290.170982901662, 8385.161483851565, 8602.18279263469, 8885.822283554164, 11624.476898539417, 11699.23954942926, 12227.69430764238, 12910.0, 12920.418581164058, 10757.46212689378, 10815.729606759895, 10942.0, 10992.615258465916, 11269.830952535882, 10606.310589811637, 10612.946935265274, 10921.235513513977, 10982.560697572007, 11670.824937626112, 10415.895841041493, 10547.0, 10695.465226738477, 10860.837087443537, 11357.148213883827, 7252.818679533054, 7367.300106489874, 7496.437767167593, 8003.599820009093, 8548.401611887108, 9959.352642078242, 10748.623798167027, 10924.235303528676, 11012.17408694335, 11945.402729863647], "value": 8914.469490640595, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.731429685508, 1473.6242258224154, 1605.7109720250357, 1719.688742315702, 1721.440531827155, 7692.769216923487, 7959.442839001273, 8145.674173033079, 8783.648654053839, 8847.938247410311, 8271.627776750045, 8541.658333666646, 8558.657653693861, 8810.118988101187, 8811.559422028906, 2332.3003099070297, 2370.7984821290124, 2371.0515793682493, 2371.9644205336936, 2373.2761507740133, 2257.3566533537864, 2326.0346956013236, 2327.0691723310642, 2329.1498603009863, 2330.6132850953654, 2291.8051965582945, 2315.5947709150914, 2339.6841426407386, 2371.2412028150998, 2377.595808712523, 2290.576243394977, 2302.631578947369, 2316.3166865774638, 2320.953580928389, 2338.543983923136, 2263.0, 2284.805791507724, 2285.5543169082034, 2288.233441797, 2289.5878741826464, 8545.786355341104, 8686.782830429227, 8756.255718263956, 8759.868601970975, 8762.299016078698, 5144.56271216947, 5262.631615786897, 5306.442823503554, 5309.867253318659, 5312.043832110218, 3092.8762849485993, 3109.8134111953354, 3413.2832105257676, 3427.7086447651977, 3433.210361616817, 1074.371492676785, 1096.9177311701653, 1117.4133579870552, 1134.8014097532898, 1154.9307041577533, 12010.579629712918, 12027.93986030073, 12094.516219351304, 12098.939505302505, 12111.999999999913, 4451.243288640874, 4628.768561571908, 4722.645801564828, 4735.881602959885, 4750.524947505291, 10019.79960400788, 10083.294169408071, 10091.091801737879, 10095.848562271573, 10128.848067278997, 5339.359276886721, 5342.813001544927, 5348.491893270133, 5349.251104845324, 5359.062164121263, 4319.611234988866, 4348.543402942645, 4744.667873248839, 4816.54242846936, 4903.607711383081, 3736.8886579083273, 3791.7345785795283, 3844.442555829389, 3949.4865667463046, 3989.58109398509, 1251.9374031298398, 1253.2417887178308, 1254.5358217459416, 1266.4997326056157, 1285.1774864086992, 809.2110192562204, 917.8852643419573, 927.679950417105, 929.6002718830968, 941.5951141009294, 5889.440503152194, 5930.7924222652, 6020.307664618537, 6069.787557435557, 6102.359252278536, 466.9626429885601, 487.8511106344578, 490.80367852858427, 499.18134259813934, 980.1864452504404, 3821.6942644588366, 4085.0, 4132.037282290948, 4144.233316836395, 4155.58444155582, 10524.736881577868, 10610.469476526143, 10661.84007239892, 10866.945665271782, 10867.29362591429, 10716.839247411139, 10719.303245289031, 10748.193885458622, 10760.892391076146, 10807.78384432307, 7709.229077092358, 7956.602169891482, 7998.680052797823, 8017.158198389202, 8188.344932405394, 5465.234867118527, 5620.662760234399, 5679.17651940458, 5888.263967004124, 5976.103584462366, 9712.125908668253, 9813.852792208265, 9909.900900990899, 9983.500824958577, 9995.800083998134, 9660.75848103803, 9897.901020989699, 10163.441010744184, 10163.7459063524, 10200.438975856103, 8012.5192488450875, 8160.714374996846, 8204.466709663853, 8251.0, 8355.0, 8526.829463410573, 8547.0, 8560.357973152162, 8586.0, 8602.956985215034, 7308.744193953399, 7498.850022999619, 7536.5101268417375, 7758.107817601048, 7826.569538675428, 7307.0, 7323.048003759477, 7361.447891408059, 7409.37020353276, 7423.888641670487, 7009.0, 7037.225905150532, 7107.715691372287, 7139.32176443237, 7141.321574450419, 5026.346574945233, 5075.375879718455, 5134.974325128351, 5208.0, 5382.838514844561, 5175.508326708957, 5232.581393488588, 5248.475152484721, 5306.097963346318, 5392.5416339611575], "value": 4540.276966672212, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.49848743522926, 319.1988109844291, 327.3730805507453, 329.47119872604486, 329.89485224497935, 5352.357717073947, 5392.218128371389, 5409.43200963899, 5471.753771080301, 5486.259354987075, 5329.813456529013, 5347.465253474651, 5380.784768609261, 5382.461753824616, 5385.542228910547, 4196.328587426013, 4199.3281075028, 4236.449261595988, 4238.173556156551, 4240.745555266679, 3986.0034991252187, 4140.275451795924, 4224.936625950613, 4227.936580951288, 4232.640225580829, 4163.542010378856, 4164.666826653875, 4167.666586673059, 4179.540250572434, 4185.393117997888, 4154.52222994355, 4163.167366526692, 4169.353750168729, 4187.20443115807, 4220.113776107021, 3675.4119340905327, 3685.636314563602, 3691.003429074135, 3695.9630403695887, 3696.796676182809, 5198.506141916512, 5283.788648454057, 5284.6564973277, 5302.814401495968, 5321.201819727034, 4740.7007601313335, 4772.880677983044, 4774.73738944358, 4776.617870570346, 4776.737279449629, 5507.586930980153, 5575.609707320489, 5577.972110139464, 5629.549636029108, 5632.07070833312, 3897.142628621699, 3947.5460322063045, 3962.128331767007, 3967.920641587152, 3994.2610617035944, 5796.681182534959, 5799.507041901444, 5805.0, 5825.126231065332, 5898.233229680114, 4126.216018956388, 4147.52303485103, 4159.542450330461, 4159.668905950067, 4166.562510936369, 4072.7759973201164, 4140.399642051885, 4144.689148313889, 4177.394277829759, 4186.183694179666, 4726.527347265246, 4738.360321356642, 4747.2879068140055, 4759.904801903943, 4767.141914455431, 5645.927273817962, 5668.69179423641, 5684.687342196219, 5684.8863022739315, 5712.285964254468, 1319.0371029148582, 1344.6571124363224, 1368.493657346788, 1385.5081446086695, 1387.126110550367, 933.3000249812641, 938.2540880000416, 939.7829810395417, 956.5695437053354, 962.8988956159502, 5226.863881670967, 5248.55664692205, 5251.0, 5298.576113910955, 5309.867253318698, 5632.605717599728, 5641.0, 5644.689542075225, 5650.886982260332, 5662.631928924607, 5110.95225478776, 5157.329547158845, 5210.192420174879, 5218.930119325529, 5304.363476382781, 2932.9441401095587, 2936.7797415193945, 2960.955585666217, 2973.0, 2982.7331228266676, 5768.163616275617, 5772.278465191851, 5794.50746686528, 5800.274965629296, 5810.535157187415, 5488.69812160327, 5619.325680918316, 5636.774529018875, 5651.406602306781, 5684.658920464785, 5742.885142297131, 5748.396418376094, 5755.251817263729, 5770.884582308414, 5788.884222315446, 5272.367315922113, 5454.0002998349955, 5539.612227144061, 5598.440155984369, 5613.316005198506, 5464.22412715861, 5474.644148130359, 5506.0, 5528.170774383874, 5542.722863856871, 5789.305283366023, 5828.242328497268, 5841.737121829443, 5846.590738648424, 5849.502792262705, 3885.1452680410266, 3983.66138878187, 3984.3425834736945, 3988.922990792528, 4008.518977722575, 5611.438856114356, 5620.915686264628, 5629.099344104923, 5632.522144894737, 5646.632968857011, 5631.915521267102, 5638.379778224474, 5692.7722891083895, 5696.0, 5701.201831743476, 5649.548036157015, 5649.887002259849, 5671.319441667027, 5681.375048744552, 5717.513446503855, 5511.779528818803, 5645.745941432728, 5656.717164141694, 5667.518260947865, 5690.260266165372, 5699.0, 5700.0, 5705.001624715741, 5716.771329146954, 5747.017279038725, 5387.838364849061, 5572.721363931868, 5588.804391846266, 5616.21373007771, 5661.603687741818], "value": 4245.0799703535195, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.3673988300706, 707.4764674141136, 707.8442742596627, 734.614327478074, 741.0, 13598.524051658194, 14209.218492982882, 14223.217723025255, 14377.568672939802, 14453.63865903353, 13680.0, 13884.166949983008, 13910.095843770174, 13914.234717090556, 14292.499762508314, 776.4875182379631, 797.3501596199079, 799.4883274704194, 800.5156880087521, 800.9639566219505, 799.8120441696196, 800.3557136505111, 800.6117033238875, 801.3829351399419, 802.1457148137245, 847.7075408983891, 848.3043903998723, 855.4738835616082, 855.9529225892604, 856.5888373580685, 850.0649285785648, 851.8509260879352, 852.4586887326561, 852.8550146475114, 852.923236908675, 615.1019511513196, 619.157945194535, 619.752099160335, 620.981370558884, 621.1459243540132, 14165.433382664783, 14184.361703723358, 14208.715825683532, 14228.217448040354, 14296.499622513265, 13201.669958251025, 13279.0, 13602.727945441036, 13737.862621373759, 13956.0, 11047.944760276228, 11348.0, 11504.482298296596, 11645.126615503787, 11782.234154779911, 3617.439296908983, 3667.651573100551, 3688.0964163780045, 3699.500567423417, 3709.684676802475, 61291.693541532455, 61695.383046169416, 61824.38175618231, 62160.378396215914, 62466.37533624651, 9904.653337133166, 10015.69952901414, 10184.592616295266, 10219.693409197736, 10248.333858299187, 19585.804141958397, 19710.310139145062, 19743.0, 19750.209991600463, 19827.0, 7817.609119544, 7822.256885595859, 7832.373410127176, 7867.6066196689935, 8181.918180818116, 4398.604125628709, 4456.9331460028125, 4461.263891457873, 4492.034212644232, 4581.312803079565, 3529.8588056477965, 3590.533230679995, 3592.946105808415, 3617.6744093031753, 3656.6526180012856, 622.3372108704216, 629.515273239603, 631.8388810853203, 634.926983396906, 652.9640869752114, 644.1414740169853, 700.5201437015661, 714.4355958792496, 725.5956344985885, 738.8374557597427, 9263.37786401981, 9425.764355891157, 9518.666846660471, 9652.581033612569, 10066.54700538463, 559.8264537993235, 666.9099671544279, 694.7950354645392, 696.6516741629185, 711.6157275071404, 4276.8289268429535, 4599.425071866017, 4603.516630753789, 4616.722996620214, 4637.513061128533, 88742.55628721815, 89215.0, 89564.0, 91240.0, 92003.53998229966, 47952.0, 53967.73016134894, 73623.0, 73773.0, 76232.61883690656, 67134.32865671281, 67415.3258467409, 69588.65205674041, 70202.0, 71779.0, 8835.160659737314, 9200.861987070066, 9214.817626522596, 9260.768480787765, 9315.72052838416, 40355.59644403518, 43439.0, 43891.78054109709, 44856.32715509335, 44909.550904490534, 57030.0, 59112.70443647754, 59779.0, 59982.70008649929, 61853.381466184765, 11440.599579014695, 11441.942790285995, 11892.405379731152, 12073.818892716441, 12933.741325173256, 13569.321533923461, 13916.791248131489, 14012.929935350257, 14020.649483762987, 14169.0, 12467.87532124667, 12847.807282890952, 13171.678948416496, 13257.204567725967, 13545.390457429243, 12797.616071517868, 12822.487100515875, 13132.540361087316, 13177.47290108385, 13187.340632968506, 12989.545365912149, 13003.349832508526, 13009.479620815062, 13141.0, 13327.600171994856, 10155.492225388552, 10635.8936410638, 10703.625373111903, 10803.649543807023, 11080.722981925517, 10934.835977460185, 10980.176486763365, 11001.22991390595, 11112.833307500556, 11256.549738010715], "value": 7015.102229823274, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 112.0, 112.0, 112.0, 112.0, 112.0, 112.0, 113.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 127.0, 126.0, 164.0, 125.0, 126.0, 128.0, 128.0, 143.0, 130.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 167.0, 168.0, 165.0, 164.0, 162.0, 161.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 78.0, 101.0, 76.0, 76.0, 76.0, 76.0, 100.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 103.0, 83.0, 83.0, 85.0, 97.0, 83.0, 82.0, 118.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 117.0, 119.0, 118.0, 118.0, 117.0, 122.0, 118.0, 119.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 95.0, 98.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 56.0, 56.0, 56.0, 56.0, 61.0, 56.0, 55.0, 60.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 63.0, 64.0, 63.0, 63.0, 62.0, 64.0, 62.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 87.0, 87.0, 82.0, 80.0, 82.0, 81.0, 82.0, 94.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 140.0, 137.0, 131.0, 151.0, 133.0, 150.0, 136.0, 176.0, 134.0], "value": 143.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 167.0, 172.0, 167.0, 173.0, 170.0, 166.0, 164.0, 165.0, 175.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 66.0, 65.0, 65.0, 66.0, 66.0, 67.0, 70.0, 67.0, 66.0], "value": 67.1, "unit": "score"}]}]} 00:37:23 INFO - Return code: 0 00:37:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:37:23 ERROR - # TBPL SUCCESS # 00:37:23 INFO - Running post-action listener: _resource_record_post_action 00:37:23 INFO - [mozharness: 2016-11-23 08:37:23.479625Z] Finished run-tests step (success) 00:37:23 INFO - Running post-run listener: _resource_record_post_run 00:37:23 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392970240; Read time: 16; Write time: 291012 00:37:23 INFO - TinderboxPrint: CPU usage
13.5% 00:37:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 00:37:23 INFO - TinderboxPrint: I/O write bytes / time
392,970,240 / 291,012 00:37:23 INFO - TinderboxPrint: CPU idle
8,253.0 (86.5%) 00:37:23 INFO - TinderboxPrint: CPU user
1,222.4 (12.8%) 00:37:23 INFO - TinderboxPrint: Swap in / out
0 / 0 00:37:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104026112; Read time: 0; Write time: 92088 00:37:23 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288944128; Read time: 0; Write time: 198924 00:37:24 INFO - Running post-run listener: _upload_blobber_files 00:37:24 INFO - Blob upload gear active. 00:37:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:37:24 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 00:37:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:37:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:37:24 INFO - (blobuploader) - INFO - Open directory for files ... 00:37:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:37:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:37:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:37:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:37:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:37:27 INFO - (blobuploader) - INFO - Done attempting. 00:37:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:37:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:37:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:37:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:37:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:37:28 INFO - (blobuploader) - INFO - Done attempting. 00:37:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:37:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:37:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:37:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:37:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:37:29 INFO - (blobuploader) - INFO - Done attempting. 00:37:29 INFO - (blobuploader) - INFO - Iteration through files over. 00:37:29 INFO - Return code: 0 00:37:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:37:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:37:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dc84e9db7967bbc70ba648c04c4b5dafabc7469e6d041c23ba2167dafd0cc87a0e36d7bd40135e9fd1962cf87b0bf66886c1f6aec8e7c9fc21e6cc0367fde92e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f65be3348b664577667051ad8561cfd51dc52bf3767bdb0cf97c76322b37c33533f6adc8c9afbc5305ef3545448105e2bb7a05579151ca8bfad50112ba771bb3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e1be7ae7260eb20856ebc487a841591d936df79e1ea7a8872b39c3d86dc88af3d96783f9b476c8c2bce66c4cd6982eb4f6a3c633302ba5fe1a2b8fa48e9c76f4"} 00:37:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:37:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:37:29 INFO - Contents: 00:37:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dc84e9db7967bbc70ba648c04c4b5dafabc7469e6d041c23ba2167dafd0cc87a0e36d7bd40135e9fd1962cf87b0bf66886c1f6aec8e7c9fc21e6cc0367fde92e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f65be3348b664577667051ad8561cfd51dc52bf3767bdb0cf97c76322b37c33533f6adc8c9afbc5305ef3545448105e2bb7a05579151ca8bfad50112ba771bb3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e1be7ae7260eb20856ebc487a841591d936df79e1ea7a8872b39c3d86dc88af3d96783f9b476c8c2bce66c4cd6982eb4f6a3c633302ba5fe1a2b8fa48e9c76f4"} 00:37:29 INFO - Running post-run listener: copy_logs_to_upload_dir 00:37:29 INFO - Copying logs to upload dir... 00:37:29 INFO - mkdir: /builds/slave/test/build/upload/logs 00:37:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.701158 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-11-23 00:37:29.219208) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 00:37:29.222549) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dc84e9db7967bbc70ba648c04c4b5dafabc7469e6d041c23ba2167dafd0cc87a0e36d7bd40135e9fd1962cf87b0bf66886c1f6aec8e7c9fc21e6cc0367fde92e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f65be3348b664577667051ad8561cfd51dc52bf3767bdb0cf97c76322b37c33533f6adc8c9afbc5305ef3545448105e2bb7a05579151ca8bfad50112ba771bb3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e1be7ae7260eb20856ebc487a841591d936df79e1ea7a8872b39c3d86dc88af3d96783f9b476c8c2bce66c4cd6982eb4f6a3c633302ba5fe1a2b8fa48e9c76f4"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011846 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479879013/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dc84e9db7967bbc70ba648c04c4b5dafabc7469e6d041c23ba2167dafd0cc87a0e36d7bd40135e9fd1962cf87b0bf66886c1f6aec8e7c9fc21e6cc0367fde92e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f65be3348b664577667051ad8561cfd51dc52bf3767bdb0cf97c76322b37c33533f6adc8c9afbc5305ef3545448105e2bb7a05579151ca8bfad50112ba771bb3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e1be7ae7260eb20856ebc487a841591d936df79e1ea7a8872b39c3d86dc88af3d96783f9b476c8c2bce66c4cd6982eb4f6a3c633302ba5fe1a2b8fa48e9c76f4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 00:37:29.247740) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 00:37:29.248056) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1479884784.789128-764597146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 00:37:29.332766) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 00:37:29.333045) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 00:37:29.333324) ========= ========= Total master_lag: 0.18 =========