builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1475794308.88 results: success (0) buildid: 20161006154718 builduid: eba38ad13d2c49acb49bdae25f548f17 revision: ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 15:51:48.884272) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 15:51:48.885639) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 15:51:48.886453) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 15:51:48.904396) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:51:48.905177) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 15:51:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.1M=0s 2016-10-06 15:51:49 (47.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081930 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:51:49.006912) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:51:49.007615) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019102 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:51:49.058141) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 15:51:49.058605) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df --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=9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 15:51:49,281 truncating revision to first 12 chars 2016-10-06 15:51:49,282 Setting DEBUG logging. 2016-10-06 15:51:49,282 attempt 1/10 2016-10-06 15:51:49,282 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ef345e3b5fa9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 15:51:50,532 unpacking tar archive at: fx-team-ef345e3b5fa9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.641890 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 15:51:50.716721) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 15:51:50.717105) ========= script_repo_revision: ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 15:51:50.717568) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 15:51:50.717905) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 15:51:50.728901) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-06 15:51:50.729243) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:51:51 INFO - MultiFileLogger online at 20161006 15:51:51 in /builds/slave/test 15:51:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:51:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:51:51 INFO - {'append_to_log': False, 15:51:51 INFO - 'base_work_dir': '/builds/slave/test', 15:51:51 INFO - 'blob_upload_branch': 'Fx-Team', 15:51:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:51:51 INFO - 'branch': 'Fx-Team', 15:51:51 INFO - 'buildbot_json_path': 'buildprops.json', 15:51:51 INFO - 'config_files': ('talos/linux_config.py',), 15:51:51 INFO - 'default_actions': ('clobber', 15:51:51 INFO - 'read-buildbot-config', 15:51:51 INFO - 'download-and-extract', 15:51:51 INFO - 'populate-webroot', 15:51:51 INFO - 'create-virtualenv', 15:51:51 INFO - 'install', 15:51:51 INFO - 'run-tests'), 15:51:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:51:51 INFO - 'download_minidump_stackwalk': True, 15:51:51 INFO - 'download_symbols': 'ondemand', 15:51:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:51:51 INFO - 'tooltool.py': '/tools/tooltool.py', 15:51:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:51:51 INFO - '/tools/misc-python/virtualenv.py')}, 15:51:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:51:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:51:51 INFO - 'installer_path': 'installer.exe', 15:51:51 INFO - 'log_level': 'info', 15:51:51 INFO - 'log_name': 'talos', 15:51:51 INFO - 'log_to_console': True, 15:51:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:51:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:51:51 INFO - 'opt_config_files': (), 15:51:51 INFO - 'pip_index': False, 15:51:51 INFO - 'sps_profile': False, 15:51:51 INFO - 'sps_profile_interval': 0, 15:51:51 INFO - 'suite': 'dromaeojs-e10s', 15:51:51 INFO - 'system_bits': '32', 15:51:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:51:51 INFO - 'title': 'talos-linux64-ix-022', 15:51:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:51:51 INFO - 'use_talos_json': True, 15:51:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:51:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:51:51 INFO - 'work_dir': 'build'} 15:51:51 INFO - [mozharness: 2016-10-06 22:51:51.049783Z] Running clobber step. 15:51:51 INFO - Running pre-action listener: _resource_record_pre_action 15:51:51 INFO - Running main action method: clobber 15:51:51 INFO - rmtree: /builds/slave/test/build 15:51:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:51:52 INFO - Running post-action listener: _resource_record_post_action 15:51:52 INFO - [mozharness: 2016-10-06 22:51:52.025674Z] Finished clobber step (success) 15:51:52 INFO - [mozharness: 2016-10-06 22:51:52.025774Z] Running read-buildbot-config step. 15:51:52 INFO - Running pre-action listener: _resource_record_pre_action 15:51:52 INFO - Running main action method: read_buildbot_config 15:51:52 INFO - Using buildbot properties: 15:51:52 INFO - { 15:51:52 INFO - "project": "", 15:51:52 INFO - "product": "firefox", 15:51:52 INFO - "script_repo_revision": "production", 15:51:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:51:52 INFO - "repository": "", 15:51:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 15:51:52 INFO - "buildid": "20161006154718", 15:51:52 INFO - "stage_platform": "linux64-pgo", 15:51:52 INFO - "basedir": "/builds/slave/test", 15:51:52 INFO - "buildnumber": 831, 15:51:52 INFO - "platform": "ubuntu64_hw", 15:51:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:51:52 INFO - "slavebuilddir": "test", 15:51:52 INFO - "branch": "fx-team", 15:51:52 INFO - "revision": "ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df", 15:51:52 INFO - "slavename": "talos-linux64-ix-022", 15:51:52 INFO - "builduid": "eba38ad13d2c49acb49bdae25f548f17", 15:51:52 INFO - "repo_path": "integration/fx-team" 15:51:52 INFO - } 15:51:52 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:51:52 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 15:51:52 INFO - Running post-action listener: _resource_record_post_action 15:51:52 INFO - [mozharness: 2016-10-06 22:51:52.028128Z] Finished read-buildbot-config step (success) 15:51:52 INFO - [mozharness: 2016-10-06 22:51:52.028217Z] Running download-and-extract step. 15:51:52 INFO - Running pre-action listener: _resource_record_pre_action 15:51:52 INFO - Running main action method: download_and_extract 15:51:52 INFO - mkdir: /builds/slave/test/build/tests 15:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:52 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:51:52 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:51:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:51:52 INFO - Downloaded 1361 bytes. 15:51:52 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:51:52 INFO - Using the following test package requirements: 15:51:52 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:51:52 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:51:52 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:51:52 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:52 INFO - u'jsshell-linux-x86_64.zip'], 15:51:52 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:51:52 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:51:52 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:51:52 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:51:52 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:51:52 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:51:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:51:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:51:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:51:52 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:51:52 INFO - Http code: 200 15:51:52 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 15:51:52 INFO - x-amz-cf-id: cefAtn_Px-B7eFi09cPqianVpmSkzEAazFDTEHeXs64jbyUBt2MpxA== 15:51:52 INFO - x-amz-replication-status: COMPLETED 15:51:52 INFO - x-amz-version-id: w1P88ttxLDtKSap6UU85ULloCNnisI8m 15:51:52 INFO - Expected file size: 22018140 15:51:52 INFO - Obtained file size: 22018140 15:51:56 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:51:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:51:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:51:56 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:51:56 INFO - Http code: 200 15:51:56 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 15:51:56 INFO - x-amz-cf-id: wYsJxFgD5OfncNmiJleebI0AfSo_ljCdvpowuIGJbNnwwlSua7k0hA== 15:51:56 INFO - x-amz-replication-status: COMPLETED 15:51:56 INFO - x-amz-version-id: w1P88ttxLDtKSap6UU85ULloCNnisI8m 15:51:56 INFO - Expected file size: 22018140 15:51:56 INFO - Obtained file size: 22018140 15:52:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:52:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:52:01 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:52:01 INFO - Http code: 200 15:52:01 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 15:52:01 INFO - x-amz-cf-id: wS9tjuHh3HD4CcOf7LQJQAf18rVL5F3N4gdaSFzxUeA0B1an_EB55Q== 15:52:01 INFO - x-amz-replication-status: COMPLETED 15:52:01 INFO - x-amz-version-id: JkkGCay6lzPmBKyga2XB6rsQcr24f59Y 15:52:01 INFO - Expected file size: 14409006 15:52:01 INFO - Obtained file size: 14409006 15:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:01 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:52:01 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:52:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:52:02 INFO - Downloaded 59705984 bytes. 15:52:02 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:52:02 INFO - mkdir: /builds/slave/test/properties 15:52:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:52:02 INFO - Writing to file /builds/slave/test/properties/build_url 15:52:02 INFO - Contents: 15:52:02 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:52:02 INFO - Running post-action listener: _resource_record_post_action 15:52:02 INFO - Running post-action listener: set_extra_try_arguments 15:52:02 INFO - [mozharness: 2016-10-06 22:52:02.882252Z] Finished download-and-extract step (success) 15:52:02 INFO - [mozharness: 2016-10-06 22:52:02.882480Z] Running populate-webroot step. 15:52:02 INFO - Running pre-action listener: _resource_record_pre_action 15:52:02 INFO - Running main action method: populate_webroot 15:52:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:52:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:52:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:52:02 INFO - '--tppagecycles', 15:52:02 INFO - '7'], 15:52:02 INFO - 'tests': ['tsvgm']}}, 15:52:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:52:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:52:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:52:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:52:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:52:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:52:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:02 INFO - 'talos_options': ['--disable-e10s'], 15:52:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:02 INFO - 'talos_options': ['--disable-e10s'], 15:52:02 INFO - 'tests': ['damp', 'tps']}, 15:52:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:02 INFO - 'tests': ['damp', 'tps']}, 15:52:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:52:02 INFO - 'tests': ['dromaeo_dom']}, 15:52:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:52:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:52:02 INFO - 'tests': ['basic_compositor_video']}, 15:52:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:52:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:52:02 INFO - 'tests': ['a11yr', 15:52:02 INFO - 'ts_paint', 15:52:02 INFO - 'tpaint', 15:52:02 INFO - 'sessionrestore', 15:52:02 INFO - 'sessionrestore_no_auto_restore', 15:52:02 INFO - 'tabpaint']}, 15:52:02 INFO - 'other-e10s': {'tests': ['a11yr', 15:52:02 INFO - 'ts_paint', 15:52:02 INFO - 'tpaint', 15:52:02 INFO - 'sessionrestore', 15:52:02 INFO - 'sessionrestore_no_auto_restore', 15:52:02 INFO - 'tabpaint']}, 15:52:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:52:02 INFO - 'ts_paint', 15:52:02 INFO - 'tpaint', 15:52:02 INFO - 'sessionrestore', 15:52:02 INFO - 'sessionrestore_no_auto_restore', 15:52:02 INFO - 'tabpaint']}, 15:52:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:52:02 INFO - 'ts_paint', 15:52:02 INFO - 'tpaint', 15:52:02 INFO - 'sessionrestore', 15:52:02 INFO - 'sessionrestore_no_auto_restore', 15:52:02 INFO - 'tabpaint']}, 15:52:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:52:02 INFO - 'tests': ['a11yr', 15:52:02 INFO - 'ts_paint', 15:52:02 INFO - 'tpaint', 15:52:02 INFO - 'sessionrestore', 15:52:02 INFO - 'sessionrestore_no_auto_restore', 15:52:02 INFO - 'tabpaint']}, 15:52:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:52:02 INFO - 'tests': ['a11yr', 15:52:02 INFO - 'ts_paint', 15:52:02 INFO - 'tpaint', 15:52:02 INFO - 'sessionrestore', 15:52:02 INFO - 'sessionrestore_no_auto_restore', 15:52:02 INFO - 'tabpaint']}, 15:52:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:52:02 INFO - 'tests': ['tsvgx', 15:52:02 INFO - 'tsvgr_opacity', 15:52:02 INFO - 'tart', 15:52:02 INFO - 'tscrollx', 15:52:02 INFO - 'cart']}, 15:52:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:52:02 INFO - 'tsvgr_opacity', 15:52:02 INFO - 'tart', 15:52:02 INFO - 'tscrollx', 15:52:02 INFO - 'cart']}, 15:52:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:02 INFO - 'talos_options': ['--disable-e10s'], 15:52:02 INFO - 'tests': ['tp5o']}, 15:52:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:02 INFO - 'tests': ['tp5o']}, 15:52:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:02 INFO - 'talos_options': ['--disable-e10s', 15:52:02 INFO - '--xperf_path', 15:52:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:02 INFO - 'tests': ['tp5n']}, 15:52:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:02 INFO - 'talos_options': ['--xperf_path', 15:52:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:02 INFO - 'tests': ['tp5n']}}, 15:52:02 INFO - 'talos.zip': {'path': '', 15:52:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:52:02 INFO - Running post-action listener: _resource_record_post_action 15:52:02 INFO - [mozharness: 2016-10-06 22:52:02.900738Z] Finished populate-webroot step (success) 15:52:02 INFO - [mozharness: 2016-10-06 22:52:02.900827Z] Running create-virtualenv step. 15:52:02 INFO - Running pre-action listener: _resource_record_pre_action 15:52:02 INFO - Running main action method: create_virtualenv 15:52:02 INFO - Creating virtualenv /builds/slave/test/build/venv 15:52:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:52:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:52:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:52:03 INFO - Using real prefix '/usr' 15:52:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:52:03 INFO - Installing distribute.............................................................................................................................................................................................done. 15:52:05 INFO - Installing pip.................done. 15:52:05 INFO - Return code: 0 15:52:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:52:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:52:05 INFO - Reading from file tmpfile_stdout 15:52:05 INFO - Output received: 15:52:05 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:52:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:05 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 0x7f1d5034bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d177b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da6790>, '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 0x1da7690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da7b20>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:52:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:52:05 INFO - Using env: {'DISPLAY': ':0', 15:52:05 INFO - 'HOME': '/home/cltbld', 15:52:05 INFO - 'LANG': 'en_US.UTF-8', 15:52:05 INFO - 'LANGUAGE': 'en_US:en', 15:52:05 INFO - 'LOGNAME': 'cltbld', 15:52:05 INFO - 'MAIL': '/var/mail/cltbld', 15:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:05 INFO - 'MOZ_NO_REMOTE': '1', 15:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:05 INFO - 'NO_EM_RESTART': '1', 15:52:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:05 INFO - 'PWD': '/builds/slave/test', 15:52:05 INFO - 'SHELL': '/bin/bash', 15:52:05 INFO - 'SHLVL': '1', 15:52:05 INFO - 'TERM': 'linux', 15:52:05 INFO - 'TMOUT': '86400', 15:52:05 INFO - 'USER': 'cltbld', 15:52:05 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 15:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:05 INFO - '_': '/tools/buildbot/bin/python'} 15:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:52:05 INFO - Cleaning up... 15:52:05 INFO - Return code: 0 15:52:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:05 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 0x7f1d5034bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d177b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da6790>, '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 0x1da7690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da7b20>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:52:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:52:05 INFO - Using env: {'DISPLAY': ':0', 15:52:05 INFO - 'HOME': '/home/cltbld', 15:52:05 INFO - 'LANG': 'en_US.UTF-8', 15:52:05 INFO - 'LANGUAGE': 'en_US:en', 15:52:05 INFO - 'LOGNAME': 'cltbld', 15:52:05 INFO - 'MAIL': '/var/mail/cltbld', 15:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:05 INFO - 'MOZ_NO_REMOTE': '1', 15:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:05 INFO - 'NO_EM_RESTART': '1', 15:52:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:05 INFO - 'PWD': '/builds/slave/test', 15:52:05 INFO - 'SHELL': '/bin/bash', 15:52:05 INFO - 'SHLVL': '1', 15:52:05 INFO - 'TERM': 'linux', 15:52:05 INFO - 'TMOUT': '86400', 15:52:05 INFO - 'USER': 'cltbld', 15:52:05 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 15:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:05 INFO - '_': '/tools/buildbot/bin/python'} 15:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:06 INFO - Downloading/unpacking psutil>=3.1.1 15:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:52:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:08 INFO - Installing collected packages: psutil 15:52:08 INFO - Running setup.py install for psutil 15:52:08 INFO - building 'psutil._psutil_linux' extension 15:52:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:52:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:52:08 INFO - building 'psutil._psutil_posix' extension 15:52:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:52:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:52:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:08 INFO - Successfully installed psutil 15:52:08 INFO - Cleaning up... 15:52:08 INFO - Return code: 0 15:52:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:08 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 0x7f1d5034bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d177b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da6790>, '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 0x1da7690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da7b20>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:52:08 INFO - Using env: {'DISPLAY': ':0', 15:52:08 INFO - 'HOME': '/home/cltbld', 15:52:08 INFO - 'LANG': 'en_US.UTF-8', 15:52:08 INFO - 'LANGUAGE': 'en_US:en', 15:52:08 INFO - 'LOGNAME': 'cltbld', 15:52:08 INFO - 'MAIL': '/var/mail/cltbld', 15:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:08 INFO - 'MOZ_NO_REMOTE': '1', 15:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:08 INFO - 'NO_EM_RESTART': '1', 15:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:08 INFO - 'PWD': '/builds/slave/test', 15:52:08 INFO - 'SHELL': '/bin/bash', 15:52:08 INFO - 'SHLVL': '1', 15:52:08 INFO - 'TERM': 'linux', 15:52:08 INFO - 'TMOUT': '86400', 15:52:08 INFO - 'USER': 'cltbld', 15:52:08 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 15:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:08 INFO - '_': '/tools/buildbot/bin/python'} 15:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:52:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:52:10 INFO - Installing collected packages: mozsystemmonitor 15:52:10 INFO - Running setup.py install for mozsystemmonitor 15:52:10 INFO - Successfully installed mozsystemmonitor 15:52:10 INFO - Cleaning up... 15:52:11 INFO - Return code: 0 15:52:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:11 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 0x7f1d5034bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d177b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da6790>, '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 0x1da7690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da7b20>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:52:11 INFO - Using env: {'DISPLAY': ':0', 15:52:11 INFO - 'HOME': '/home/cltbld', 15:52:11 INFO - 'LANG': 'en_US.UTF-8', 15:52:11 INFO - 'LANGUAGE': 'en_US:en', 15:52:11 INFO - 'LOGNAME': 'cltbld', 15:52:11 INFO - 'MAIL': '/var/mail/cltbld', 15:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:11 INFO - 'MOZ_NO_REMOTE': '1', 15:52:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:11 INFO - 'NO_EM_RESTART': '1', 15:52:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:11 INFO - 'PWD': '/builds/slave/test', 15:52:11 INFO - 'SHELL': '/bin/bash', 15:52:11 INFO - 'SHLVL': '1', 15:52:11 INFO - 'TERM': 'linux', 15:52:11 INFO - 'TMOUT': '86400', 15:52:11 INFO - 'USER': 'cltbld', 15:52:11 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 15:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:11 INFO - '_': '/tools/buildbot/bin/python'} 15:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:11 INFO - Downloading/unpacking jsonschema==2.5.1 15:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:52:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:13 INFO - Downloading functools32-3.2.3-2.tar.gz 15:52:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:52:13 INFO - warning: no files found matching '*.txt' 15:52:13 INFO - no previously-included directories found matching 'build' 15:52:13 INFO - no previously-included directories found matching 'dist' 15:52:13 INFO - no previously-included directories found matching '.git*' 15:52:13 INFO - Installing collected packages: jsonschema, functools32 15:52:13 INFO - Running setup.py install for functools32 15:52:13 INFO - warning: no files found matching '*.txt' 15:52:13 INFO - no previously-included directories found matching 'build' 15:52:13 INFO - no previously-included directories found matching 'dist' 15:52:13 INFO - no previously-included directories found matching '.git*' 15:52:13 INFO - Successfully installed jsonschema functools32 15:52:13 INFO - Cleaning up... 15:52:13 INFO - Return code: 0 15:52:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:13 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 0x7f1d5034bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d177b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da6790>, '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 0x1da7690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da7b20>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:52:13 INFO - Using env: {'DISPLAY': ':0', 15:52:13 INFO - 'HOME': '/home/cltbld', 15:52:13 INFO - 'LANG': 'en_US.UTF-8', 15:52:13 INFO - 'LANGUAGE': 'en_US:en', 15:52:13 INFO - 'LOGNAME': 'cltbld', 15:52:13 INFO - 'MAIL': '/var/mail/cltbld', 15:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:13 INFO - 'MOZ_NO_REMOTE': '1', 15:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:13 INFO - 'NO_EM_RESTART': '1', 15:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:13 INFO - 'PWD': '/builds/slave/test', 15:52:13 INFO - 'SHELL': '/bin/bash', 15:52:13 INFO - 'SHLVL': '1', 15:52:13 INFO - 'TERM': 'linux', 15:52:13 INFO - 'TMOUT': '86400', 15:52:13 INFO - 'USER': 'cltbld', 15:52:13 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 15:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:13 INFO - '_': '/tools/buildbot/bin/python'} 15:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:52:13 INFO - Cleaning up... 15:52:13 INFO - Return code: 0 15:52:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:13 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 0x7f1d5034bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d177b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da6790>, '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 0x1da7690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da7b20>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:52:13 INFO - Using env: {'DISPLAY': ':0', 15:52:13 INFO - 'HOME': '/home/cltbld', 15:52:13 INFO - 'LANG': 'en_US.UTF-8', 15:52:13 INFO - 'LANGUAGE': 'en_US:en', 15:52:13 INFO - 'LOGNAME': 'cltbld', 15:52:13 INFO - 'MAIL': '/var/mail/cltbld', 15:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:13 INFO - 'MOZ_NO_REMOTE': '1', 15:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:13 INFO - 'NO_EM_RESTART': '1', 15:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:13 INFO - 'PWD': '/builds/slave/test', 15:52:13 INFO - 'SHELL': '/bin/bash', 15:52:13 INFO - 'SHLVL': '1', 15:52:13 INFO - 'TERM': 'linux', 15:52:13 INFO - 'TMOUT': '86400', 15:52:13 INFO - 'USER': 'cltbld', 15:52:13 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 15:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:13 INFO - '_': '/tools/buildbot/bin/python'} 15:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:14 INFO - Downloading/unpacking blobuploader==1.2.4 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:15 INFO - Downloading blobuploader-1.2.4.tar.gz 15:52:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:52:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:52:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:16 INFO - Downloading docopt-0.6.1.tar.gz 15:52:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:52:16 INFO - Installing collected packages: blobuploader, requests, docopt 15:52:16 INFO - Running setup.py install for blobuploader 15:52:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:52:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:52:16 INFO - Running setup.py install for requests 15:52:17 INFO - Running setup.py install for docopt 15:52:17 INFO - Successfully installed blobuploader requests docopt 15:52:17 INFO - Cleaning up... 15:52:17 INFO - Return code: 0 15:52:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:17 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 0x7f1d5034bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d177b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da6790>, '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 0x1da7690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da7b20>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:52:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:52:17 INFO - Using env: {'DISPLAY': ':0', 15:52:17 INFO - 'HOME': '/home/cltbld', 15:52:17 INFO - 'LANG': 'en_US.UTF-8', 15:52:17 INFO - 'LANGUAGE': 'en_US:en', 15:52:17 INFO - 'LOGNAME': 'cltbld', 15:52:17 INFO - 'MAIL': '/var/mail/cltbld', 15:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:17 INFO - 'MOZ_NO_REMOTE': '1', 15:52:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:17 INFO - 'NO_EM_RESTART': '1', 15:52:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:17 INFO - 'PWD': '/builds/slave/test', 15:52:17 INFO - 'SHELL': '/bin/bash', 15:52:17 INFO - 'SHLVL': '1', 15:52:17 INFO - 'TERM': 'linux', 15:52:17 INFO - 'TMOUT': '86400', 15:52:17 INFO - 'USER': 'cltbld', 15:52:17 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 15:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:17 INFO - '_': '/tools/buildbot/bin/python'} 15:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:17 INFO - Running setup.py (path:/tmp/pip-INh5CN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:17 INFO - Running setup.py (path:/tmp/pip-eXQpiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:17 INFO - Running setup.py (path:/tmp/pip-OyruEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:17 INFO - Running setup.py (path:/tmp/pip-uWukQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:18 INFO - Running setup.py (path:/tmp/pip-ouyHfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:18 INFO - Running setup.py (path:/tmp/pip-YAqAAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:18 INFO - Running setup.py (path:/tmp/pip-cn2Aot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:18 INFO - Running setup.py (path:/tmp/pip-glQjNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:18 INFO - Running setup.py (path:/tmp/pip-I3ooh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:18 INFO - Running setup.py (path:/tmp/pip-ttwXFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:18 INFO - Running setup.py (path:/tmp/pip-gLp9C5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:18 INFO - Running setup.py (path:/tmp/pip-Iv6eLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:18 INFO - Running setup.py (path:/tmp/pip-F5HNPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:18 INFO - Running setup.py (path:/tmp/pip-tEpaMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:18 INFO - Running setup.py (path:/tmp/pip-XA34Ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:52:18 INFO - Running setup.py (path:/tmp/pip-IUGqCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:52:18 INFO - Running setup.py (path:/tmp/pip-H9mD5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:52:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:52:18 INFO - Running setup.py install for manifestparser 15:52:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:52:19 INFO - Running setup.py install for mozcrash 15:52:19 INFO - Running setup.py install for mozdebug 15:52:19 INFO - Running setup.py install for mozdevice 15:52:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:52:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:52:19 INFO - Running setup.py install for mozfile 15:52:19 INFO - Running setup.py install for mozhttpd 15:52:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:52:19 INFO - Running setup.py install for mozinfo 15:52:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:52:19 INFO - Running setup.py install for mozInstall 15:52:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:52:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:52:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:52:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:52:19 INFO - Running setup.py install for mozleak 15:52:19 INFO - Running setup.py install for mozlog 15:52:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:52:20 INFO - Running setup.py install for moznetwork 15:52:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:52:20 INFO - Running setup.py install for mozprocess 15:52:20 INFO - Running setup.py install for mozprofile 15:52:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:52:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:52:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:52:20 INFO - Running setup.py install for mozrunner 15:52:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:52:20 INFO - Running setup.py install for mozscreenshot 15:52:20 INFO - Running setup.py install for moztest 15:52:20 INFO - Running setup.py install for mozversion 15:52:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:52:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:52:20 INFO - Cleaning up... 15:52:20 INFO - Return code: 0 15:52:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:20 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 0x7f1d5034bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d177b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da6790>, '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 0x1da7690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da7b20>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:52:20 INFO - Using env: {'DISPLAY': ':0', 15:52:20 INFO - 'HOME': '/home/cltbld', 15:52:20 INFO - 'LANG': 'en_US.UTF-8', 15:52:20 INFO - 'LANGUAGE': 'en_US:en', 15:52:20 INFO - 'LOGNAME': 'cltbld', 15:52:20 INFO - 'MAIL': '/var/mail/cltbld', 15:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:20 INFO - 'MOZ_NO_REMOTE': '1', 15:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:20 INFO - 'NO_EM_RESTART': '1', 15:52:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:20 INFO - 'PWD': '/builds/slave/test', 15:52:20 INFO - 'SHELL': '/bin/bash', 15:52:20 INFO - 'SHLVL': '1', 15:52:20 INFO - 'TERM': 'linux', 15:52:20 INFO - 'TMOUT': '86400', 15:52:20 INFO - 'USER': 'cltbld', 15:52:20 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 15:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:20 INFO - '_': '/tools/buildbot/bin/python'} 15:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:21 INFO - Running setup.py (path:/tmp/pip-TltEmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:21 INFO - Running setup.py (path:/tmp/pip-WcV352-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:21 INFO - Running setup.py (path:/tmp/pip-GfvzN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:21 INFO - Running setup.py (path:/tmp/pip-QiJCzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:21 INFO - Running setup.py (path:/tmp/pip-WVrVOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:21 INFO - Running setup.py (path:/tmp/pip-M6iqvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:21 INFO - Running setup.py (path:/tmp/pip-7_g46D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:21 INFO - Running setup.py (path:/tmp/pip-6C4oK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:21 INFO - Running setup.py (path:/tmp/pip-xE3tIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:21 INFO - Running setup.py (path:/tmp/pip-JKodGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:21 INFO - Running setup.py (path:/tmp/pip-0gUO4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:21 INFO - Running setup.py (path:/tmp/pip-3APAAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:21 INFO - Running setup.py (path:/tmp/pip-cECl5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:21 INFO - Running setup.py (path:/tmp/pip-nyfyFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:22 INFO - Running setup.py (path:/tmp/pip-pRotJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:52:22 INFO - Running setup.py (path:/tmp/pip-_tog4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:52:22 INFO - Running setup.py (path:/tmp/pip-5RbFdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:52:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:24 INFO - Downloading blessings-1.6.tar.gz 15:52:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:52:24 INFO - Installing collected packages: blessings 15:52:24 INFO - Running setup.py install for blessings 15:52:24 INFO - Successfully installed blessings 15:52:24 INFO - Cleaning up... 15:52:24 INFO - Return code: 0 15:52:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:52:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:52:24 INFO - Reading from file tmpfile_stdout 15:52:24 INFO - Current package versions: 15:52:24 INFO - argparse == 1.2.1 15:52:24 INFO - blessings == 1.6 15:52:24 INFO - blobuploader == 1.2.4 15:52:24 INFO - docopt == 0.6.1 15:52:24 INFO - functools32 == 3.2.3-2 15:52:24 INFO - jsonschema == 2.5.1 15:52:24 INFO - manifestparser == 1.1 15:52:24 INFO - mozInstall == 1.12 15:52:24 INFO - mozcrash == 0.17 15:52:24 INFO - mozdebug == 0.1 15:52:24 INFO - mozdevice == 0.48 15:52:24 INFO - mozfile == 1.2 15:52:24 INFO - mozhttpd == 0.7 15:52:24 INFO - mozinfo == 0.9 15:52:24 INFO - mozleak == 0.1 15:52:24 INFO - mozlog == 3.4 15:52:24 INFO - moznetwork == 0.27 15:52:24 INFO - mozprocess == 0.23 15:52:24 INFO - mozprofile == 0.28 15:52:24 INFO - mozrunner == 6.12 15:52:24 INFO - mozscreenshot == 0.1 15:52:24 INFO - mozsystemmonitor == 0.3 15:52:24 INFO - moztest == 0.7 15:52:24 INFO - mozversion == 1.4 15:52:24 INFO - psutil == 3.1.1 15:52:24 INFO - requests == 1.2.3 15:52:24 INFO - wsgiref == 0.1.2 15:52:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:24 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 0x7f1d5034bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d177b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da6790>, '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 0x1da7690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da7b20>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:52:24 INFO - Using env: {'DISPLAY': ':0', 15:52:24 INFO - 'HOME': '/home/cltbld', 15:52:24 INFO - 'LANG': 'en_US.UTF-8', 15:52:24 INFO - 'LANGUAGE': 'en_US:en', 15:52:24 INFO - 'LOGNAME': 'cltbld', 15:52:24 INFO - 'MAIL': '/var/mail/cltbld', 15:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:24 INFO - 'MOZ_NO_REMOTE': '1', 15:52:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:24 INFO - 'NO_EM_RESTART': '1', 15:52:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:24 INFO - 'PWD': '/builds/slave/test', 15:52:24 INFO - 'SHELL': '/bin/bash', 15:52:24 INFO - 'SHLVL': '1', 15:52:24 INFO - 'TERM': 'linux', 15:52:24 INFO - 'TMOUT': '86400', 15:52:24 INFO - 'USER': 'cltbld', 15:52:24 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 15:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:24 INFO - '_': '/tools/buildbot/bin/python'} 15:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:52:24 INFO - Cleaning up... 15:52:24 INFO - Return code: 0 15:52:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d5034bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d177b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da6790>, '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 0x1da7690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da7b20>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:52:24 INFO - Using env: {'DISPLAY': ':0', 15:52:24 INFO - 'HOME': '/home/cltbld', 15:52:24 INFO - 'LANG': 'en_US.UTF-8', 15:52:24 INFO - 'LANGUAGE': 'en_US:en', 15:52:24 INFO - 'LOGNAME': 'cltbld', 15:52:24 INFO - 'MAIL': '/var/mail/cltbld', 15:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:24 INFO - 'MOZ_NO_REMOTE': '1', 15:52:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:24 INFO - 'NO_EM_RESTART': '1', 15:52:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:24 INFO - 'PWD': '/builds/slave/test', 15:52:24 INFO - 'SHELL': '/bin/bash', 15:52:24 INFO - 'SHLVL': '1', 15:52:24 INFO - 'TERM': 'linux', 15:52:24 INFO - 'TMOUT': '86400', 15:52:24 INFO - 'USER': 'cltbld', 15:52:24 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 15:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:24 INFO - '_': '/tools/buildbot/bin/python'} 15:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:52:25 INFO - Cleaning up... 15:52:25 INFO - Return code: 0 15:52:25 INFO - Running post-action listener: _resource_record_post_action 15:52:25 INFO - Running post-action listener: _start_resource_monitoring 15:52:25 INFO - Starting resource monitoring. 15:52:25 INFO - [mozharness: 2016-10-06 22:52:25.142033Z] Finished create-virtualenv step (success) 15:52:25 INFO - [mozharness: 2016-10-06 22:52:25.142530Z] Running install step. 15:52:25 INFO - Running pre-action listener: _resource_record_pre_action 15:52:25 INFO - Running main action method: install 15:52:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:52:25 INFO - Reading from file tmpfile_stdout 15:52:25 INFO - Detecting whether we're running mozinstall >=1.0... 15:52:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:52:25 INFO - Reading from file tmpfile_stdout 15:52:25 INFO - Output received: 15:52:25 INFO - Usage: mozinstall [options] installer 15:52:25 INFO - Options: 15:52:25 INFO - -h, --help show this help message and exit 15:52:25 INFO - -d DEST, --destination=DEST 15:52:25 INFO - Directory to install application into. [default: 15:52:25 INFO - "/builds/slave/test"] 15:52:25 INFO - --app=APP Application being installed. [default: firefox] 15:52:25 INFO - mkdir: /builds/slave/test/build/application 15:52:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:52:42 INFO - Reading from file tmpfile_stdout 15:52:42 INFO - Output received: 15:52:42 INFO - /builds/slave/test/build/application/firefox/firefox 15:52:42 INFO - Running post-action listener: _resource_record_post_action 15:52:42 INFO - [mozharness: 2016-10-06 22:52:42.658312Z] Finished install step (success) 15:52:42 INFO - [mozharness: 2016-10-06 22:52:42.658585Z] Running run-tests step. 15:52:42 INFO - Running pre-action listener: _resource_record_pre_action 15:52:42 INFO - Running main action method: run_tests 15:52:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:52:42 INFO - Python 2.7.3 15:52:42 INFO - Return code: 0 15:52:42 INFO - grabbing minidump binary from tooltool 15:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:42 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 0x1da6790>, '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 0x1da7690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:52:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:52:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:52:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:52:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:52:42 INFO - Return code: 0 15:52:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:52:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:52:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:52:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:52:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:52:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:52:42 INFO - Using env: {'DISPLAY': ':0', 15:52:42 INFO - 'HOME': '/home/cltbld', 15:52:42 INFO - 'LANG': 'en_US.UTF-8', 15:52:42 INFO - 'LANGUAGE': 'en_US:en', 15:52:42 INFO - 'LOGNAME': 'cltbld', 15:52:42 INFO - 'MAIL': '/var/mail/cltbld', 15:52:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:52:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:42 INFO - 'MOZ_NO_REMOTE': '1', 15:52:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:52:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:42 INFO - 'NO_EM_RESTART': '1', 15:52:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:42 INFO - 'PWD': '/builds/slave/test', 15:52:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:52:42 INFO - 'SHELL': '/bin/bash', 15:52:42 INFO - 'SHLVL': '1', 15:52:42 INFO - 'TERM': 'linux', 15:52:42 INFO - 'TMOUT': '86400', 15:52:42 INFO - 'USER': 'cltbld', 15:52:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713', 15:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:42 INFO - '_': '/tools/buildbot/bin/python'} 15:52:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:52:42 INFO - mozversion application_buildid: 20161006123013 15:52:42 INFO - mozversion application_changeset: ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df 15:52:42 INFO - mozversion application_display_name: Nightly 15:52:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:52:42 INFO - mozversion application_name: Firefox 15:52:42 INFO - mozversion application_remotingname: firefox 15:52:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:52:42 INFO - mozversion application_vendor: Mozilla 15:52:42 INFO - mozversion application_version: 52.0a1 15:52:42 INFO - mozversion platform_buildid: 20161006123013 15:52:42 INFO - mozversion platform_changeset: ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df 15:52:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:52:42 INFO - mozversion platform_version: 52.0a1 15:52:42 INFO - using testdate: 1475794362 15:52:42 INFO - actual date: 1475794362 15:52:42 INFO - starting webserver on 'localhost:43470' 15:52:42 INFO - SUITE-START | Running 2 tests 15:52:42 INFO - TEST-START | dromaeo_css 15:52:42 INFO - operating with platform_type : linux_ 15:52:42 INFO - Initialising browser for dromaeo_css test... 15:52:42 INFO - TEST-INFO | started process 26746 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLpWHmp/profile http://localhost:43470/getInfo.html) 15:52:47 INFO - PROCESS | 26746 | __metrics Screen width/height:1600/1200 15:52:47 INFO - PROCESS | 26746 | colorDepth:24 15:52:47 INFO - PROCESS | 26746 | Browser inner width/height: 1024/697 15:52:47 INFO - PROCESS | 26746 | __metrics 15:52:48 ERROR - PROCESS | 26746 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 15:52:49 INFO - TEST-INFO | 26746: exit 0 15:52:49 INFO - Browser initialized. 15:52:49 INFO - Running cycle 1/1 for dromaeo_css test... 15:52:49 INFO - TEST-INFO | started process 26869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLpWHmp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:53:01 INFO - PROCESS | 26869 | RSS: Main: 185720832 15:53:01 INFO - PROCESS | 26869 | 15:53:51 INFO - PROCESS | 26869 | 1475794431075 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:56:02 INFO - PROCESS | 26869 | Cycle 1(1): loaded http://localhost:43470/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43470/tests/dromaeo/cssquery-ext.html) 15:56:03 INFO - PROCESS | 26869 | RSS: Main: 201072640 15:56:03 INFO - PROCESS | 26869 | 15:59:05 INFO - PROCESS | 26869 | Cycle 1(1): loaded http://localhost:43470/tests/dromaeo/cssquery-ext.html (next: http://localhost:43470/tests/dromaeo/cssquery-jquery.html) 15:59:06 INFO - PROCESS | 26869 | RSS: Main: 198651904 15:59:06 INFO - PROCESS | 26869 | 16:02:07 INFO - PROCESS | 26869 | Cycle 1(1): loaded http://localhost:43470/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43470/tests/dromaeo/cssquery-mootools.html) 16:02:08 INFO - PROCESS | 26869 | RSS: Main: 199532544 16:02:08 INFO - PROCESS | 26869 | 16:05:10 INFO - PROCESS | 26869 | Cycle 1(1): loaded http://localhost:43470/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43470/tests/dromaeo/cssquery-prototype.html) 16:05:11 INFO - PROCESS | 26869 | RSS: Main: 196046848 16:05:11 INFO - PROCESS | 26869 | 16:08:13 INFO - PROCESS | 26869 | Cycle 1(1): loaded http://localhost:43470/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43470/tests/dromaeo/cssquery-yui.html) 16:08:14 INFO - PROCESS | 26869 | RSS: Main: 199417856 16:08:14 INFO - PROCESS | 26869 | 16:11:16 INFO - PROCESS | 26869 | Cycle 1(1): loaded http://localhost:43470/tests/dromaeo/cssquery-yui.html (next: http://localhost:43470/tests/dromaeo/cssquery-dojo.html) 16:11:17 INFO - PROCESS | 26869 | RSS: Main: 200314880 16:11:17 INFO - PROCESS | 26869 | 16:11:17 INFO - PROCESS | 26869 | __start_tp_report 16:11:17 INFO - PROCESS | 26869 | _x_x_mozilla_page_load 16:11:17 INFO - PROCESS | 26869 | _x_x_mozilla_page_load_details 16:11:17 INFO - PROCESS | 26869 | |i|pagename|runs| 16:11:17 INFO - PROCESS | 26869 | |0;dojo.html;3033.5449682547614;3040.4071206114804;3047.238190452387;3062.265056386468;3077.415291094692;5200.427952925184;5293.126634105372;5302.1781623848265;5352.598555108363;5381.246625472427;5252.763625636846;5264.710440925747;5280.498352656501;5311.415744268127;5380.3274590676165;4669.066186762644;4765.880852978668;4855.101806165853;4859.73271470069;5013.749312534359;4974.030064137494;4984.451710311862;4991.7504124793795;5008.198688209887;5050.166722490784;4722.1736196165875;4749.430068391815;4837.274408838667;4898.779554920037;4924.950750492503;4865.6107511399005;4899.8040078396825;4925.802967881281;4967.850964471072;4975.60195184388;4814.253790662453;4872.968973437857;4887.218045112765;4891.315215869781;4962.106820772259;5147.871303217449;5215.16557350822;5357.892842143175;5372.91940620891;5400.810971615974;5542.307211598551;5548.6393384430285;5551.195076713854;5627.409122042168;5630.380658127603;5641.182028605829;5659.801906933279;5726.31284245889;5740.339860915965;5748.109043098327;5301.390340110859;5301.946980530222;5320.920186197211;5328.360596728378;5391.973040134774;5851.795187168429;5879.441453062038;5894;5905.7932972346625;5962.642241465526;5595.804146854841;5663.32040155184;5669.489745922887;5670.177824215466;5680.176374425685;5569.888602227933;5665.12190610456;5714.142878568165;5734.77060917567;5757.193992841006;5723.341815691166;5725.312962444534;5729.3984131665575;5739.368669446358;5758.2514273144225;5699.088145896637;5719.2279042328755;5723.399043100415;5730.971345143331;5749.683767392834;4274.444322238089;4324.805383757675;4326.891827704332;4407.449068866392;4457.710248833815;3834.5973672764517;3859.729818912649;3885.902852428712;3903.277893589695;3909.6872250219913;5308.92036619451;5328.200769884548;5338.065838478328;5362.946370536245;5367.2485851980755;5611.719414029282;5698.6580805151825;5699.971500142473;5701.629394089371;5775.047117225695;5288.576913846883;5396.64921780083;5429.457054294618;5443.265159203536;5509.862253443696;4960.826371077067;4976.975115124401;4988.5260900214425;5001.624878134155;5047.520485553867;5983.551233657493;5986.760529578768;5989.341172471025;5990.131430942489;5992.700364981821;5677.858053548694;5681.0910254359105;5734.942650573441;5739.2252045973255;5743.798967036134;5933.792317268875;5939.406059394026;5951.940480595312;5964.522838173022;5974.372690867396;5396.7571459283645;5421.566274697936;5650.406707295675;5655.660660360391;5659.858503537444;5568.805091821767;5661.264035675335;5668.914966275592;5684.772609095755;5766.538676905921;5537.750801213874;5541.418151094077;5543.72281385921;5561.249231353877;5563.610547261653;5425.321834770653;5511.559075274049;5528.530074943514;5528.806491772769;5596.132599447093;5398.946010540001;5537.584681149011;5569.832905012856;5582.218489411567;5615.747291371979;5617.578681598815;5617.943820561905;5626.88746225065;5635.774569017193;5648.519875810438;5505.284313039279;5523.8895222094525;5537.723113844372;5538.833834984957;5539.639923404966 16:11:17 INFO - PROCESS | 26869 | |1;ext.html;542.5599385222185;575.4303239792605;585.4262822434017;593.2228780297808;604.9213602231711;41965.79017104914;43408;43531.78234108825;43657;47277.29084063733;46062.76968615152;46196;46216.3067553987;46594.57351551597;46708.76645616767;8828.42615230008;8973.955130224373;8986.326025548078;8993.865092023625;8994.325425593073;8937.329700272474;8941.552922353889;8947.239484643813;8956.104389561024;9023.954880225623;8925.910740892605;8975.192232699055;8980.146886045815;8986.550672466383;9046.050164732707;8898.06570310121;8926.86609700855;8950;8959.731208063737;8962.103789621051;8762.824743505158;8887.73336799897;8889.111088891124;8917.242034427081;8918.687845925426;42852.57147428517;42862.57137428617;42995.785021075004;43171;43264;3418.242558014679;3626.691731202851;3672.57765356982;3855.633714797118;4004.4794176757127;31171.688283117106;31341.84329078363;31637.52543711823;31652.683473165205;31858.362832743445;4265.829366825355;4287.399764033038;4294.634956028742;4408.40486534317;4442.155990361821;242505;242736;242944;243578;244054;58511;58540;58967.115493267636;59113.11330330049;59164.704176478845;61987.690061550304;62067.689661551405;62155;62193;62211.688941555;17409.390671326695;17544.122793860257;17546.29814807419;17570.38503652366;17682.115894205497;12434.81347779766;12434.81347779784;12506.312152831682;12522.624321270376;12537.185082969578;15815.36738530469;17463.476095716895;17612.383566575107;17697.469075927744;17751.11244437773;6058.27300723916;6154.1999540059505;6175.536834737412;6329.240491141092;6344.619322840645;971.8930917599058;1021.8927012663712;1080.6974047266779;1089.4280502736126;1121.5009320852143;31710.841445792623;32340.191495212806;32410.837945810592;32635.347293054005;33322.166945826066;1067.3169171730099;1092.6503518873883;1106.3251416635846;1122.4331712485307;1130.4743294367993;16036.839631603769;16921.877498800644;16924.153792310335;17119.48641540756;17394.47816565505;464525;464619;464901;470167;471664;58423;58472.70763646154;58594;58718.70640646855;58818.7059064702;1320.795276732089;1324.973500529984;1330.7471580399692;1374.5257886029303;1375.9036867419184;31449.842750786098;32992.505112422856;33926.830365848014;34210.65789342075;34300.48549271713;50031.49968500269;50537.49462505475;50963.235551466016;51038;51104.74447627738;359214;360680;361181;361797;362649;27773.58339624867;28368;28462.57306140451;28489.28776780597;28575.571366429936;47275.76362118167;47335.28997064978;47439.762801185774;48348.5165148344;49027.50972490372;39513.802430987664;39803.66577196671;40685.38971915483;41294;43460.78269608632;40490;40902.1819563613;41436.40618996144;41997.79001104975;42174.156516868876;35920.28159436744;36580.26839463249;38205;40679.7966010168;41855.7907210462;33707;36600.33996600319;36860;36922.26155476929;37054.629453705114;28382.137809625514;28383.14850554487;28560.14319570416;28763.85618071896;28922 16:11:17 INFO - PROCESS | 26869 | |2;jquery.html;388.068635275339;390.5801263641588;395.72101668323836;399.6902400639505;420.3841372389449;18194.81805181948;19651;19669.606607867852;19840.107195176217;20217.49456263594;19319.4204173875;19334.32329868455;19643.410697679057;19656.312029078985;19851;5675.829725108253;5710.086386178213;5850.531957443394;5889.734961926723;5897.911531327033;5781.190633311318;5816.534677225833;5840.678762668052;5846.386129456409;5868.589198756089;5570.554355651539;5756.280464941882;5758.769649214027;5764.827055188351;5778.27771528559;5566.944330556683;5772.942270577303;5783.9710801445935;5818.825435236908;5821.796237131702;5076.263941728465;5083.593312534988;5102.948970510284;5137.8715532112;5139.15203991341;22680.432989175402;23290.3012909613;23336.299911002698;23365.182218622267;23461.41346466335;2154.0306861912204;2242.473018840571;2294.4378627236433;2313.2944451942153;2998.865051072707;13758.380872860746;13981.510647127403;14034.859651403458;14704;15188.924055379763;1866.6266746650724;1962.1856929374292;1971.7141014552953;1972.8816271023784;2001.4195883193856;75704.62147689282;76978;78284;78392.60803696002;78967.60516197383;10070.69787906364;10150.644727434505;10480.633177838892;10568;10905.400202988752;14258;14421.134731915909;14427.42290308376;14540.49108281205;14636.926815365856;7906.960465197637;8182;8283.751487455385;8446.366522510836;8509.064002959669;7943.64253608589;8013.799655008672;8032.4778889372;8240.793980150424;8322.958385208036;6338.239411270585;6435.195600549931;6455.4835613150835;6566.244881838554;6596.328486962788;1937.2251099560008;1953.5116220944765;1957.2268953763185;1965.6756635155325;1996.9700454493195;952.3238500664468;1009.1825621246813;1025.8307379282335;1069.3215339233013;1101.5593762494907;18090.63818723618;19749.60500789976;19837.30569430063;19930.800691992896;20265.189392424432;970.1705042188968;1001.2890847498358;1001.9448930308757;1011.5448048378112;1016.7153197104823;10781.514831832586;10960.451977401099;11252.15608829341;11294.491747871365;11386.772264554662;432527;432738;433512;436053;436532;70882.64558677276;71629;73684;73701.63149184328;73987;1021.5862575656871;1040.1626690514208;1043.3009883378154;1054.836500342448;1055.150603763962;16488.734280973153;17003.91498042502;17118.572035699206;17309.134543273038;17391.47825565235;35470.46794298036;35559;36065.81967090253;36403;37696.2460750778;47978;48413.757931210115;48460;48530.757346213046;48581;8073.636686349246;8216.21945915137;8249.587520623825;8270.503769773833;8295.668173273001;12290.631281061582;12597.244165350108;12716.682082948;12737.87262127367;12873.163244389085;11054.502547385548;11157.330560166416;11431.428428578703;11669.649910502698;11868.643940681794;10831.729206769895;10985.231033827555;11197.272177308449;11236.381998990135;11679.591214307799;11214.327140371604;11296.6046188383;11481.36852473122;11545.82681259765;11598.130140239684;7294.525855819355;7562.924370756442;7672;7869.173736757558;7884.487508311941;10035.949820250851;10760.139188865029;10921.617743378943;11088.722781930517;11564.653060408202 16:11:17 INFO - PROCESS | 26869 | |3;mootools.html;1488.7022595480908;1520.9847901520984;1649.6370798424343;1740.5474576610093;1754.9298028078877;7745.651445684944;7998.480098793574;8624.396292259544;9331.486768227753;9339.579718912657;8603.268722158624;8950.910490895089;8965.82068358634;9151.954240228806;9178.173964343208;2334.4980829121737;2352.2707960532202;2356.7289761677457;2363.326451961191;2369.5853225685437;2325.4070212095894;2326.7789559991775;2366.656834758959;2369.07606033647;2369.8104151667912;2304.6082166031815;2344.8006919411787;2348.53029394121;2357.363511851799;2372.193454225563;2301.3211102724736;2314.6065168921323;2318.3740390094663;2325.3140323604575;2331.219041621059;2209.845310828243;2236.8993395297252;2241.753407125215;2242.0583354990945;2247.651613999816;9040.186383225542;9130.680426185118;9188.586513606904;9239;9344.579493922789;5203.453637368059;5338.813141540067;5344.4922732340365;5356.223347614613;5362.383325917492;3330.916727081818;3393.8642454302044;3531.0819187011307;3543.6633519815578;3584.372734771405;1161.1523587780966;1176.5411489519095;1200.2858299311895;1204.0728638948049;1216.574199030341;12760.425780839885;12797.104202705814;12815.935920320431;12841.229526228457;12846.807297890538;4403.3174857897075;4557.088582283556;4676.742779147179;4706.129366067288;4707.93983910461;10705.304155229886;10713.625023124154;10736.73158171052;10747.83878241827;10758.56965721378;5366.329208848894;5403.729813509387;5408.161734931092;5424.83725488236;5440.211169380497;4286.078493123993;4427.734335939854;4685.250359942393;4863.756812159378;4921.729304888266;3861.3242682530445;3974.2647610192207;4058.370952502367;4073.1853629274265;4095.5494895561465;1299.8050292456207;1324.6953200763878;1328.4022190014532;1340.7385559815743;1356.0575400097034;907.2288554728428;925.4724806860025;941.7833898203452;946.8485042393185;952.642758965388;5693.772249110072;5889.469947704727;5936.456521304405;6061.605995610271;6211.65835879031;467.0658682634731;470.49891865164176;470.6399604302711;473.76075082083327;482.73690838492405;4139.606737359946;4172.603602657743;4195.286801243796;4224.155168966219;4235.767032813224;10387;10587.100096491731;10740;10787.406692631981;10829.67510974672;10570.947145264225;10627.043566078935;10646.041856232976;10664.41345725977;10753.677389678322;7784.766457006299;8093.635786389509;8133.552654604054;8145.226203510657;8233.79415514617;5940.970295148497;6155.969220153871;6246.344133865879;6315;6388.39310265524;10059.69820905374;10309.48452577383;10360.378377297386;10409.479526023517;10412.739681508023;10577.682669519927;10636.09593184557;10642.71181695939;10646.817402432638;10654.414007229676;7180.640967951686;7407;7571.659275332733;7917.247861453153;8120.796980075309;8540.188682075193;8805.515696636747;8835.911640883509;8864.468131912106;8865.290776737975;7581.962090189514;7729.729459468892;7773.37812974972;8054.597270136587;8144.714934977247;7780.221977802401;7796.727114550963;7853.1361550228285;7942.682292708458;7984.720534781255;6996.405305548882;7120.0387947626405;7124.893126603001;7127.287271273039;7140.107486564179;4763.380760501252;4778.546038126373;4805.8558243252755;4879.585235255043;4923.384576927884;5088.084144853962;5278.155495120763;5281.656692314988;5285.68285902847;5415.35015798091 16:11:17 INFO - PROCESS | 26869 | |4;prototype.html;333.29009210381884;339.72821742605925;344.0161139142054;346.8439202358936;347.9895603131905;5342.492463215998;5352.464753524646;5354.196870469432;5364.5708343332535;5405.945940540593;5257.342832145981;5265.710385928773;5279.63042587019;5281.260623512701;5283.973580132094;3984.740991835529;4085.22380747657;4089.734167279117;4140.503139623234;4218.093109981353;4167.770242920038;4178.728382655133;4189.706720529564;4197.00642194958;4214.70497065204;4172.895677608069;4225.514065882432;4226.978865105685;4232.894177645553;4246.2993606055115;4092.836286548549;4185.686073544466;4190.979045104755;4196.139791342767;4265.637420819234;3706.2031663192274;3725.1245957200035;3738.345789486829;3745.8688945887034;3756.492873462102;5251.947480525222;5253.947460525423;5293.57651387888;5300.496452837013;5306.336707911511;4715.24556071027;4806.831760888352;4844.927326090112;4854;4884.7069175849565;5520.806771763009;5589.133684278943;5607.719614019324;5617.719114044281;5619.6066275360745;4124;4136.503619565641;4137.172565486914;4140.834366625331;4146.279294092978;5614.2490179812;5773.971130144364;5775.2780902386785;5884.852878678024;5902.881942361171;4180.665546756313;4182.477190351206;4199.223143718422;4205.894852628709;4208.936865947013;4249.3413520904305;4254.234237837219;4275.87172384829;4285.7642829644665;4315.352697095461;4556.726596404226;4810.831620893252;4811.061842940663;4812.903741925212;4843.321934929113;5673.631213971161;5691.8861622768145;5695.943040569541;5734.731203214212;5743.59794814359;1443.6968236670207;1451.201838988552;1455.486294253964;1456.5193486149544;1465.6116129225763;900.8135442019147;941.2658126661215;959.7984423271051;979.5934687104914;1001.1240164855751;5448.42791506894;5468.047254482614;5484.8354549363585;5506.504414602625;5521.613487055948;5752;5822.417758224228;5851.810763134102;5863.736131874076;5868.38381969887;5212.9739351303;5448.782048718086;5461.754221060062;5492.890142197213;5539.086050801653;3052.1911693401266;3089.567460555524;3092.6752690967573;3097.953530696996;3116.6442597470173;5793.623414478046;6062.484688801413;6079.6960151992225;6116.541259405562;6162.506999440034;5964.373740757244;5965.313988891333;5979.4618484336615;5983;5983.222181116514;6067.423594758491;6100.328963813977;6111.174991376108;6150.7539698411565;6205.627662340274;5561.776409189972;5844.327902291121;5863.885861686436;5880.94119058804;5890.083094741949;5825.271841019872;5830.008898487183;5832.562557808096;5851.951816864063;5854.4730974212525;5874.4139082448355;6088.665123418077;6095.818554229048;6126.752821004875;6153.553914829922;4138.234426631083;4156.106437116035;4189.449903535711;4215.093754842724;4217.68027584821;5874.530037596896;5901.380355062656;5920.348761636131;5957.438301530384;5975.37258587842;5605.607607467438;5721.256236689203;5727.255456790591;5729.71351432435;5747.224124743107;5677.120046392815;5682.119271512922;5698;5711.286614015862;5719;5313.512216579364;5604.495595396434;5715;5728.140778883201;5776.942230577641;5646.576506762091;5667.773289068391;5680.744366503434;5692.8576785579035;5708.4862362387585;5575.916361254665;5591.329040515164;5595.664260144405;5630.831075067755;5658.207850900795 16:11:17 INFO - PROCESS | 26869 | |5;yui.html;678.7352932356382;743.4609907816833;744.1293686386927;825.2820046559494;839.9118092600273;14964.476243331486;15052.698946021073;15059.247037648129;15291.311890964891;15467.613309667264;14685.632859178526;14899;14910.403583856632;14934.477293294736;14953.327100280487;787.1656044592736;801.7474495533917;802.1417083720421;804.388664614891;805.6173317674087;795.5306369242146;795.7493389582263;796.7330944133722;797.1629788721818;797.6051854332113;846.5428668518992;847.92792612628;848.9660413583449;849.5752123938031;849.9617517211709;837.0248660310731;839.9622017009249;839.9664013439456;840.9495430274203;842.7766641839918;626.8840264551072;628.0202883501752;630.6279295215799;630.8580569371901;630.8801327747714;12932.612021639367;13126.409311581001;13142.145760525535;13160.6709832254;13306.733865322736;12290.569830055994;12699.365031748375;12931.935340323333;13484.932575337061;13514.459421623123;10951.233413661046;10999.271769599869;11399.829002564886;11453.845769403719;11630;3790.536578578617;3806.3148633246005;3836.117692930614;3863.1694185749916;3908.2769687607883;70552.64723676349;71469.6426517864;75491;75538;77403.22596774016;9851.16265117473;10140;10323.63867264642;10325.586976521005;10337;20058.699119513218;20170.39488815338;20243.797562024487;20386.082626281852;20433.59132817365;7740.496867703581;7822.687092516349;7851.607419628996;7855.371570274365;8119.188081191834;4279.015826359955;4285.078708077778;4324.567543245713;4456.688031837805;4535.138323718483;3591.5690117186105;3709.0541911812857;3709.276691045274;3710.0910276982313;3719.9256014880093;682.8566001139717;724.2142275630999;726.5204964723257;732.4140687450018;740.5593671765291;749.568997826252;756.1380026769488;768.5696010234286;794.7893808140848;797.3541431440551;9576.281778866613;10202.591896324064;10374.688759337232;10449.738756531147;10675.466226688635;708.3943228539524;727.7598392530452;735.1912895814561;737.922518135588;766.9156392796788;4741.786619602126;4852.636052296092;4889.608831293488;4905.803767849317;4932.926006109911;88898;91370.54314728384;92736.53631731933;105671;121778.3911080439;82950.58524707459;85002.57498712467;86591;89162;92514.53742731243;78947;79851.60074199592;80404;81323.5933820339;82024.58987705143;9653.276004299565;10037.799244015225;10117.431798071311;10159.187265018929;10166.949165254126;45140;45442.545574545155;46591.767041164574;46632;47072;57574.42425575691;57596;58583.70708146432;60624.39375606187;65573;12450.875491244971;13062.563118056816;13182.60452186436;13254.933725331312;13433.126846754929;14187.503437379642;14979.400823967355;15241.31414086391;15253.161076140475;15514.37942482288;13403.731925361242;14188.219647919463;14211.64470888236;14239;14530.564083077525;12814.295213763333;13439.932800335935;13571.86428135706;13735;14060;12643.557475488315;13557.389917453935;13777.104488208635;13782;14219.715605688036;10473.581056757948;10582.571397438103;10972.561097556008;10974.890251097388;11028.393438360967;9861.901380986385;10149.188064954933;10353.378797272188;11702.824457632973;12158.209716368408 16:11:17 INFO - PROCESS | 26869 | __end_tp_report 16:11:17 INFO - PROCESS | 26869 | __start_cc_report 16:11:17 INFO - PROCESS | 26869 | _x_x_mozilla_cycle_collect,308 16:11:17 INFO - PROCESS | 26869 | __end_cc_report 16:11:17 INFO - PROCESS | 26869 | __startTimestamp1475795477187__endTimestamp 16:11:17 INFO - PROCESS | 26869 | 16:11:17 INFO - PROCESS | 26869 | ------- Summary: start ------- 16:11:17 INFO - PROCESS | 26869 | Number of tests: 6 16:11:17 INFO - PROCESS | 26869 | 16:11:17 INFO - PROCESS | 26869 | [#0] dojo.html Cycles:165 Average:5305.37 Median:5528.53 stddev:605.19 (10.9%) stddev-sans-first:580.22 16:11:17 INFO - PROCESS | 26869 | Values: 3033.5 3040.4 3047.2 3062.3 3077.4 5200.4 5293.1 5302.2 5352.6 5381.2 5252.8 5264.7 5280.5 5311.4 5380.3 4669.1 4765.9 4855.1 4859.7 5013.7 4974.0 4984.5 4991.8 5008.2 5050.2 4722.2 4749.4 4837.3 4898.8 4925.0 4865.6 4899.8 4925.8 4967.9 4975.6 4814.3 4873.0 4887.2 4891.3 4962.1 5147.9 5215.2 5357.9 5372.9 5400.8 5542.3 5548.6 5551.2 5627.4 5630.4 5641.2 5659.8 5726.3 5740.3 5748.1 5301.4 5301.9 5320.9 5328.4 5392.0 5851.8 5879.4 5894.0 5905.8 5962.6 5595.8 5663.3 5669.5 5670.2 5680.2 5569.9 5665.1 5714.1 5734.8 5757.2 5723.3 5725.3 5729.4 5739.4 5758.3 5699.1 5719.2 5723.4 5731.0 5749.7 4274.4 4324.8 4326.9 4407.4 4457.7 3834.6 3859.7 3885.9 3903.3 3909.7 5308.9 5328.2 5338.1 5362.9 5367.2 5611.7 5698.7 5700.0 5701.6 5775.0 5288.6 5396.6 5429.5 5443.3 5509.9 4960.8 4977.0 4988.5 5001.6 5047.5 5983.6 5986.8 5989.3 5990.1 5992.7 5677.9 5681.1 5734.9 5739.2 5743.8 5933.8 5939.4 5951.9 5964.5 5974.4 5396.8 5421.6 5650.4 5655.7 5659.9 5568.8 5661.3 5668.9 5684.8 5766.5 5537.8 5541.4 5543.7 5561.2 5563.6 5425.3 5511.6 5528.5 5528.8 5596.1 5398.9 5537.6 5569.8 5582.2 5615.7 5617.6 5617.9 5626.9 5635.8 5648.5 5505.3 5523.9 5537.7 5538.8 5539.6 16:11:17 INFO - PROCESS | 26869 | 16:11:17 INFO - PROCESS | 26869 | [#1] ext.html Cycles:180 Average:53383.72 Median:41910.79 stddev:97349.47 (232.3%) stddev-sans-first:97541.71 16:11:17 INFO - PROCESS | 26869 | Values: 542.6 575.4 585.4 593.2 604.9 41965.8 43408.0 43531.8 43657.0 47277.3 46062.8 46196.0 46216.3 46594.6 46708.8 8828.4 8974.0 8986.3 8993.9 8994.3 8937.3 8941.6 8947.2 8956.1 9024.0 8925.9 8975.2 8980.1 8986.6 9046.1 8898.1 8926.9 8950.0 8959.7 8962.1 8762.8 8887.7 8889.1 8917.2 8918.7 42852.6 42862.6 42995.8 43171.0 43264.0 3418.2 3626.7 3672.6 3855.6 4004.5 31171.7 31341.8 31637.5 31652.7 31858.4 4265.8 4287.4 4294.6 4408.4 4442.2 242505.0 242736.0 242944.0 243578.0 244054.0 58511.0 58540.0 58967.1 59113.1 59164.7 61987.7 62067.7 62155.0 62193.0 62211.7 17409.4 17544.1 17546.3 17570.4 17682.1 12434.8 12434.8 12506.3 12522.6 12537.2 15815.4 17463.5 17612.4 17697.5 17751.1 6058.3 6154.2 6175.5 6329.2 6344.6 971.9 1021.9 1080.7 1089.4 1121.5 31710.8 32340.2 32410.8 32635.3 33322.2 1067.3 1092.7 1106.3 1122.4 1130.5 16036.8 16921.9 16924.2 17119.5 17394.5 464525.0 464619.0 464901.0 470167.0 471664.0 58423.0 58472.7 58594.0 58718.7 58818.7 1320.8 1325.0 1330.7 1374.5 1375.9 31449.8 32992.5 33926.8 34210.7 34300.5 50031.5 50537.5 50963.2 51038.0 51104.7 359214.0 360680.0 361181.0 361797.0 362649.0 27773.6 28368.0 28462.6 28489.3 28575.6 47275.8 47335.3 47439.8 48348.5 49027.5 39513.8 39803.7 40685.4 41294.0 43460.8 40490.0 40902.2 41436.4 41997.8 42174.2 35920.3 36580.3 38205.0 40679.8 41855.8 33707.0 36600.3 36860.0 36922.3 37054.6 28382.1 28383.1 28560.1 28763.9 28922.0 16:11:17 INFO - PROCESS | 26869 | 16:11:17 INFO - PROCESS | 26869 | [#2] jquery.html Cycles:180 Average:26471.08 Median:12487.44 stddev:71325.63 (571.2%) stddev-sans-first:71498.83 16:11:17 INFO - PROCESS | 26869 | Values: 388.1 390.6 395.7 399.7 420.4 18194.8 19651.0 19669.6 19840.1 20217.5 19319.4 19334.3 19643.4 19656.3 19851.0 5675.8 5710.1 5850.5 5889.7 5897.9 5781.2 5816.5 5840.7 5846.4 5868.6 5570.6 5756.3 5758.8 5764.8 5778.3 5566.9 5772.9 5784.0 5818.8 5821.8 5076.3 5083.6 5102.9 5137.9 5139.2 22680.4 23290.3 23336.3 23365.2 23461.4 2154.0 2242.5 2294.4 2313.3 2998.9 13758.4 13981.5 14034.9 14704.0 15188.9 1866.6 1962.2 1971.7 1972.9 2001.4 75704.6 76978.0 78284.0 78392.6 78967.6 10070.7 10150.6 10480.6 10568.0 10905.4 14258.0 14421.1 14427.4 14540.5 14636.9 7907.0 8182.0 8283.8 8446.4 8509.1 7943.6 8013.8 8032.5 8240.8 8323.0 6338.2 6435.2 6455.5 6566.2 6596.3 1937.2 1953.5 1957.2 1965.7 1997.0 952.3 1009.2 1025.8 1069.3 1101.6 18090.6 19749.6 19837.3 19930.8 20265.2 970.2 1001.3 1001.9 1011.5 1016.7 10781.5 10960.5 11252.2 11294.5 11386.8 432527.0 432738.0 433512.0 436053.0 436532.0 70882.6 71629.0 73684.0 73701.6 73987.0 1021.6 1040.2 1043.3 1054.8 1055.2 16488.7 17003.9 17118.6 17309.1 17391.5 35470.5 35559.0 36065.8 36403.0 37696.2 47978.0 48413.8 48460.0 48530.8 48581.0 8073.6 8216.2 8249.6 8270.5 8295.7 12290.6 12597.2 12716.7 12737.9 12873.2 11054.5 11157.3 11431.4 11669.6 11868.6 10831.7 10985.2 11197.3 11236.4 11679.6 11214.3 11296.6 11481.4 11545.8 11598.1 7294.5 7562.9 7672.0 7869.2 7884.5 10035.9 10760.1 10921.6 11088.7 11564.7 16:11:17 INFO - PROCESS | 26869 | 16:11:17 INFO - PROCESS | 26869 | [#3] mootools.html Cycles:180 Average:5861.00 Median:4681.00 stddev:3380.89 (72.2%) stddev-sans-first:3374.41 16:11:17 INFO - PROCESS | 26869 | Values: 1488.7 1521.0 1649.6 1740.5 1754.9 7745.7 7998.5 8624.4 9331.5 9339.6 8603.3 8950.9 8965.8 9152.0 9178.2 2334.5 2352.3 2356.7 2363.3 2369.6 2325.4 2326.8 2366.7 2369.1 2369.8 2304.6 2344.8 2348.5 2357.4 2372.2 2301.3 2314.6 2318.4 2325.3 2331.2 2209.8 2236.9 2241.8 2242.1 2247.7 9040.2 9130.7 9188.6 9239.0 9344.6 5203.5 5338.8 5344.5 5356.2 5362.4 3330.9 3393.9 3531.1 3543.7 3584.4 1161.2 1176.5 1200.3 1204.1 1216.6 12760.4 12797.1 12815.9 12841.2 12846.8 4403.3 4557.1 4676.7 4706.1 4707.9 10705.3 10713.6 10736.7 10747.8 10758.6 5366.3 5403.7 5408.2 5424.8 5440.2 4286.1 4427.7 4685.3 4863.8 4921.7 3861.3 3974.3 4058.4 4073.2 4095.5 1299.8 1324.7 1328.4 1340.7 1356.1 907.2 925.5 941.8 946.8 952.6 5693.8 5889.5 5936.5 6061.6 6211.7 467.1 470.5 470.6 473.8 482.7 4139.6 4172.6 4195.3 4224.2 4235.8 10387.0 10587.1 10740.0 10787.4 10829.7 10570.9 10627.0 10646.0 10664.4 10753.7 7784.8 8093.6 8133.6 8145.2 8233.8 5941.0 6156.0 6246.3 6315.0 6388.4 10059.7 10309.5 10360.4 10409.5 10412.7 10577.7 10636.1 10642.7 10646.8 10654.4 7180.6 7407.0 7571.7 7917.2 8120.8 8540.2 8805.5 8835.9 8864.5 8865.3 7582.0 7729.7 7773.4 8054.6 8144.7 7780.2 7796.7 7853.1 7942.7 7984.7 6996.4 7120.0 7124.9 7127.3 7140.1 4763.4 4778.5 4805.9 4879.6 4923.4 5088.1 5278.2 5281.7 5285.7 5415.4 16:11:17 INFO - PROCESS | 26869 | 16:11:17 INFO - PROCESS | 26869 | [#4] prototype.html Cycles:180 Average:4792.26 Median:5464.90 stddev:1414.17 (25.9%) stddev-sans-first:1377.97 16:11:17 INFO - PROCESS | 26869 | Values: 333.3 339.7 344.0 346.8 348.0 5342.5 5352.5 5354.2 5364.6 5405.9 5257.3 5265.7 5279.6 5281.3 5284.0 3984.7 4085.2 4089.7 4140.5 4218.1 4167.8 4178.7 4189.7 4197.0 4214.7 4172.9 4225.5 4227.0 4232.9 4246.3 4092.8 4185.7 4191.0 4196.1 4265.6 3706.2 3725.1 3738.3 3745.9 3756.5 5251.9 5253.9 5293.6 5300.5 5306.3 4715.2 4806.8 4844.9 4854.0 4884.7 5520.8 5589.1 5607.7 5617.7 5619.6 4124.0 4136.5 4137.2 4140.8 4146.3 5614.2 5774.0 5775.3 5884.9 5902.9 4180.7 4182.5 4199.2 4205.9 4208.9 4249.3 4254.2 4275.9 4285.8 4315.4 4556.7 4810.8 4811.1 4812.9 4843.3 5673.6 5691.9 5695.9 5734.7 5743.6 1443.7 1451.2 1455.5 1456.5 1465.6 900.8 941.3 959.8 979.6 1001.1 5448.4 5468.0 5484.8 5506.5 5521.6 5752.0 5822.4 5851.8 5863.7 5868.4 5213.0 5448.8 5461.8 5492.9 5539.1 3052.2 3089.6 3092.7 3098.0 3116.6 5793.6 6062.5 6079.7 6116.5 6162.5 5964.4 5965.3 5979.5 5983.0 5983.2 6067.4 6100.3 6111.2 6150.8 6205.6 5561.8 5844.3 5863.9 5880.9 5890.1 5825.3 5830.0 5832.6 5852.0 5854.5 5874.4 6088.7 6095.8 6126.8 6153.6 4138.2 4156.1 4189.4 4215.1 4217.7 5874.5 5901.4 5920.3 5957.4 5975.4 5605.6 5721.3 5727.3 5729.7 5747.2 5677.1 5682.1 5698.0 5711.3 5719.0 5313.5 5604.5 5715.0 5728.1 5776.9 5646.6 5667.8 5680.7 5692.9 5708.5 5575.9 5591.3 5595.7 5630.8 5658.2 16:11:17 INFO - PROCESS | 26869 | 16:11:17 INFO - PROCESS | 26869 | [#5] yui.html Cycles:180 Average:19134.55 Median:4390.63 stddev:26589.56 (605.6%) stddev-sans-first:26628.04 16:11:17 INFO - PROCESS | 26869 | Values: 678.7 743.5 744.1 825.3 839.9 14964.5 15052.7 15059.2 15291.3 15467.6 14685.6 14899.0 14910.4 14934.5 14953.3 787.2 801.7 802.1 804.4 805.6 795.5 795.7 796.7 797.2 797.6 846.5 847.9 849.0 849.6 850.0 837.0 840.0 840.0 840.9 842.8 626.9 628.0 630.6 630.9 630.9 12932.6 13126.4 13142.1 13160.7 13306.7 12290.6 12699.4 12931.9 13484.9 13514.5 10951.2 10999.3 11399.8 11453.8 11630.0 3790.5 3806.3 3836.1 3863.2 3908.3 70552.6 71469.6 75491.0 75538.0 77403.2 9851.2 10140.0 10323.6 10325.6 10337.0 20058.7 20170.4 20243.8 20386.1 20433.6 7740.5 7822.7 7851.6 7855.4 8119.2 4279.0 4285.1 4324.6 4456.7 4535.1 3591.6 3709.1 3709.3 3710.1 3719.9 682.9 724.2 726.5 732.4 740.6 749.6 756.1 768.6 794.8 797.4 9576.3 10202.6 10374.7 10449.7 10675.5 708.4 727.8 735.2 737.9 766.9 4741.8 4852.6 4889.6 4905.8 4932.9 88898.0 91370.5 92736.5 105671.0 121778.4 82950.6 85002.6 86591.0 89162.0 92514.5 78947.0 79851.6 80404.0 81323.6 82024.6 9653.3 10037.8 10117.4 10159.2 10166.9 45140.0 45442.5 46591.8 46632.0 47072.0 57574.4 57596.0 58583.7 60624.4 65573.0 12450.9 13062.6 13182.6 13254.9 13433.1 14187.5 14979.4 15241.3 15253.2 15514.4 13403.7 14188.2 14211.6 14239.0 14530.6 12814.3 13439.9 13571.9 13735.0 14060.0 12643.6 13557.4 13777.1 13782.0 14219.7 10473.6 10582.6 10972.6 10974.9 11028.4 9861.9 10149.2 10353.4 11702.8 12158.2 16:11:17 INFO - PROCESS | 26869 | -------- Summary: end -------- 16:11:17 INFO - PROCESS | 26869 | 16:11:18 INFO - TEST-INFO | 26869: exit 0 16:11:18 INFO - TEST-OK | dromaeo_css | took 1115260ms 16:11:18 INFO - TEST-START | kraken 16:11:18 INFO - operating with platform_type : linux_ 16:11:18 INFO - Initialising browser for kraken test... 16:11:18 INFO - TEST-INFO | started process 27237 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprPiSDT/profile http://localhost:43470/getInfo.html) 16:11:23 INFO - PROCESS | 27237 | __metrics Screen width/height:1600/1200 16:11:23 INFO - PROCESS | 27237 | colorDepth:24 16:11:23 INFO - PROCESS | 27237 | Browser inner width/height: 1024/697 16:11:23 INFO - PROCESS | 27237 | __metrics 16:11:23 ERROR - PROCESS | 27237 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 16:11:24 INFO - TEST-INFO | 27237: exit 0 16:11:24 INFO - Browser initialized. 16:11:24 INFO - Running cycle 1/1 for kraken test... 16:11:24 INFO - TEST-INFO | started process 27359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprPiSDT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:11:36 INFO - PROCESS | 27359 | RSS: Main: 185131008 16:11:36 INFO - PROCESS | 27359 | 16:11:39 INFO - PROCESS | 27359 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43470/tests/kraken/driver.html?testName=audio-beat-detection) 16:11:40 INFO - PROCESS | 27359 | RSS: Main: 199176192 16:11:40 INFO - PROCESS | 27359 | 16:11:42 INFO - PROCESS | 27359 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43470/tests/kraken/driver.html?testName=audio-dft) 16:11:43 INFO - PROCESS | 27359 | RSS: Main: 196792320 16:11:43 INFO - PROCESS | 27359 | 16:11:46 INFO - PROCESS | 27359 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43470/tests/kraken/driver.html?testName=audio-fft) 16:11:47 INFO - PROCESS | 27359 | RSS: Main: 192651264 16:11:47 INFO - PROCESS | 27359 | 16:11:49 INFO - PROCESS | 27359 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43470/tests/kraken/driver.html?testName=audio-oscillator) 16:11:49 INFO - PROCESS | 27359 | RSS: Main: 193232896 16:11:49 INFO - PROCESS | 27359 | 16:11:51 INFO - PROCESS | 27359 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43470/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:11:52 INFO - PROCESS | 27359 | RSS: Main: 193531904 16:11:52 INFO - PROCESS | 27359 | 16:11:55 INFO - PROCESS | 27359 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43470/tests/kraken/driver.html?testName=imaging-darkroom) 16:11:56 INFO - PROCESS | 27359 | RSS: Main: 193699840 16:11:56 INFO - PROCESS | 27359 | 16:11:59 INFO - PROCESS | 27359 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43470/tests/kraken/driver.html?testName=imaging-desaturate) 16:12:00 INFO - PROCESS | 27359 | RSS: Main: 191791104 16:12:00 INFO - PROCESS | 27359 | 16:12:03 INFO - PROCESS | 27359 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43470/tests/kraken/driver.html?testName=json-parse-financial) 16:12:03 INFO - PROCESS | 27359 | RSS: Main: 192970752 16:12:03 INFO - PROCESS | 27359 | 16:12:05 INFO - PROCESS | 27359 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43470/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:12:06 INFO - PROCESS | 27359 | RSS: Main: 193826816 16:12:06 INFO - PROCESS | 27359 | 16:12:07 INFO - PROCESS | 27359 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43470/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:12:08 INFO - PROCESS | 27359 | RSS: Main: 193372160 16:12:08 INFO - PROCESS | 27359 | 16:12:10 INFO - PROCESS | 27359 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43470/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:12:11 INFO - PROCESS | 27359 | RSS: Main: 193335296 16:12:11 INFO - PROCESS | 27359 | 16:12:13 INFO - PROCESS | 27359 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43470/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:12:14 INFO - PROCESS | 27359 | RSS: Main: 193703936 16:12:14 INFO - PROCESS | 27359 | 16:12:17 INFO - PROCESS | 27359 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43470/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:12:18 INFO - PROCESS | 27359 | RSS: Main: 193904640 16:12:18 INFO - PROCESS | 27359 | 16:12:19 INFO - PROCESS | 27359 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43470/tests/kraken/driver.html?testName=ai-astar) 16:12:20 INFO - PROCESS | 27359 | RSS: Main: 195407872 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | __start_tp_report 16:12:20 INFO - PROCESS | 27359 | _x_x_mozilla_page_load 16:12:20 INFO - PROCESS | 27359 | _x_x_mozilla_page_load_details 16:12:20 INFO - PROCESS | 27359 | |i|pagename|runs| 16:12:20 INFO - PROCESS | 27359 | |0;ai-astar;106;113;112;112;112;112;112;114;111;114 16:12:20 INFO - PROCESS | 27359 | |1;audio-beat-detection;158;125;127;171;132;126;128;127;151;126 16:12:20 INFO - PROCESS | 27359 | |2;audio-dft;162;164;164;175;163;162;161;161;163;162 16:12:20 INFO - PROCESS | 27359 | |3;audio-fft;76;76;75;102;78;75;78;76;104;76 16:12:20 INFO - PROCESS | 27359 | |4;audio-oscillator;83;82;108;85;83;84;98;82;83;117 16:12:20 INFO - PROCESS | 27359 | |5;imaging-gaussian-blur;118;117;117;118;117;117;118;117;118;119 16:12:20 INFO - PROCESS | 27359 | |6;imaging-darkroom;150;149;149;148;147;148;147;146;147;146 16:12:20 INFO - PROCESS | 27359 | |7;imaging-desaturate;98;97;96;97;97;96;96;97;97;96 16:12:20 INFO - PROCESS | 27359 | |8;json-parse-financial;54;54;53;54;54;55;55;54;54;56 16:12:20 INFO - PROCESS | 27359 | |9;json-stringify-tinderbox;60;61;60;61;61;61;61;62;61;61 16:12:20 INFO - PROCESS | 27359 | |10;stanford-crypto-aes;81;81;81;81;87;81;81;83;86;81 16:12:20 INFO - PROCESS | 27359 | |11;stanford-crypto-ccm;136;137;135;145;142;131;144;131;173;142 16:12:20 INFO - PROCESS | 27359 | |12;stanford-crypto-pbkdf2;176;170;175;171;166;180;168;169;169;171 16:12:20 INFO - PROCESS | 27359 | |13;stanford-crypto-sha256-iterative;67;68;67;67;67;66;66;67;68;67 16:12:20 INFO - PROCESS | 27359 | __end_tp_report 16:12:20 INFO - PROCESS | 27359 | __start_cc_report 16:12:20 INFO - PROCESS | 27359 | _x_x_mozilla_cycle_collect,773 16:12:20 INFO - PROCESS | 27359 | __end_cc_report 16:12:20 INFO - PROCESS | 27359 | __startTimestamp1475795540082__endTimestamp 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | ------- Summary: start ------- 16:12:20 INFO - PROCESS | 27359 | Number of tests: 14 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:2.25 (2.0%) stddev-sans-first:1.01 16:12:20 INFO - PROCESS | 27359 | Values: 106.0 113.0 112.0 112.0 112.0 112.0 112.0 114.0 111.0 114.0 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:130.00 stddev:16.62 (12.8%) stddev-sans-first:15.81 16:12:20 INFO - PROCESS | 27359 | Values: 158.0 125.0 127.0 171.0 132.0 126.0 128.0 127.0 151.0 126.0 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:4.11 (2.5%) stddev-sans-first:4.31 16:12:20 INFO - PROCESS | 27359 | Values: 162.0 164.0 164.0 175.0 163.0 162.0 161.0 161.0 163.0 162.0 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:11.34 (14.9%) stddev-sans-first:11.84 16:12:20 INFO - PROCESS | 27359 | Values: 76.0 76.0 75.0 102.0 78.0 75.0 78.0 76.0 104.0 76.0 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:83.00 stddev:12.70 (15.3%) stddev-sans-first:13.17 16:12:20 INFO - PROCESS | 27359 | Values: 83.0 82.0 108.0 85.0 83.0 84.0 98.0 82.0 83.0 117.0 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 16:12:20 INFO - PROCESS | 27359 | Values: 118.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 118.0 119.0 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:1.34 (0.9%) stddev-sans-first:1.13 16:12:20 INFO - PROCESS | 27359 | Values: 150.0 149.0 149.0 148.0 147.0 148.0 147.0 146.0 147.0 146.0 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.53 16:12:20 INFO - PROCESS | 27359 | Values: 98.0 97.0 96.0 97.0 97.0 96.0 96.0 97.0 97.0 96.0 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 16:12:20 INFO - PROCESS | 27359 | Values: 54.0 54.0 53.0 54.0 54.0 55.0 55.0 54.0 54.0 56.0 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 16:12:20 INFO - PROCESS | 27359 | Values: 60.0 61.0 60.0 61.0 61.0 61.0 61.0 62.0 61.0 61.0 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:81.00 stddev:2.31 (2.9%) stddev-sans-first:2.40 16:12:20 INFO - PROCESS | 27359 | Values: 81.0 81.0 81.0 81.0 87.0 81.0 81.0 83.0 86.0 81.0 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | [#11] stanford-crypto-ccm Cycles:10 Average:141.60 Median:142.00 stddev:12.13 (8.5%) stddev-sans-first:12.70 16:12:20 INFO - PROCESS | 27359 | Values: 136.0 137.0 135.0 145.0 142.0 131.0 144.0 131.0 173.0 142.0 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:171.00 stddev:4.25 (2.5%) stddev-sans-first:4.18 16:12:20 INFO - PROCESS | 27359 | Values: 176.0 170.0 175.0 171.0 166.0 180.0 168.0 169.0 169.0 171.0 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 16:12:20 INFO - PROCESS | 27359 | Values: 67.0 68.0 67.0 67.0 67.0 66.0 66.0 67.0 68.0 67.0 16:12:20 INFO - PROCESS | 27359 | -------- Summary: end -------- 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | 16:12:20 INFO - PROCESS | 27359 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 16:12:20 INFO - PROCESS | 27359 | 16:12:21 INFO - TEST-INFO | 27359: exit 0 16:12:21 INFO - TEST-OK | kraken | took 62974ms 16:12:21 INFO - SUITE-END | took 1178s 16:12:21 INFO - Completed test suite (00:19:38) 16:12:21 INFO - javascript benchmark 16:12:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7203.9187198190675, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3033.5449682547614, 3040.4071206114804, 3047.238190452387, 3062.265056386468, 3077.415291094692, 5200.427952925184, 5293.126634105372, 5302.1781623848265, 5352.598555108363, 5381.246625472427, 5252.763625636846, 5264.710440925747, 5280.498352656501, 5311.415744268127, 5380.3274590676165, 4669.066186762644, 4765.880852978668, 4855.101806165853, 4859.73271470069, 5013.749312534359, 4974.030064137494, 4984.451710311862, 4991.7504124793795, 5008.198688209887, 5050.166722490784, 4722.1736196165875, 4749.430068391815, 4837.274408838667, 4898.779554920037, 4924.950750492503, 4865.6107511399005, 4899.8040078396825, 4925.802967881281, 4967.850964471072, 4975.60195184388, 4814.253790662453, 4872.968973437857, 4887.218045112765, 4891.315215869781, 4962.106820772259, 5147.871303217449, 5215.16557350822, 5357.892842143175, 5372.91940620891, 5400.810971615974, 5542.307211598551, 5548.6393384430285, 5551.195076713854, 5627.409122042168, 5630.380658127603, 5641.182028605829, 5659.801906933279, 5726.31284245889, 5740.339860915965, 5748.109043098327, 5301.390340110859, 5301.946980530222, 5320.920186197211, 5328.360596728378, 5391.973040134774, 5851.795187168429, 5879.441453062038, 5894.0, 5905.7932972346625, 5962.642241465526, 5595.804146854841, 5663.32040155184, 5669.489745922887, 5670.177824215466, 5680.176374425685, 5569.888602227933, 5665.12190610456, 5714.142878568165, 5734.77060917567, 5757.193992841006, 5723.341815691166, 5725.312962444534, 5729.3984131665575, 5739.368669446358, 5758.2514273144225, 5699.088145896637, 5719.2279042328755, 5723.399043100415, 5730.971345143331, 5749.683767392834, 4274.444322238089, 4324.805383757675, 4326.891827704332, 4407.449068866392, 4457.710248833815, 3834.5973672764517, 3859.729818912649, 3885.902852428712, 3903.277893589695, 3909.6872250219913, 5308.92036619451, 5328.200769884548, 5338.065838478328, 5362.946370536245, 5367.2485851980755, 5611.719414029282, 5698.6580805151825, 5699.971500142473, 5701.629394089371, 5775.047117225695, 5288.576913846883, 5396.64921780083, 5429.457054294618, 5443.265159203536, 5509.862253443696, 4960.826371077067, 4976.975115124401, 4988.5260900214425, 5001.624878134155, 5047.520485553867, 5983.551233657493, 5986.760529578768, 5989.341172471025, 5990.131430942489, 5992.700364981821, 5677.858053548694, 5681.0910254359105, 5734.942650573441, 5739.2252045973255, 5743.798967036134, 5933.792317268875, 5939.406059394026, 5951.940480595312, 5964.522838173022, 5974.372690867396, 5396.7571459283645, 5421.566274697936, 5650.406707295675, 5655.660660360391, 5659.858503537444, 5568.805091821767, 5661.264035675335, 5668.914966275592, 5684.772609095755, 5766.538676905921, 5537.750801213874, 5541.418151094077, 5543.72281385921, 5561.249231353877, 5563.610547261653, 5425.321834770653, 5511.559075274049, 5528.530074943514, 5528.806491772769, 5596.132599447093, 5398.946010540001, 5537.584681149011, 5569.832905012856, 5582.218489411567, 5615.747291371979, 5617.578681598815, 5617.943820561905, 5626.88746225065, 5635.774569017193, 5648.519875810438, 5505.284313039279, 5523.8895222094525, 5537.723113844372, 5538.833834984957, 5539.639923404966], "value": 5264.058150606794, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.5599385222185, 575.4303239792605, 585.4262822434017, 593.2228780297808, 604.9213602231711, 41965.79017104914, 43408.0, 43531.78234108825, 43657.0, 47277.29084063733, 46062.76968615152, 46196.0, 46216.3067553987, 46594.57351551597, 46708.76645616767, 8828.42615230008, 8973.955130224373, 8986.326025548078, 8993.865092023625, 8994.325425593073, 8937.329700272474, 8941.552922353889, 8947.239484643813, 8956.104389561024, 9023.954880225623, 8925.910740892605, 8975.192232699055, 8980.146886045815, 8986.550672466383, 9046.050164732707, 8898.06570310121, 8926.86609700855, 8950.0, 8959.731208063737, 8962.103789621051, 8762.824743505158, 8887.73336799897, 8889.111088891124, 8917.242034427081, 8918.687845925426, 42852.57147428517, 42862.57137428617, 42995.785021075004, 43171.0, 43264.0, 3418.242558014679, 3626.691731202851, 3672.57765356982, 3855.633714797118, 4004.4794176757127, 31171.688283117106, 31341.84329078363, 31637.52543711823, 31652.683473165205, 31858.362832743445, 4265.829366825355, 4287.399764033038, 4294.634956028742, 4408.40486534317, 4442.155990361821, 242505.0, 242736.0, 242944.0, 243578.0, 244054.0, 58511.0, 58540.0, 58967.115493267636, 59113.11330330049, 59164.704176478845, 61987.690061550304, 62067.689661551405, 62155.0, 62193.0, 62211.688941555, 17409.390671326695, 17544.122793860257, 17546.29814807419, 17570.38503652366, 17682.115894205497, 12434.81347779766, 12434.81347779784, 12506.312152831682, 12522.624321270376, 12537.185082969578, 15815.36738530469, 17463.476095716895, 17612.383566575107, 17697.469075927744, 17751.11244437773, 6058.27300723916, 6154.1999540059505, 6175.536834737412, 6329.240491141092, 6344.619322840645, 971.8930917599058, 1021.8927012663712, 1080.6974047266779, 1089.4280502736126, 1121.5009320852143, 31710.841445792623, 32340.191495212806, 32410.837945810592, 32635.347293054005, 33322.166945826066, 1067.3169171730099, 1092.6503518873883, 1106.3251416635846, 1122.4331712485307, 1130.4743294367993, 16036.839631603769, 16921.877498800644, 16924.153792310335, 17119.48641540756, 17394.47816565505, 464525.0, 464619.0, 464901.0, 470167.0, 471664.0, 58423.0, 58472.70763646154, 58594.0, 58718.70640646855, 58818.7059064702, 1320.795276732089, 1324.973500529984, 1330.7471580399692, 1374.5257886029303, 1375.9036867419184, 31449.842750786098, 32992.505112422856, 33926.830365848014, 34210.65789342075, 34300.48549271713, 50031.49968500269, 50537.49462505475, 50963.235551466016, 51038.0, 51104.74447627738, 359214.0, 360680.0, 361181.0, 361797.0, 362649.0, 27773.58339624867, 28368.0, 28462.57306140451, 28489.28776780597, 28575.571366429936, 47275.76362118167, 47335.28997064978, 47439.762801185774, 48348.5165148344, 49027.50972490372, 39513.802430987664, 39803.66577196671, 40685.38971915483, 41294.0, 43460.78269608632, 40490.0, 40902.1819563613, 41436.40618996144, 41997.79001104975, 42174.156516868876, 35920.28159436744, 36580.26839463249, 38205.0, 40679.7966010168, 41855.7907210462, 33707.0, 36600.33996600319, 36860.0, 36922.26155476929, 37054.629453705114, 28382.137809625514, 28383.14850554487, 28560.14319570416, 28763.85618071896, 28922.0], "value": 19718.438331363235, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.068635275339, 390.5801263641588, 395.72101668323836, 399.6902400639505, 420.3841372389449, 18194.81805181948, 19651.0, 19669.606607867852, 19840.107195176217, 20217.49456263594, 19319.4204173875, 19334.32329868455, 19643.410697679057, 19656.312029078985, 19851.0, 5675.829725108253, 5710.086386178213, 5850.531957443394, 5889.734961926723, 5897.911531327033, 5781.190633311318, 5816.534677225833, 5840.678762668052, 5846.386129456409, 5868.589198756089, 5570.554355651539, 5756.280464941882, 5758.769649214027, 5764.827055188351, 5778.27771528559, 5566.944330556683, 5772.942270577303, 5783.9710801445935, 5818.825435236908, 5821.796237131702, 5076.263941728465, 5083.593312534988, 5102.948970510284, 5137.8715532112, 5139.15203991341, 22680.432989175402, 23290.3012909613, 23336.299911002698, 23365.182218622267, 23461.41346466335, 2154.0306861912204, 2242.473018840571, 2294.4378627236433, 2313.2944451942153, 2998.865051072707, 13758.380872860746, 13981.510647127403, 14034.859651403458, 14704.0, 15188.924055379763, 1866.6266746650724, 1962.1856929374292, 1971.7141014552953, 1972.8816271023784, 2001.4195883193856, 75704.62147689282, 76978.0, 78284.0, 78392.60803696002, 78967.60516197383, 10070.69787906364, 10150.644727434505, 10480.633177838892, 10568.0, 10905.400202988752, 14258.0, 14421.134731915909, 14427.42290308376, 14540.49108281205, 14636.926815365856, 7906.960465197637, 8182.0, 8283.751487455385, 8446.366522510836, 8509.064002959669, 7943.64253608589, 8013.799655008672, 8032.4778889372, 8240.793980150424, 8322.958385208036, 6338.239411270585, 6435.195600549931, 6455.4835613150835, 6566.244881838554, 6596.328486962788, 1937.2251099560008, 1953.5116220944765, 1957.2268953763185, 1965.6756635155325, 1996.9700454493195, 952.3238500664468, 1009.1825621246813, 1025.8307379282335, 1069.3215339233013, 1101.5593762494907, 18090.63818723618, 19749.60500789976, 19837.30569430063, 19930.800691992896, 20265.189392424432, 970.1705042188968, 1001.2890847498358, 1001.9448930308757, 1011.5448048378112, 1016.7153197104823, 10781.514831832586, 10960.451977401099, 11252.15608829341, 11294.491747871365, 11386.772264554662, 432527.0, 432738.0, 433512.0, 436053.0, 436532.0, 70882.64558677276, 71629.0, 73684.0, 73701.63149184328, 73987.0, 1021.5862575656871, 1040.1626690514208, 1043.3009883378154, 1054.836500342448, 1055.150603763962, 16488.734280973153, 17003.91498042502, 17118.572035699206, 17309.134543273038, 17391.47825565235, 35470.46794298036, 35559.0, 36065.81967090253, 36403.0, 37696.2460750778, 47978.0, 48413.757931210115, 48460.0, 48530.757346213046, 48581.0, 8073.636686349246, 8216.21945915137, 8249.587520623825, 8270.503769773833, 8295.668173273001, 12290.631281061582, 12597.244165350108, 12716.682082948, 12737.87262127367, 12873.163244389085, 11054.502547385548, 11157.330560166416, 11431.428428578703, 11669.649910502698, 11868.643940681794, 10831.729206769895, 10985.231033827555, 11197.272177308449, 11236.381998990135, 11679.591214307799, 11214.327140371604, 11296.6046188383, 11481.36852473122, 11545.82681259765, 11598.130140239684, 7294.525855819355, 7562.924370756442, 7672.0, 7869.173736757558, 7884.487508311941, 10035.949820250851, 10760.139188865029, 10921.617743378943, 11088.722781930517, 11564.653060408202], "value": 9132.853721831985, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1488.7022595480908, 1520.9847901520984, 1649.6370798424343, 1740.5474576610093, 1754.9298028078877, 7745.651445684944, 7998.480098793574, 8624.396292259544, 9331.486768227753, 9339.579718912657, 8603.268722158624, 8950.910490895089, 8965.82068358634, 9151.954240228806, 9178.173964343208, 2334.4980829121737, 2352.2707960532202, 2356.7289761677457, 2363.326451961191, 2369.5853225685437, 2325.4070212095894, 2326.7789559991775, 2366.656834758959, 2369.07606033647, 2369.8104151667912, 2304.6082166031815, 2344.8006919411787, 2348.53029394121, 2357.363511851799, 2372.193454225563, 2301.3211102724736, 2314.6065168921323, 2318.3740390094663, 2325.3140323604575, 2331.219041621059, 2209.845310828243, 2236.8993395297252, 2241.753407125215, 2242.0583354990945, 2247.651613999816, 9040.186383225542, 9130.680426185118, 9188.586513606904, 9239.0, 9344.579493922789, 5203.453637368059, 5338.813141540067, 5344.4922732340365, 5356.223347614613, 5362.383325917492, 3330.916727081818, 3393.8642454302044, 3531.0819187011307, 3543.6633519815578, 3584.372734771405, 1161.1523587780966, 1176.5411489519095, 1200.2858299311895, 1204.0728638948049, 1216.574199030341, 12760.425780839885, 12797.104202705814, 12815.935920320431, 12841.229526228457, 12846.807297890538, 4403.3174857897075, 4557.088582283556, 4676.742779147179, 4706.129366067288, 4707.93983910461, 10705.304155229886, 10713.625023124154, 10736.73158171052, 10747.83878241827, 10758.56965721378, 5366.329208848894, 5403.729813509387, 5408.161734931092, 5424.83725488236, 5440.211169380497, 4286.078493123993, 4427.734335939854, 4685.250359942393, 4863.756812159378, 4921.729304888266, 3861.3242682530445, 3974.2647610192207, 4058.370952502367, 4073.1853629274265, 4095.5494895561465, 1299.8050292456207, 1324.6953200763878, 1328.4022190014532, 1340.7385559815743, 1356.0575400097034, 907.2288554728428, 925.4724806860025, 941.7833898203452, 946.8485042393185, 952.642758965388, 5693.772249110072, 5889.469947704727, 5936.456521304405, 6061.605995610271, 6211.65835879031, 467.0658682634731, 470.49891865164176, 470.6399604302711, 473.76075082083327, 482.73690838492405, 4139.606737359946, 4172.603602657743, 4195.286801243796, 4224.155168966219, 4235.767032813224, 10387.0, 10587.100096491731, 10740.0, 10787.406692631981, 10829.67510974672, 10570.947145264225, 10627.043566078935, 10646.041856232976, 10664.41345725977, 10753.677389678322, 7784.766457006299, 8093.635786389509, 8133.552654604054, 8145.226203510657, 8233.79415514617, 5940.970295148497, 6155.969220153871, 6246.344133865879, 6315.0, 6388.39310265524, 10059.69820905374, 10309.48452577383, 10360.378377297386, 10409.479526023517, 10412.739681508023, 10577.682669519927, 10636.09593184557, 10642.71181695939, 10646.817402432638, 10654.414007229676, 7180.640967951686, 7407.0, 7571.659275332733, 7917.247861453153, 8120.796980075309, 8540.188682075193, 8805.515696636747, 8835.911640883509, 8864.468131912106, 8865.290776737975, 7581.962090189514, 7729.729459468892, 7773.37812974972, 8054.597270136587, 8144.714934977247, 7780.221977802401, 7796.727114550963, 7853.1361550228285, 7942.682292708458, 7984.720534781255, 6996.405305548882, 7120.0387947626405, 7124.893126603001, 7127.287271273039, 7140.107486564179, 4763.380760501252, 4778.546038126373, 4805.8558243252755, 4879.585235255043, 4923.384576927884, 5088.084144853962, 5278.155495120763, 5281.656692314988, 5285.68285902847, 5415.35015798091], "value": 4605.851840287995, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.29009210381884, 339.72821742605925, 344.0161139142054, 346.8439202358936, 347.9895603131905, 5342.492463215998, 5352.464753524646, 5354.196870469432, 5364.5708343332535, 5405.945940540593, 5257.342832145981, 5265.710385928773, 5279.63042587019, 5281.260623512701, 5283.973580132094, 3984.740991835529, 4085.22380747657, 4089.734167279117, 4140.503139623234, 4218.093109981353, 4167.770242920038, 4178.728382655133, 4189.706720529564, 4197.00642194958, 4214.70497065204, 4172.895677608069, 4225.514065882432, 4226.978865105685, 4232.894177645553, 4246.2993606055115, 4092.836286548549, 4185.686073544466, 4190.979045104755, 4196.139791342767, 4265.637420819234, 3706.2031663192274, 3725.1245957200035, 3738.345789486829, 3745.8688945887034, 3756.492873462102, 5251.947480525222, 5253.947460525423, 5293.57651387888, 5300.496452837013, 5306.336707911511, 4715.24556071027, 4806.831760888352, 4844.927326090112, 4854.0, 4884.7069175849565, 5520.806771763009, 5589.133684278943, 5607.719614019324, 5617.719114044281, 5619.6066275360745, 4124.0, 4136.503619565641, 4137.172565486914, 4140.834366625331, 4146.279294092978, 5614.2490179812, 5773.971130144364, 5775.2780902386785, 5884.852878678024, 5902.881942361171, 4180.665546756313, 4182.477190351206, 4199.223143718422, 4205.894852628709, 4208.936865947013, 4249.3413520904305, 4254.234237837219, 4275.87172384829, 4285.7642829644665, 4315.352697095461, 4556.726596404226, 4810.831620893252, 4811.061842940663, 4812.903741925212, 4843.321934929113, 5673.631213971161, 5691.8861622768145, 5695.943040569541, 5734.731203214212, 5743.59794814359, 1443.6968236670207, 1451.201838988552, 1455.486294253964, 1456.5193486149544, 1465.6116129225763, 900.8135442019147, 941.2658126661215, 959.7984423271051, 979.5934687104914, 1001.1240164855751, 5448.42791506894, 5468.047254482614, 5484.8354549363585, 5506.504414602625, 5521.613487055948, 5752.0, 5822.417758224228, 5851.810763134102, 5863.736131874076, 5868.38381969887, 5212.9739351303, 5448.782048718086, 5461.754221060062, 5492.890142197213, 5539.086050801653, 3052.1911693401266, 3089.567460555524, 3092.6752690967573, 3097.953530696996, 3116.6442597470173, 5793.623414478046, 6062.484688801413, 6079.6960151992225, 6116.541259405562, 6162.506999440034, 5964.373740757244, 5965.313988891333, 5979.4618484336615, 5983.0, 5983.222181116514, 6067.423594758491, 6100.328963813977, 6111.174991376108, 6150.7539698411565, 6205.627662340274, 5561.776409189972, 5844.327902291121, 5863.885861686436, 5880.94119058804, 5890.083094741949, 5825.271841019872, 5830.008898487183, 5832.562557808096, 5851.951816864063, 5854.4730974212525, 5874.4139082448355, 6088.665123418077, 6095.818554229048, 6126.752821004875, 6153.553914829922, 4138.234426631083, 4156.106437116035, 4189.449903535711, 4215.093754842724, 4217.68027584821, 5874.530037596896, 5901.380355062656, 5920.348761636131, 5957.438301530384, 5975.37258587842, 5605.607607467438, 5721.256236689203, 5727.255456790591, 5729.71351432435, 5747.224124743107, 5677.120046392815, 5682.119271512922, 5698.0, 5711.286614015862, 5719.0, 5313.512216579364, 5604.495595396434, 5715.0, 5728.140778883201, 5776.942230577641, 5646.576506762091, 5667.773289068391, 5680.744366503434, 5692.8576785579035, 5708.4862362387585, 5575.916361254665, 5591.329040515164, 5595.664260144405, 5630.831075067755, 5658.207850900795], "value": 4341.46474134034, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.7352932356382, 743.4609907816833, 744.1293686386927, 825.2820046559494, 839.9118092600273, 14964.476243331486, 15052.698946021073, 15059.247037648129, 15291.311890964891, 15467.613309667264, 14685.632859178526, 14899.0, 14910.403583856632, 14934.477293294736, 14953.327100280487, 787.1656044592736, 801.7474495533917, 802.1417083720421, 804.388664614891, 805.6173317674087, 795.5306369242146, 795.7493389582263, 796.7330944133722, 797.1629788721818, 797.6051854332113, 846.5428668518992, 847.92792612628, 848.9660413583449, 849.5752123938031, 849.9617517211709, 837.0248660310731, 839.9622017009249, 839.9664013439456, 840.9495430274203, 842.7766641839918, 626.8840264551072, 628.0202883501752, 630.6279295215799, 630.8580569371901, 630.8801327747714, 12932.612021639367, 13126.409311581001, 13142.145760525535, 13160.6709832254, 13306.733865322736, 12290.569830055994, 12699.365031748375, 12931.935340323333, 13484.932575337061, 13514.459421623123, 10951.233413661046, 10999.271769599869, 11399.829002564886, 11453.845769403719, 11630.0, 3790.536578578617, 3806.3148633246005, 3836.117692930614, 3863.1694185749916, 3908.2769687607883, 70552.64723676349, 71469.6426517864, 75491.0, 75538.0, 77403.22596774016, 9851.16265117473, 10140.0, 10323.63867264642, 10325.586976521005, 10337.0, 20058.699119513218, 20170.39488815338, 20243.797562024487, 20386.082626281852, 20433.59132817365, 7740.496867703581, 7822.687092516349, 7851.607419628996, 7855.371570274365, 8119.188081191834, 4279.015826359955, 4285.078708077778, 4324.567543245713, 4456.688031837805, 4535.138323718483, 3591.5690117186105, 3709.0541911812857, 3709.276691045274, 3710.0910276982313, 3719.9256014880093, 682.8566001139717, 724.2142275630999, 726.5204964723257, 732.4140687450018, 740.5593671765291, 749.568997826252, 756.1380026769488, 768.5696010234286, 794.7893808140848, 797.3541431440551, 9576.281778866613, 10202.591896324064, 10374.688759337232, 10449.738756531147, 10675.466226688635, 708.3943228539524, 727.7598392530452, 735.1912895814561, 737.922518135588, 766.9156392796788, 4741.786619602126, 4852.636052296092, 4889.608831293488, 4905.803767849317, 4932.926006109911, 88898.0, 91370.54314728384, 92736.53631731933, 105671.0, 121778.3911080439, 82950.58524707459, 85002.57498712467, 86591.0, 89162.0, 92514.53742731243, 78947.0, 79851.60074199592, 80404.0, 81323.5933820339, 82024.58987705143, 9653.276004299565, 10037.799244015225, 10117.431798071311, 10159.187265018929, 10166.949165254126, 45140.0, 45442.545574545155, 46591.767041164574, 46632.0, 47072.0, 57574.42425575691, 57596.0, 58583.70708146432, 60624.39375606187, 65573.0, 12450.875491244971, 13062.563118056816, 13182.60452186436, 13254.933725331312, 13433.126846754929, 14187.503437379642, 14979.400823967355, 15241.31414086391, 15253.161076140475, 15514.37942482288, 13403.731925361242, 14188.219647919463, 14211.64470888236, 14239.0, 14530.564083077525, 12814.295213763333, 13439.932800335935, 13571.86428135706, 13735.0, 14060.0, 12643.557475488315, 13557.389917453935, 13777.104488208635, 13782.0, 14219.715605688036, 10473.581056757948, 10582.571397438103, 10972.561097556008, 10974.890251097388, 11028.393438360967, 9861.901380986385, 10149.188064954933, 10353.378797272188, 11702.824457632973, 12158.209716368408], "value": 7372.644639460056, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 112.0, 112.0, 112.0, 112.0, 112.0, 114.0, 111.0, 114.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 125.0, 127.0, 171.0, 132.0, 126.0, 128.0, 127.0, 151.0, 126.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 175.0, 163.0, 162.0, 161.0, 161.0, 163.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 102.0, 78.0, 75.0, 78.0, 76.0, 104.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 108.0, 85.0, 83.0, 84.0, 98.0, 82.0, 83.0, 117.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 119.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 149.0, 148.0, 147.0, 148.0, 147.0, 146.0, 147.0, 146.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 97.0, 97.0, 96.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 54.0, 55.0, 55.0, 54.0, 54.0, 56.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 81.0, 81.0, 87.0, 81.0, 81.0, 83.0, 86.0, 81.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 137.0, 135.0, 145.0, 142.0, 131.0, 144.0, 131.0, 173.0, 142.0], "value": 141.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 170.0, 175.0, 171.0, 166.0, 180.0, 168.0, 169.0, 169.0, 171.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0, 68.0, 67.0], "value": 67.0, "unit": "score"}]}]} 16:12:21 INFO - Return code: 0 16:12:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:12:21 ERROR - # TBPL SUCCESS # 16:12:21 INFO - Running post-action listener: _resource_record_post_action 16:12:21 INFO - [mozharness: 2016-10-06 23:12:21.401383Z] Finished run-tests step (success) 16:12:21 INFO - Running post-run listener: _resource_record_post_run 16:12:21 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 399654912; Read time: 220; Write time: 361252 16:12:21 INFO - TinderboxPrint: CPU usage
13.4% 16:12:21 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 220 16:12:21 INFO - TinderboxPrint: I/O write bytes / time
399,654,912 / 361,252 16:12:21 INFO - TinderboxPrint: CPU idle
8,261.7 (86.6%) 16:12:21 INFO - TinderboxPrint: CPU user
1,213.3 (12.7%) 16:12:21 INFO - TinderboxPrint: Swap in / out
0 / 0 16:12:21 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 110350336; Read time: 0; Write time: 101884 16:12:21 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288735232; Read time: 208; Write time: 259332 16:12:22 INFO - Running post-run listener: _upload_blobber_files 16:12:22 INFO - Blob upload gear active. 16:12:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:12:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:12:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:12:22 INFO - (blobuploader) - INFO - Open directory for files ... 16:12:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:12:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:12:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:23 INFO - (blobuploader) - INFO - Done attempting. 16:12:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:12:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:12:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:26 INFO - (blobuploader) - INFO - Done attempting. 16:12:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:12:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:12:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:27 INFO - (blobuploader) - INFO - Done attempting. 16:12:27 INFO - (blobuploader) - INFO - Iteration through files over. 16:12:27 INFO - Return code: 0 16:12:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:12:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:12:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6fbd0dd98af4a3d10803aeae5ce293492f9307b7ef65f14f6648695e8ef1e01185c4e3841e4253f711862440c51832d8a1ed94e17bd8d8ebdf79351456c7b33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d18f327f6ca9c66041eade15fa955062c5d9a225ba411b872673eb381df7db8ce85a416f0393cef1238fea5abf14a587f2862b9b227cbfe118ba9e9f08e32f93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0cfebef81efc4c5df01a649a136cc2952d8cb659454e770f3865f86a80c9789add68c64fb979e7463a7efd66fce95a1ef9198b9e016e435244fb54716fdeeafe"} 16:12:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:12:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:12:27 INFO - Contents: 16:12:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6fbd0dd98af4a3d10803aeae5ce293492f9307b7ef65f14f6648695e8ef1e01185c4e3841e4253f711862440c51832d8a1ed94e17bd8d8ebdf79351456c7b33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d18f327f6ca9c66041eade15fa955062c5d9a225ba411b872673eb381df7db8ce85a416f0393cef1238fea5abf14a587f2862b9b227cbfe118ba9e9f08e32f93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0cfebef81efc4c5df01a649a136cc2952d8cb659454e770f3865f86a80c9789add68c64fb979e7463a7efd66fce95a1ef9198b9e016e435244fb54716fdeeafe"} 16:12:27 INFO - Running post-run listener: copy_logs_to_upload_dir 16:12:27 INFO - Copying logs to upload dir... 16:12:27 INFO - mkdir: /builds/slave/test/build/upload/logs 16:12:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.291283 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-06 16:12:27.045335) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 16:12:27.049308) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6fbd0dd98af4a3d10803aeae5ce293492f9307b7ef65f14f6648695e8ef1e01185c4e3841e4253f711862440c51832d8a1ed94e17bd8d8ebdf79351456c7b33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d18f327f6ca9c66041eade15fa955062c5d9a225ba411b872673eb381df7db8ce85a416f0393cef1238fea5abf14a587f2862b9b227cbfe118ba9e9f08e32f93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0cfebef81efc4c5df01a649a136cc2952d8cb659454e770f3865f86a80c9789add68c64fb979e7463a7efd66fce95a1ef9198b9e016e435244fb54716fdeeafe"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011400 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475782213/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6fbd0dd98af4a3d10803aeae5ce293492f9307b7ef65f14f6648695e8ef1e01185c4e3841e4253f711862440c51832d8a1ed94e17bd8d8ebdf79351456c7b33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d18f327f6ca9c66041eade15fa955062c5d9a225ba411b872673eb381df7db8ce85a416f0393cef1238fea5abf14a587f2862b9b227cbfe118ba9e9f08e32f93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0cfebef81efc4c5df01a649a136cc2952d8cb659454e770f3865f86a80c9789add68c64fb979e7463a7efd66fce95a1ef9198b9e016e435244fb54716fdeeafe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 16:12:27.077997) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 16:12:27.078371) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1475794308.343265-1385128713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 16:12:27.160075) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 16:12:27.160457) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 16:12:27.160833) ========= ========= Total master_lag: 0.19 =========