builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1477946220.12 results: success (0) buildid: 20161031073029 builduid: 397a287c61eb43f3992e3082f4114afb revision: e017b947cea08b7bdd21007e95bd13e14ad59103 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 13:37:00.123728) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 13:37:00.124188) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 13:37:00.124474) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 13:37:00.138938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 13:37:00.139234) ========= 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=17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-31 13:37:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-10-31 13:37:00 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.409450 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 13:37:00.562830) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 13:37:00.563178) ========= 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=17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017987 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 13:37:00.613218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 13:37:00.613572) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e017b947cea08b7bdd21007e95bd13e14ad59103 --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 e017b947cea08b7bdd21007e95bd13e14ad59103 --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=17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-31 13:37:00,798 truncating revision to first 12 chars 2016-10-31 13:37:00,798 Setting DEBUG logging. 2016-10-31 13:37:00,798 attempt 1/10 2016-10-31 13:37:00,798 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e017b947cea0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 13:37:01,178 unpacking tar archive at: fx-team-e017b947cea0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.681062 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 13:37:01.309346) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 13:37:01.309667) ========= script_repo_revision: e017b947cea08b7bdd21007e95bd13e14ad59103 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 13:37:01.310056) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 13:37:01.310333) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 13:37:01.321885) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-31 13:37:01.322282) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:37:01 INFO - MultiFileLogger online at 20161031 13:37:01 in /builds/slave/test 13:37:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:37:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:37:01 INFO - {'append_to_log': False, 13:37:01 INFO - 'base_work_dir': '/builds/slave/test', 13:37:01 INFO - 'blob_upload_branch': 'Fx-Team', 13:37:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:37:01 INFO - 'branch': 'Fx-Team', 13:37:01 INFO - 'buildbot_json_path': 'buildprops.json', 13:37:01 INFO - 'config_files': ('talos/linux_config.py',), 13:37:01 INFO - 'default_actions': ('clobber', 13:37:01 INFO - 'read-buildbot-config', 13:37:01 INFO - 'download-and-extract', 13:37:01 INFO - 'populate-webroot', 13:37:01 INFO - 'create-virtualenv', 13:37:01 INFO - 'install', 13:37:01 INFO - 'run-tests'), 13:37:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:37:01 INFO - 'download_minidump_stackwalk': True, 13:37:01 INFO - 'download_symbols': 'ondemand', 13:37:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:37:01 INFO - 'tooltool.py': '/tools/tooltool.py', 13:37:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:37:01 INFO - '/tools/misc-python/virtualenv.py')}, 13:37:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:37:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:37:01 INFO - 'installer_path': 'installer.exe', 13:37:01 INFO - 'log_level': 'info', 13:37:01 INFO - 'log_name': 'talos', 13:37:01 INFO - 'log_to_console': True, 13:37:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:37:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:37:01 INFO - 'opt_config_files': (), 13:37:01 INFO - 'pip_index': False, 13:37:01 INFO - 'sps_profile': False, 13:37:01 INFO - 'sps_profile_interval': 0, 13:37:01 INFO - 'suite': 'dromaeojs', 13:37:01 INFO - 'system_bits': '32', 13:37:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:37:01 INFO - 'title': 'talos-linux64-ix-009', 13:37:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:37:01 INFO - 'use_talos_json': True, 13:37:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:37:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:37:01 INFO - 'work_dir': 'build'} 13:37:01 INFO - [mozharness: 2016-10-31 20:37:01.614728Z] Running clobber step. 13:37:01 INFO - Running pre-action listener: _resource_record_pre_action 13:37:01 INFO - Running main action method: clobber 13:37:01 INFO - rmtree: /builds/slave/test/build 13:37:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:37:02 INFO - Running post-action listener: _resource_record_post_action 13:37:02 INFO - [mozharness: 2016-10-31 20:37:02.594736Z] Finished clobber step (success) 13:37:02 INFO - [mozharness: 2016-10-31 20:37:02.594837Z] Running read-buildbot-config step. 13:37:02 INFO - Running pre-action listener: _resource_record_pre_action 13:37:02 INFO - Running main action method: read_buildbot_config 13:37:02 INFO - Using buildbot properties: 13:37:02 INFO - { 13:37:02 INFO - "project": "", 13:37:02 INFO - "product": "firefox", 13:37:02 INFO - "script_repo_revision": "production", 13:37:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:37:02 INFO - "repository": "", 13:37:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:37:02 INFO - "buildid": "20161031073029", 13:37:02 INFO - "stage_platform": "linux64-pgo", 13:37:02 INFO - "basedir": "/builds/slave/test", 13:37:02 INFO - "buildnumber": 1674, 13:37:02 INFO - "platform": "ubuntu64_hw", 13:37:02 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:37:02 INFO - "slavebuilddir": "test", 13:37:02 INFO - "branch": "fx-team", 13:37:02 INFO - "revision": "e017b947cea08b7bdd21007e95bd13e14ad59103", 13:37:02 INFO - "slavename": "talos-linux64-ix-009", 13:37:02 INFO - "builduid": "397a287c61eb43f3992e3082f4114afb", 13:37:02 INFO - "repo_path": "integration/fx-team" 13:37:02 INFO - } 13:37:02 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 13:37:02 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 13:37:02 INFO - Running post-action listener: _resource_record_post_action 13:37:02 INFO - [mozharness: 2016-10-31 20:37:02.597197Z] Finished read-buildbot-config step (success) 13:37:02 INFO - [mozharness: 2016-10-31 20:37:02.597285Z] Running download-and-extract step. 13:37:02 INFO - Running pre-action listener: _resource_record_pre_action 13:37:02 INFO - Running main action method: download_and_extract 13:37:02 INFO - mkdir: /builds/slave/test/build/tests 13:37:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:37:02 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:37:02 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/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 13:37:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/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 13:37:02 INFO - Downloaded 1361 bytes. 13:37:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:37:02 INFO - Using the following test package requirements: 13:37:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:37:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:37:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:37:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:37:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:37:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:37:02 INFO - u'jsshell-linux-x86_64.zip'], 13:37:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:37:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:37:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:37:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:37:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:37:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:37:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:37:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:37:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:37:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:37:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:37:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:37:02 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/1477888230/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:37:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:37:02 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:37:02 INFO - Http code: 200 13:37:02 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 13:37:02 INFO - x-amz-cf-id: 2qfi5ZrVFiR0qPY0TQZEGHKFmwWAnvlAfMU97pJnLLwxnl3KotwZSw== 13:37:02 INFO - x-amz-replication-status: PENDING 13:37:02 INFO - x-amz-version-id: y31BQrNdTWPkjV6bE.oIf9Bzhl9oa4xO 13:37:03 INFO - Expected file size: 22006771 13:37:03 INFO - Obtained file size: 22006771 13:37:07 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 13:37:07 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/1477888230/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:37:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:37:07 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:37:07 INFO - Http code: 200 13:37:07 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 13:37:07 INFO - x-amz-cf-id: 1GBHPnzYxhWbjWxZFBgOn-V2em3tcOwbJidbOQAbA7a5OMCu4Fwlbw== 13:37:07 INFO - x-amz-replication-status: PENDING 13:37:07 INFO - x-amz-version-id: y31BQrNdTWPkjV6bE.oIf9Bzhl9oa4xO 13:37:07 INFO - Expected file size: 22006771 13:37:07 INFO - Obtained file size: 22006771 13:37:12 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/1477888230/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 13:37:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:37:12 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:37:12 INFO - Http code: 200 13:37:12 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 13:37:12 INFO - x-amz-cf-id: Kt62KC_EKRAaBnjI-wR2YiWh_EcmeIyBNE6GMGUl3Ojb_Hln1xwEPg== 13:37:12 INFO - x-amz-replication-status: PENDING 13:37:12 INFO - x-amz-version-id: si55E5g.tWpWncDMLoPLIj9kMv5S1DyA 13:37:12 INFO - Expected file size: 14409038 13:37:12 INFO - Obtained file size: 14409038 13:37:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:37:12 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:37:12 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/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 13:37:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/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 13:37:13 INFO - Downloaded 59606250 bytes. 13:37:13 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:37:13 INFO - mkdir: /builds/slave/test/properties 13:37:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:37:13 INFO - Writing to file /builds/slave/test/properties/build_url 13:37:13 INFO - Contents: 13:37:13 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:37:14 INFO - Running post-action listener: _resource_record_post_action 13:37:14 INFO - Running post-action listener: set_extra_try_arguments 13:37:14 INFO - [mozharness: 2016-10-31 20:37:14.011132Z] Finished download-and-extract step (success) 13:37:14 INFO - [mozharness: 2016-10-31 20:37:14.011359Z] Running populate-webroot step. 13:37:14 INFO - Running pre-action listener: _resource_record_pre_action 13:37:14 INFO - Running main action method: populate_webroot 13:37:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:37:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:37:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:37:14 INFO - '--tppagecycles', 13:37:14 INFO - '7'], 13:37:14 INFO - 'tests': ['tsvgm']}}, 13:37:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:37:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:37:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:37:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:37:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:37:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:37:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:14 INFO - 'talos_options': ['--disable-e10s'], 13:37:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:37:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:37:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:14 INFO - 'talos_options': ['--disable-e10s'], 13:37:14 INFO - 'tests': ['damp', 'tps']}, 13:37:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:14 INFO - 'tests': ['damp', 'tps']}, 13:37:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:37:14 INFO - 'tests': ['dromaeo_dom']}, 13:37:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:37:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:37:14 INFO - 'tests': ['basic_compositor_video']}, 13:37:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:37:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:37:14 INFO - 'tests': ['a11yr', 13:37:14 INFO - 'ts_paint', 13:37:14 INFO - 'tpaint', 13:37:14 INFO - 'sessionrestore', 13:37:14 INFO - 'sessionrestore_no_auto_restore', 13:37:14 INFO - 'tabpaint']}, 13:37:14 INFO - 'other-e10s': {'tests': ['a11yr', 13:37:14 INFO - 'ts_paint', 13:37:14 INFO - 'tpaint', 13:37:14 INFO - 'sessionrestore', 13:37:14 INFO - 'sessionrestore_no_auto_restore', 13:37:14 INFO - 'tabpaint']}, 13:37:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:37:14 INFO - 'ts_paint', 13:37:14 INFO - 'tpaint', 13:37:14 INFO - 'sessionrestore', 13:37:14 INFO - 'sessionrestore_no_auto_restore', 13:37:14 INFO - 'tabpaint']}, 13:37:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:37:14 INFO - 'ts_paint', 13:37:14 INFO - 'tpaint', 13:37:14 INFO - 'sessionrestore', 13:37:14 INFO - 'sessionrestore_no_auto_restore', 13:37:14 INFO - 'tabpaint']}, 13:37:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:37:14 INFO - 'tests': ['a11yr', 13:37:14 INFO - 'ts_paint', 13:37:14 INFO - 'tpaint', 13:37:14 INFO - 'sessionrestore', 13:37:14 INFO - 'sessionrestore_no_auto_restore', 13:37:14 INFO - 'tabpaint']}, 13:37:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:37:14 INFO - 'tests': ['a11yr', 13:37:14 INFO - 'ts_paint', 13:37:14 INFO - 'tpaint', 13:37:14 INFO - 'sessionrestore', 13:37:14 INFO - 'sessionrestore_no_auto_restore', 13:37:14 INFO - 'tabpaint']}, 13:37:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:37:14 INFO - 'tests': ['tsvgx', 13:37:14 INFO - 'tsvgr_opacity', 13:37:14 INFO - 'tart', 13:37:14 INFO - 'tscrollx', 13:37:14 INFO - 'cart']}, 13:37:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:37:14 INFO - 'tsvgr_opacity', 13:37:14 INFO - 'tart', 13:37:14 INFO - 'tscrollx', 13:37:14 INFO - 'cart']}, 13:37:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:14 INFO - 'talos_options': ['--disable-e10s'], 13:37:14 INFO - 'tests': ['tp5o']}, 13:37:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:14 INFO - 'tests': ['tp5o']}, 13:37:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:14 INFO - 'talos_options': ['--disable-e10s', 13:37:14 INFO - '--xperf_path', 13:37:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:37:14 INFO - 'tests': ['tp5n']}, 13:37:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:14 INFO - 'talos_options': ['--xperf_path', 13:37:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:37:14 INFO - 'tests': ['tp5n']}}, 13:37:14 INFO - 'talos.zip': {'path': '', 13:37:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:37:14 INFO - Running post-action listener: _resource_record_post_action 13:37:14 INFO - [mozharness: 2016-10-31 20:37:14.031277Z] Finished populate-webroot step (success) 13:37:14 INFO - [mozharness: 2016-10-31 20:37:14.031365Z] Running create-virtualenv step. 13:37:14 INFO - Running pre-action listener: _resource_record_pre_action 13:37:14 INFO - Running main action method: create_virtualenv 13:37:14 INFO - Creating virtualenv /builds/slave/test/build/venv 13:37:14 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 13:37:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:37:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:37:14 INFO - Using real prefix '/usr' 13:37:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:37:14 INFO - Installing distribute.............................................................................................................................................................................................done. 13:37:16 INFO - Installing pip.................done. 13:37:16 INFO - Return code: 0 13:37:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:37:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:37:16 INFO - Reading from file tmpfile_stdout 13:37:16 INFO - Output received: 13:37:16 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) 13:37:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:37:16 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')]} 13:37:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:16 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')]} 13:37:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:16 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 0x7f55f684df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2361790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235e930>, '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 0x235f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235fcc0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', '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 13:37:16 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 13:37:16 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 13:37:16 INFO - Using env: {'DISPLAY': ':0', 13:37:16 INFO - 'HOME': '/home/cltbld', 13:37:16 INFO - 'LANG': 'en_US.UTF-8', 13:37:16 INFO - 'LANGUAGE': 'en_US:en', 13:37:16 INFO - 'LOGNAME': 'cltbld', 13:37:16 INFO - 'MAIL': '/var/mail/cltbld', 13:37:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:16 INFO - 'MOZ_NO_REMOTE': '1', 13:37:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:16 INFO - 'NO_EM_RESTART': '1', 13:37:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:16 INFO - 'PWD': '/builds/slave/test', 13:37:16 INFO - 'SHELL': '/bin/bash', 13:37:16 INFO - 'SHLVL': '1', 13:37:16 INFO - 'TERM': 'linux', 13:37:16 INFO - 'TMOUT': '86400', 13:37:16 INFO - 'USER': 'cltbld', 13:37:16 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', 13:37:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:16 INFO - '_': '/tools/buildbot/bin/python'} 13:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:17 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 13:37:17 INFO - Cleaning up... 13:37:17 INFO - Return code: 0 13:37:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:37: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')]} 13:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37: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')]} 13:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:17 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 0x7f55f684df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2361790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235e930>, '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 0x235f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235fcc0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', '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 13:37:17 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 13:37:17 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 13:37:17 INFO - Using env: {'DISPLAY': ':0', 13:37:17 INFO - 'HOME': '/home/cltbld', 13:37:17 INFO - 'LANG': 'en_US.UTF-8', 13:37:17 INFO - 'LANGUAGE': 'en_US:en', 13:37:17 INFO - 'LOGNAME': 'cltbld', 13:37:17 INFO - 'MAIL': '/var/mail/cltbld', 13:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:17 INFO - 'MOZ_NO_REMOTE': '1', 13:37:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:17 INFO - 'NO_EM_RESTART': '1', 13:37:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:17 INFO - 'PWD': '/builds/slave/test', 13:37:17 INFO - 'SHELL': '/bin/bash', 13:37:17 INFO - 'SHLVL': '1', 13:37:17 INFO - 'TERM': 'linux', 13:37:17 INFO - 'TMOUT': '86400', 13:37:17 INFO - 'USER': 'cltbld', 13:37:17 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', 13:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:17 INFO - '_': '/tools/buildbot/bin/python'} 13:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:17 INFO - Downloading/unpacking psutil>=3.1.1 13:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:37:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:37:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:37:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:37:19 INFO - Installing collected packages: psutil 13:37:19 INFO - Running setup.py install for psutil 13:37:19 INFO - building 'psutil._psutil_linux' extension 13:37:19 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 13:37:19 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 13:37:19 INFO - building 'psutil._psutil_posix' extension 13:37:19 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 13:37:19 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 13:37:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:37:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:37:19 INFO - Successfully installed psutil 13:37:19 INFO - Cleaning up... 13:37:19 INFO - Return code: 0 13:37:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:19 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 0x7f55f684df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2361790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235e930>, '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 0x235f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235fcc0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', '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 13:37:19 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 13:37:19 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 13:37:19 INFO - Using env: {'DISPLAY': ':0', 13:37:19 INFO - 'HOME': '/home/cltbld', 13:37:19 INFO - 'LANG': 'en_US.UTF-8', 13:37:19 INFO - 'LANGUAGE': 'en_US:en', 13:37:19 INFO - 'LOGNAME': 'cltbld', 13:37:19 INFO - 'MAIL': '/var/mail/cltbld', 13:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:19 INFO - 'MOZ_NO_REMOTE': '1', 13:37:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:19 INFO - 'NO_EM_RESTART': '1', 13:37:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:19 INFO - 'PWD': '/builds/slave/test', 13:37:19 INFO - 'SHELL': '/bin/bash', 13:37:19 INFO - 'SHLVL': '1', 13:37:19 INFO - 'TERM': 'linux', 13:37:19 INFO - 'TMOUT': '86400', 13:37:19 INFO - 'USER': 'cltbld', 13:37:19 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', 13:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:19 INFO - '_': '/tools/buildbot/bin/python'} 13:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:37:20 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 13:37:20 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 13:37:20 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 13:37:20 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 13:37:20 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 13:37:20 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 13:37:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:37:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:37:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:37:22 INFO - Installing collected packages: mozsystemmonitor 13:37:22 INFO - Running setup.py install for mozsystemmonitor 13:37:22 INFO - Successfully installed mozsystemmonitor 13:37:22 INFO - Cleaning up... 13:37:22 INFO - Return code: 0 13:37:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:37:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:22 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 0x7f55f684df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2361790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235e930>, '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 0x235f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235fcc0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', '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 13:37:22 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 13:37:22 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 13:37:22 INFO - Using env: {'DISPLAY': ':0', 13:37:22 INFO - 'HOME': '/home/cltbld', 13:37:22 INFO - 'LANG': 'en_US.UTF-8', 13:37:22 INFO - 'LANGUAGE': 'en_US:en', 13:37:22 INFO - 'LOGNAME': 'cltbld', 13:37:22 INFO - 'MAIL': '/var/mail/cltbld', 13:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:22 INFO - 'MOZ_NO_REMOTE': '1', 13:37:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:22 INFO - 'NO_EM_RESTART': '1', 13:37:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:22 INFO - 'PWD': '/builds/slave/test', 13:37:22 INFO - 'SHELL': '/bin/bash', 13:37:22 INFO - 'SHLVL': '1', 13:37:22 INFO - 'TERM': 'linux', 13:37:22 INFO - 'TMOUT': '86400', 13:37:22 INFO - 'USER': 'cltbld', 13:37:22 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', 13:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:22 INFO - '_': '/tools/buildbot/bin/python'} 13:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:22 INFO - Downloading/unpacking jsonschema==2.5.1 13:37: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 13:37: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 13:37: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 13:37: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 13:37: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 13:37: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 13:37:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:37:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:37:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:24 INFO - Downloading functools32-3.2.3-2.tar.gz 13:37:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:37:24 INFO - warning: no files found matching '*.txt' 13:37:24 INFO - no previously-included directories found matching 'build' 13:37:24 INFO - no previously-included directories found matching 'dist' 13:37:24 INFO - no previously-included directories found matching '.git*' 13:37:24 INFO - Installing collected packages: jsonschema, functools32 13:37:24 INFO - Running setup.py install for functools32 13:37:24 INFO - warning: no files found matching '*.txt' 13:37:24 INFO - no previously-included directories found matching 'build' 13:37:24 INFO - no previously-included directories found matching 'dist' 13:37:24 INFO - no previously-included directories found matching '.git*' 13:37:24 INFO - Successfully installed jsonschema functools32 13:37:24 INFO - Cleaning up... 13:37:24 INFO - Return code: 0 13:37:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:37: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')]} 13:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37: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')]} 13:37:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37: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', '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 0x7f55f684df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2361790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235e930>, '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 0x235f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235fcc0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', '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 13:37: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:37: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 functools32==3.2.3-2 13:37:24 INFO - Using env: {'DISPLAY': ':0', 13:37:24 INFO - 'HOME': '/home/cltbld', 13:37:24 INFO - 'LANG': 'en_US.UTF-8', 13:37:24 INFO - 'LANGUAGE': 'en_US:en', 13:37:24 INFO - 'LOGNAME': 'cltbld', 13:37:24 INFO - 'MAIL': '/var/mail/cltbld', 13:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:24 INFO - 'MOZ_NO_REMOTE': '1', 13:37:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:24 INFO - 'NO_EM_RESTART': '1', 13:37:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:24 INFO - 'PWD': '/builds/slave/test', 13:37:24 INFO - 'SHELL': '/bin/bash', 13:37:24 INFO - 'SHLVL': '1', 13:37:24 INFO - 'TERM': 'linux', 13:37:24 INFO - 'TMOUT': '86400', 13:37:24 INFO - 'USER': 'cltbld', 13:37:24 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', 13:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:24 INFO - '_': '/tools/buildbot/bin/python'} 13:37:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:37:25 INFO - Cleaning up... 13:37:25 INFO - Return code: 0 13:37:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:37:25 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')]} 13:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:25 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')]} 13:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:25 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 0x7f55f684df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2361790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235e930>, '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 0x235f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235fcc0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', '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 13:37:25 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 13:37:25 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 13:37:25 INFO - Using env: {'DISPLAY': ':0', 13:37:25 INFO - 'HOME': '/home/cltbld', 13:37:25 INFO - 'LANG': 'en_US.UTF-8', 13:37:25 INFO - 'LANGUAGE': 'en_US:en', 13:37:25 INFO - 'LOGNAME': 'cltbld', 13:37:25 INFO - 'MAIL': '/var/mail/cltbld', 13:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:25 INFO - 'MOZ_NO_REMOTE': '1', 13:37:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:25 INFO - 'NO_EM_RESTART': '1', 13:37:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:25 INFO - 'PWD': '/builds/slave/test', 13:37:25 INFO - 'SHELL': '/bin/bash', 13:37:25 INFO - 'SHLVL': '1', 13:37:25 INFO - 'TERM': 'linux', 13:37:25 INFO - 'TMOUT': '86400', 13:37:25 INFO - 'USER': 'cltbld', 13:37:25 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', 13:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:25 INFO - '_': '/tools/buildbot/bin/python'} 13:37:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:25 INFO - Downloading/unpacking blobuploader==1.2.4 13:37:25 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 13:37:25 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 13:37:25 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 13:37:25 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 13:37:25 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 13:37:25 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 13:37:27 INFO - Downloading blobuploader-1.2.4.tar.gz 13:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:37:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:37:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:37:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:37:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:27 INFO - Downloading docopt-0.6.1.tar.gz 13:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:37:27 INFO - Installing collected packages: blobuploader, requests, docopt 13:37:27 INFO - Running setup.py install for blobuploader 13:37:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:37:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:37:28 INFO - Running setup.py install for requests 13:37:28 INFO - Running setup.py install for docopt 13:37:28 INFO - Successfully installed blobuploader requests docopt 13:37:28 INFO - Cleaning up... 13:37:28 INFO - Return code: 0 13:37:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:37:28 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')]} 13:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:28 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')]} 13:37:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:28 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 0x7f55f684df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2361790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235e930>, '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 0x235f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235fcc0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', '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 13:37:28 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 13:37:28 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 13:37:28 INFO - Using env: {'DISPLAY': ':0', 13:37:28 INFO - 'HOME': '/home/cltbld', 13:37:28 INFO - 'LANG': 'en_US.UTF-8', 13:37:28 INFO - 'LANGUAGE': 'en_US:en', 13:37:28 INFO - 'LOGNAME': 'cltbld', 13:37:28 INFO - 'MAIL': '/var/mail/cltbld', 13:37:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:28 INFO - 'MOZ_NO_REMOTE': '1', 13:37:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:28 INFO - 'NO_EM_RESTART': '1', 13:37:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:28 INFO - 'PWD': '/builds/slave/test', 13:37:28 INFO - 'SHELL': '/bin/bash', 13:37:28 INFO - 'SHLVL': '1', 13:37:28 INFO - 'TERM': 'linux', 13:37:28 INFO - 'TMOUT': '86400', 13:37:28 INFO - 'USER': 'cltbld', 13:37:28 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', 13:37:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:28 INFO - '_': '/tools/buildbot/bin/python'} 13:37:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:37:28 INFO - Running setup.py (path:/tmp/pip-Q19Kpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:37:28 INFO - Running setup.py (path:/tmp/pip-SbEoQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:37:28 INFO - Running setup.py (path:/tmp/pip-boMXeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:37:29 INFO - Running setup.py (path:/tmp/pip-jn4vTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:37:29 INFO - Running setup.py (path:/tmp/pip-z0KEfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:37:29 INFO - Running setup.py (path:/tmp/pip-K56mD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:37:29 INFO - Running setup.py (path:/tmp/pip-tyNgOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:37:29 INFO - Running setup.py (path:/tmp/pip-l61T9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:37:29 INFO - Running setup.py (path:/tmp/pip-tflvuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:37:29 INFO - Running setup.py (path:/tmp/pip-hR7pop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:37:29 INFO - Running setup.py (path:/tmp/pip-f08Wfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:37:29 INFO - Running setup.py (path:/tmp/pip-V6OKEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:37:29 INFO - Running setup.py (path:/tmp/pip-1c9Hio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:37:29 INFO - Running setup.py (path:/tmp/pip-7tVshU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:37:29 INFO - Running setup.py (path:/tmp/pip-F6HSbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:37:29 INFO - Running setup.py (path:/tmp/pip-0xd5WN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:37:29 INFO - Running setup.py (path:/tmp/pip-qIjbnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:37:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:37:30 INFO - Running setup.py install for manifestparser 13:37:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:37:30 INFO - Running setup.py install for mozcrash 13:37:30 INFO - Running setup.py install for mozdebug 13:37:30 INFO - Running setup.py install for mozdevice 13:37:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:37:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:37:30 INFO - Running setup.py install for mozfile 13:37:30 INFO - Running setup.py install for mozhttpd 13:37:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:37:30 INFO - Running setup.py install for mozinfo 13:37:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:37:30 INFO - Running setup.py install for mozInstall 13:37:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:37:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:37:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:37:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:37:30 INFO - Running setup.py install for mozleak 13:37:30 INFO - Running setup.py install for mozlog 13:37:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:37:31 INFO - Running setup.py install for moznetwork 13:37:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:37:31 INFO - Running setup.py install for mozprocess 13:37:31 INFO - Running setup.py install for mozprofile 13:37:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:37:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:37:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:37:31 INFO - Running setup.py install for mozrunner 13:37:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:37:31 INFO - Running setup.py install for mozscreenshot 13:37:31 INFO - Running setup.py install for moztest 13:37:31 INFO - Running setup.py install for mozversion 13:37:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:37:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:37:31 INFO - Cleaning up... 13:37:31 INFO - Return code: 0 13:37:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:37:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:31 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 0x7f55f684df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2361790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235e930>, '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 0x235f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235fcc0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', '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 13:37:31 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 13:37:31 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 13:37:31 INFO - Using env: {'DISPLAY': ':0', 13:37:31 INFO - 'HOME': '/home/cltbld', 13:37:31 INFO - 'LANG': 'en_US.UTF-8', 13:37:31 INFO - 'LANGUAGE': 'en_US:en', 13:37:31 INFO - 'LOGNAME': 'cltbld', 13:37:31 INFO - 'MAIL': '/var/mail/cltbld', 13:37:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:31 INFO - 'MOZ_NO_REMOTE': '1', 13:37:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:31 INFO - 'NO_EM_RESTART': '1', 13:37:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:31 INFO - 'PWD': '/builds/slave/test', 13:37:31 INFO - 'SHELL': '/bin/bash', 13:37:31 INFO - 'SHLVL': '1', 13:37:31 INFO - 'TERM': 'linux', 13:37:31 INFO - 'TMOUT': '86400', 13:37:31 INFO - 'USER': 'cltbld', 13:37:31 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', 13:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:31 INFO - '_': '/tools/buildbot/bin/python'} 13:37:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:37:32 INFO - Running setup.py (path:/tmp/pip-MFrTN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:37:32 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)) 13:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:37:32 INFO - Running setup.py (path:/tmp/pip-xLKmTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:37:32 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)) 13:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:37:32 INFO - Running setup.py (path:/tmp/pip-sYBReW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:37:32 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)) 13:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:37:32 INFO - Running setup.py (path:/tmp/pip-NkxzSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:37:32 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)) 13:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:37:32 INFO - Running setup.py (path:/tmp/pip-hCBdsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:37:32 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)) 13:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:37:32 INFO - Running setup.py (path:/tmp/pip-E4zajS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:37:32 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)) 13:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:37:32 INFO - Running setup.py (path:/tmp/pip-W3Ifea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:37:32 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)) 13:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:37:32 INFO - Running setup.py (path:/tmp/pip-SySGeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:37:32 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)) 13:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:37:32 INFO - Running setup.py (path:/tmp/pip-VrO8hN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:37:32 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)) 13:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:37:32 INFO - Running setup.py (path:/tmp/pip-VBlqcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:37:32 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)) 13:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:37:32 INFO - Running setup.py (path:/tmp/pip-spX7N1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:37:32 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)) 13:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:37:32 INFO - Running setup.py (path:/tmp/pip-6oSv5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:37:32 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)) 13:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:37:32 INFO - Running setup.py (path:/tmp/pip-YcD0il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:37:32 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)) 13:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:37:32 INFO - Running setup.py (path:/tmp/pip-Q4PRGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:37:33 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)) 13:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:37:33 INFO - Running setup.py (path:/tmp/pip-Qk0MMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:37:33 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)) 13:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:37:33 INFO - Running setup.py (path:/tmp/pip-0qVMID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:37:33 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)) 13:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:37:33 INFO - Running setup.py (path:/tmp/pip-21Y3M0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:37:33 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)) 13:37:33 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)) 13:37:33 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)) 13:37:33 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)) 13:37:33 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)) 13:37:33 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)) 13:37:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:37:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:35 INFO - Downloading blessings-1.6.tar.gz 13:37:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:37:35 INFO - Installing collected packages: blessings 13:37:35 INFO - Running setup.py install for blessings 13:37:35 INFO - Successfully installed blessings 13:37:35 INFO - Cleaning up... 13:37:35 INFO - Return code: 0 13:37:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:37:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:37:35 INFO - Reading from file tmpfile_stdout 13:37:35 INFO - Current package versions: 13:37:35 INFO - argparse == 1.2.1 13:37:35 INFO - blessings == 1.6 13:37:35 INFO - blobuploader == 1.2.4 13:37:35 INFO - docopt == 0.6.1 13:37:35 INFO - functools32 == 3.2.3-2 13:37:35 INFO - jsonschema == 2.5.1 13:37:35 INFO - manifestparser == 1.1 13:37:35 INFO - mozInstall == 1.12 13:37:35 INFO - mozcrash == 0.17 13:37:35 INFO - mozdebug == 0.1 13:37:35 INFO - mozdevice == 0.48 13:37:35 INFO - mozfile == 1.2 13:37:35 INFO - mozhttpd == 0.7 13:37:35 INFO - mozinfo == 0.9 13:37:35 INFO - mozleak == 0.1 13:37:35 INFO - mozlog == 3.4 13:37:35 INFO - moznetwork == 0.27 13:37:35 INFO - mozprocess == 0.23 13:37:35 INFO - mozprofile == 0.28 13:37:35 INFO - mozrunner == 6.12 13:37:35 INFO - mozscreenshot == 0.1 13:37:35 INFO - mozsystemmonitor == 0.3 13:37:35 INFO - moztest == 0.7 13:37:35 INFO - mozversion == 1.4 13:37:35 INFO - psutil == 3.1.1 13:37:35 INFO - requests == 1.2.3 13:37:35 INFO - wsgiref == 0.1.2 13:37:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:37:35 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')]} 13:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:35 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')]} 13:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:35 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 0x7f55f684df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2361790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235e930>, '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 0x235f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235fcc0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', '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 13:37:35 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 13:37:35 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 13:37:35 INFO - Using env: {'DISPLAY': ':0', 13:37:35 INFO - 'HOME': '/home/cltbld', 13:37:35 INFO - 'LANG': 'en_US.UTF-8', 13:37:35 INFO - 'LANGUAGE': 'en_US:en', 13:37:35 INFO - 'LOGNAME': 'cltbld', 13:37:35 INFO - 'MAIL': '/var/mail/cltbld', 13:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:35 INFO - 'MOZ_NO_REMOTE': '1', 13:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:35 INFO - 'NO_EM_RESTART': '1', 13:37:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:35 INFO - 'PWD': '/builds/slave/test', 13:37:35 INFO - 'SHELL': '/bin/bash', 13:37:35 INFO - 'SHLVL': '1', 13:37:35 INFO - 'TERM': 'linux', 13:37:35 INFO - 'TMOUT': '86400', 13:37:35 INFO - 'USER': 'cltbld', 13:37:35 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', 13:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:35 INFO - '_': '/tools/buildbot/bin/python'} 13:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:35 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)) 13:37:35 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)) 13:37:35 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)) 13:37:35 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)) 13:37:35 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)) 13:37:35 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)) 13:37:35 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)) 13:37:35 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)) 13:37:35 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)) 13:37:35 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)) 13:37:35 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)) 13:37:35 INFO - Cleaning up... 13:37:35 INFO - Return code: 0 13:37:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:37:35 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')]} 13:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:35 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')]} 13:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:35 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 0x7f55f684df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2361790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235e930>, '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 0x235f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235fcc0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', '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 13:37:35 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 13:37:35 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 13:37:35 INFO - Using env: {'DISPLAY': ':0', 13:37:35 INFO - 'HOME': '/home/cltbld', 13:37:35 INFO - 'LANG': 'en_US.UTF-8', 13:37:35 INFO - 'LANGUAGE': 'en_US:en', 13:37:35 INFO - 'LOGNAME': 'cltbld', 13:37:35 INFO - 'MAIL': '/var/mail/cltbld', 13:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:35 INFO - 'MOZ_NO_REMOTE': '1', 13:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:35 INFO - 'NO_EM_RESTART': '1', 13:37:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:35 INFO - 'PWD': '/builds/slave/test', 13:37:35 INFO - 'SHELL': '/bin/bash', 13:37:35 INFO - 'SHLVL': '1', 13:37:35 INFO - 'TERM': 'linux', 13:37:35 INFO - 'TMOUT': '86400', 13:37:35 INFO - 'USER': 'cltbld', 13:37:35 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', 13:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:35 INFO - '_': '/tools/buildbot/bin/python'} 13:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:37:36 INFO - Cleaning up... 13:37:36 INFO - Return code: 0 13:37:36 INFO - Running post-action listener: _resource_record_post_action 13:37:36 INFO - Running post-action listener: _start_resource_monitoring 13:37:36 INFO - Starting resource monitoring. 13:37:36 INFO - [mozharness: 2016-10-31 20:37:36.163569Z] Finished create-virtualenv step (success) 13:37:36 INFO - [mozharness: 2016-10-31 20:37:36.164074Z] Running install step. 13:37:36 INFO - Running pre-action listener: _resource_record_pre_action 13:37:36 INFO - Running main action method: install 13:37:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:37:36 INFO - Reading from file tmpfile_stdout 13:37:36 INFO - Detecting whether we're running mozinstall >=1.0... 13:37:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:37:36 INFO - Reading from file tmpfile_stdout 13:37:36 INFO - Output received: 13:37:36 INFO - Usage: mozinstall [options] installer 13:37:36 INFO - Options: 13:37:36 INFO - -h, --help show this help message and exit 13:37:36 INFO - -d DEST, --destination=DEST 13:37:36 INFO - Directory to install application into. [default: 13:37:36 INFO - "/builds/slave/test"] 13:37:36 INFO - --app=APP Application being installed. [default: firefox] 13:37:36 INFO - mkdir: /builds/slave/test/build/application 13:37:36 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'] 13:37:36 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 13:37:53 INFO - Reading from file tmpfile_stdout 13:37:53 INFO - Output received: 13:37:53 INFO - /builds/slave/test/build/application/firefox/firefox 13:37:53 INFO - Running post-action listener: _resource_record_post_action 13:37:53 INFO - [mozharness: 2016-10-31 20:37:53.416598Z] Finished install step (success) 13:37:53 INFO - [mozharness: 2016-10-31 20:37:53.416875Z] Running run-tests step. 13:37:53 INFO - Running pre-action listener: _resource_record_pre_action 13:37:53 INFO - Running main action method: run_tests 13:37:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:37:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:37:53 INFO - Python 2.7.3 13:37:53 INFO - Return code: 0 13:37:53 INFO - grabbing minidump binary from tooltool 13:37:53 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')]} 13:37:53 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 0x235e930>, '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 0x235f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235fcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:37:53 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 13:37:53 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 13:37:53 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 13:37:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:37:53 INFO - Return code: 0 13:37:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:37:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:37:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:37:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:37:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:37:53 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:37:53 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:37:53 INFO - Using env: {'DISPLAY': ':0', 13:37:53 INFO - 'HOME': '/home/cltbld', 13:37:53 INFO - 'LANG': 'en_US.UTF-8', 13:37:53 INFO - 'LANGUAGE': 'en_US:en', 13:37:53 INFO - 'LOGNAME': 'cltbld', 13:37:53 INFO - 'MAIL': '/var/mail/cltbld', 13:37:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:37:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:53 INFO - 'MOZ_NO_REMOTE': '1', 13:37:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:53 INFO - 'NO_EM_RESTART': '1', 13:37:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:53 INFO - 'PWD': '/builds/slave/test', 13:37:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:37:53 INFO - 'SHELL': '/bin/bash', 13:37:53 INFO - 'SHLVL': '1', 13:37:53 INFO - 'TERM': 'linux', 13:37:53 INFO - 'TMOUT': '86400', 13:37:53 INFO - 'USER': 'cltbld', 13:37:53 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029', 13:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:53 INFO - '_': '/tools/buildbot/bin/python'} 13:37:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:37:53 INFO - mozversion application_buildid: 20161030213030 13:37:53 INFO - mozversion application_changeset: e017b947cea08b7bdd21007e95bd13e14ad59103 13:37:53 INFO - mozversion application_display_name: Nightly 13:37:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:37:53 INFO - mozversion application_name: Firefox 13:37:53 INFO - mozversion application_remotingname: firefox 13:37:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:37:53 INFO - mozversion application_vendor: Mozilla 13:37:53 INFO - mozversion application_version: 52.0a1 13:37:53 INFO - mozversion platform_buildid: 20161030213030 13:37:53 INFO - mozversion platform_changeset: e017b947cea08b7bdd21007e95bd13e14ad59103 13:37:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:37:53 INFO - mozversion platform_version: 52.0a1 13:37:53 INFO - using testdate: 1477946273 13:37:53 INFO - actual date: 1477946273 13:37:53 INFO - starting webserver on 'localhost:36700' 13:37:53 INFO - SUITE-START | Running 2 tests 13:37:53 INFO - TEST-START | dromaeo_css 13:37:53 INFO - operating with platform_type : linux_ 13:37:53 INFO - Initialising browser for dromaeo_css test... 13:37:53 INFO - TEST-INFO | started process 11685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkZfrZ7/profile http://localhost:36700/getInfo.html) 13:37:57 INFO - PROCESS | 11685 | __metrics Screen width/height:1600/1200 13:37:57 INFO - PROCESS | 11685 | colorDepth:24 13:37:57 INFO - PROCESS | 11685 | Browser inner width/height: 1024/697 13:37:57 INFO - PROCESS | 11685 | __metrics 13:37:58 INFO - PROCESS | 11685 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:37:58 INFO - PROCESS | 11685 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:37:59 INFO - PROCESS | 11685 | console.error: PushService: 13:37:59 INFO - PROCESS | 11685 | stateChangeProcessEnqueue: Error transitioning state 13:37:59 INFO - PROCESS | 11685 | UnknownError 13:37:59 INFO - TEST-INFO | 11685: exit 0 13:37:59 INFO - Browser initialized. 13:37:59 INFO - Running cycle 1/1 for dromaeo_css test... 13:37:59 INFO - TEST-INFO | started process 11770 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkZfrZ7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:38:11 INFO - PROCESS | 11770 | RSS: Main: 174403584 13:38:11 INFO - PROCESS | 11770 | 13:39:03 INFO - PROCESS | 11770 | 1477946343142 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] 13:41:14 INFO - PROCESS | 11770 | Cycle 1(1): loaded http://localhost:36700/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36700/tests/dromaeo/cssquery-ext.html) 13:41:15 INFO - PROCESS | 11770 | RSS: Main: 286687232 13:41:15 INFO - PROCESS | 11770 | 13:44:18 INFO - PROCESS | 11770 | Cycle 1(1): loaded http://localhost:36700/tests/dromaeo/cssquery-ext.html (next: http://localhost:36700/tests/dromaeo/cssquery-jquery.html) 13:44:19 INFO - PROCESS | 11770 | RSS: Main: 278044672 13:44:19 INFO - PROCESS | 11770 | 13:47:20 INFO - PROCESS | 11770 | Cycle 1(1): loaded http://localhost:36700/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36700/tests/dromaeo/cssquery-mootools.html) 13:47:21 INFO - PROCESS | 11770 | RSS: Main: 241766400 13:47:21 INFO - PROCESS | 11770 | 13:50:23 INFO - PROCESS | 11770 | Cycle 1(1): loaded http://localhost:36700/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36700/tests/dromaeo/cssquery-prototype.html) 13:50:24 INFO - PROCESS | 11770 | RSS: Main: 247914496 13:50:24 INFO - PROCESS | 11770 | 13:53:27 INFO - PROCESS | 11770 | Cycle 1(1): loaded http://localhost:36700/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36700/tests/dromaeo/cssquery-yui.html) 13:53:27 INFO - PROCESS | 11770 | RSS: Main: 219066368 13:53:27 INFO - PROCESS | 11770 | 13:56:30 INFO - PROCESS | 11770 | Cycle 1(1): loaded http://localhost:36700/tests/dromaeo/cssquery-yui.html (next: http://localhost:36700/tests/dromaeo/cssquery-dojo.html) 13:56:30 INFO - PROCESS | 11770 | RSS: Main: 314470400 13:56:30 INFO - PROCESS | 11770 | 13:56:30 INFO - PROCESS | 11770 | __start_tp_report 13:56:30 INFO - PROCESS | 11770 | _x_x_mozilla_page_load 13:56:30 INFO - PROCESS | 11770 | _x_x_mozilla_page_load_details 13:56:30 INFO - PROCESS | 11770 | |i|pagename|runs| 13:56:30 INFO - PROCESS | 11770 | |0;dojo.html;3025.379797141586;3064;3087.1201707513364;3099.845007749612;3106.766992475565;5226.163813789794;5296.576273898088;5301.7084060376665;5371.140617501195;5390.865228369288;5328.067588172074;5338.946610533893;5354.732263386834;5355.384130824957;5366.838994830152;4812.831550895719;4835.830745923893;4846.733429661367;4891.4130304363525;4904.730239836807;4837.927431088537;4849.199882019462;4871.537203965618;4884.5848102911295;4885.291632713254;4878.0731660984475;4881.975590122062;4896.290037944496;4926.679765815228;4927.236278376839;4972.801087956477;4975.925361119586;4990.30135780991;4991.076650819574;5041.395032596112;4700.952990470086;4730.195866702668;4730.550597693248;4891.902161956777;4892.559669629751;5191.740412979374;5245.816396426107;5270.235815806686;5278.551323137538;5308.203769434577;5623.156526521014;5664.631798933097;5733.82798516041;5735.225744524478;5738.110592858114;5535.308086489189;5766.769329226826;5770.826875193751;5775.422457754233;5782.190493330937;5264.131418315973;5350.250964864961;5391.514763671288;5397.595180361489;5402.810901618424;5842.532597392198;5874.530037596982;5877.617954832922;5877.882442351129;5881.9705901470215;5507.752151153208;5643.830685079454;5651.124075768263;5653.236813030188;5660.066089095336;5617.8033768817895;5633.802816901389;5655.0103731847585;5710.71446427677;5717.828465146053;5724.398938111522;5726.656400615976;5744.396838331999;5746.9425305747245;5774.335951365562;5757.337906140764;5760.53915686744;5763.740631671585;5764.654120752768;5811.012127938261;4235.618794308465;4290.699651024398;4310.353446982977;4311.417958575615;4377.934330985037;3851.017990412427;3857.4406711026745;3871.941920871133;3906.2968665640456;3925.7840818755244;5330.546903513167;5333.599980001438;5339.546138578186;5340.25236466895;5341.278927344759;5540.722963851791;5583.3858275589655;5630.042892708249;5638.632061915942;5646.265985421869;5388.5419739321815;5453.536449401845;5479.863003424946;5494.697791621419;5556.277683901148;4996.800127994912;5011.022850544109;5011.047900898818;5012.097822392005;5070.670406423571;5692.516136128475;5928.110783382527;5959.4934430573885;5964.075568286922;5966.463018328198;5609.635373700697;5730.971345143247;5778.27771528559;5784.913226301524;5868.501177399969;5916.585838991229;5962.16529685853;5971.880562388815;5977.432143946318;5977.850553736017;5680.318361796611;5684.147377893349;5685.118806584986;5693.373728889902;5693.572982026281;5504.697241651587;5546.833594992157;5625.268715067015;5661.150827375926;5685.20407142992;5583.106702927512;5590;5591.580631452576;5593;5656.208130861765;5514;5550.47270509301;5556.694381809039;5562.527185189142;5566.526845218202;5362.1420572708175;5399.541039011728;5509.696966666872;5549.250851135045;5572.024895643165;5654.915176272277;5699.658020518782;5704.429557044428;5753.424657534213;5765.56758243125;5253.422123566481;5570.86072848182;5581.10702287632;5583.748731307182;5585.581081418829 13:56:30 INFO - PROCESS | 11770 | |1;ext.html;562.0990136933831;581.9883602327953;584.6170758153411;597.9864130299144;604.6009633641797;33439;34003.48994765074;34120.14699632507;34129.293535323224;34148;43105.568944310544;43956;44029.55970440303;47098.764506177504;47113.52886471143;8683.39216254864;8908.242799362062;8915.331350148732;8917.33120015998;8921.241694455979;8150.5517196554165;8342.082370939192;8748.69379571715;8829.558522073903;10355.585776568929;10386.428746418944;10447.216458765584;10454.68635940923;10460.633877814278;10481.475926203697;10731.892681073206;10822.080123189538;10832.350058996406;10833.349999000045;10837.349759014485;10541.947290263577;10595.629152979609;10609.363438193734;10613.628523001658;10616.734581635521;41794;42097.368539471936;42140;42154.36768448476;42222.78888605568;3347.129746265964;3411.1472131967007;3465.324261768956;3505.7545971781988;3629.237860049393;30311.69688303111;31304;31337.686623133934;31374;31652.525212121836;4203.726757760735;4209.284421648296;4289.399484072233;4296.2696341621995;4341.826326946918;310971;311259.44370278233;312020;312493.56349765597;312592;55926.161107583415;56347.43652563422;56569.71715141398;56626.7168664154;56668;59641.70179149076;59726;59752.402475975556;59761.40238597646;59787.10319345213;15858.841411585736;16060.357585696675;16084.597885052968;16087.839121608635;16094.919525402298;12259.877401226053;12317.26096434199;12318;12324.322162280982;12327.50689972391;14571.198584077978;14650.926745366418;16212.270447829877;16492.505224843273;16598.170091495376;4830.124881433944;5934.970325148347;5959.970200148971;5975.43233392827;6027.397260273938;968.1867231525553;986.2356673578034;999.7500624843789;1007.4106647611229;1026.3226270661328;30424.847875760923;30933.226669333446;31072;32183.35633287368;32294.83852580769;1013.366645846346;1078.6224821312478;1092.721515826469;1131.8132508136066;1137.9487923043482;15630.531084067496;16374.345026199057;16653.583660408585;16655.6668866622;16664.666706665797;445252;446855;448739;449207;450376;53788.73105634525;54312.72843635835;54626.453735462135;55247.723761380934;56973.43026569764;1345.0853419674715;1352.7700290950365;1354.4514471639002;1355.525566051874;1360.53741727813;30122.292853682913;32360.35279294448;32420.35159296848;32611;33086.503702444;49440.752796237226;49836.501634983186;49868;49948.50051499584;50047;439415;440282;441784;442019.26874753035;442934;39024.6097539021;39362.2127557453;40215;40367;40415.1916961665;45599.544004560856;46755.29867052065;47641.285380718626;47923.28115078346;48313.516864830905;38012.80993595014;39833.60166398299;39876.220137112694;40355.59644403518;40652.18695626012;38444.80777596206;38948.221035578565;40154.59845401625;40226.59773402228;40795.796021019705;39227.607723922396;39290.607093928695;39682;39816.60183398245;40832.1833563333;32674.673253267163;35494.29011419809;35640.82179589086;36035;36123.81938090398;26793.330166745207;27106.72893271121;27277.727222727517;27492.539253275063;27566.061343209574 13:56:30 INFO - PROCESS | 11770 | |2;jquery.html;372.48596936228;397.2868700682277;403.6750415915188;406.3863566015317;420.10727204690033;13464;18464.907675461636;18585.721214181798;18663.97348145853;18827.62344753104;17781.822181778178;18062.5484362891;18295.451136465894;18303.17635706393;18329.54176145597;5429.56563474923;5469.124940009599;5696.287964004499;5696.743646535895;5699.914501282484;5580.441955804427;5655.1517272409055;5656.802011929583;5669.8582535436735;5675.091985282355;5397.379301380352;5629.521490673298;5633.436656334375;5641.746121424525;5642.322921249435;5518.944810551903;5603.439656034364;5604.299462567159;5612.859678508029;5625.268715067056;4997.150484417622;5081.441041485434;5081.923771143436;5088.872778180576;5269.762860671279;13404.262765547892;13633.182009079486;13675.589732308046;13740.244286564235;13756.518521851687;2307.1348244408346;2383.142068855228;2383.988080059589;2829.3633932365055;2832.5326321156986;9736.977617350147;9845.163161131313;9946.701598952042;10081.294309398345;10482.842757358645;1797.63148554546;1849.4636555398918;1916.6166766646586;1925.4512463947708;1925.643755905162;79055;82284;82506.17493825105;82571.58714206451;82614;8761.255293300013;9051.81896362069;9293.767655808659;10742.78514429707;10897.29167604119;12670;12700.491980320683;12726.809097863354;12753.553625623059;12757;7261.552469838383;7362.7423040193335;7363.77908662741;7383.520071195355;7537.2085930977555;7336.37640800538;7393.741219057307;7603.505772124794;7635.923640763633;7689;3884.4173373994126;3943.3099207638547;3959.5644479107277;4087.959120408758;4089.8568550100604;1834.5413646588354;1872.5786697992842;1897.6679081160742;1907.8759880607715;1948.5031317014354;890.5591732092655;945.135201290825;947.3842002698301;955.6655170690203;1018.1803648063232;18029.18868650914;19492.220311187393;19573.804261957484;19579;19584.902075489816;947.1475671895212;969.9321047526746;989.8416253399422;990.9009099090033;1049.2445439283704;7962.562059086806;10906.563737450413;10918.727031824268;10920.453977301104;10942.890571094347;465744;466549;466663;469844;484729;89995.55002224947;92272.53863730638;92392.53803731073;93909.5304523473;94190.52904735433;920.9815803683889;944.1832814615308;957.2581249531669;960.2893858544627;962.9470379129075;16220.432284869972;16455.341786328412;17298.97267978124;17317.393891213746;17614.295428183243;40006.799965999984;40023;41098;41268.587314126475;41708.58291417168;50402;50738.74630626823;56911.146332804215;57554.42445575491;57984.4201557979;7945.523268603903;8332.583370831555;8391;8580.442271252348;8656.567171641518;12906.741865162456;13254.602361929157;13352.265625390308;13812.654683632587;13995.370208340853;11266.211365204357;11299.774004519699;11357.148213883827;11488.712782180512;12204.32876191818;11423;11468.369239691898;11531;11645.359505226956;11721.589744358907;10261.897381026392;10461.581536738446;10649.361038337725;10776.407297598707;10811.35131892089;8169.346452283684;8354.679409400174;8501.829963400822;8527;8774.561271936505;10151.390916544735;10631.681049568526;11357.545698172311;11490;11736.589219377282 13:56:30 INFO - PROCESS | 11770 | |3;mootools.html;1319.182107093602;1452.2085463422434;1486.8067151270334;1601.4154833485782;1753;7432;8071.112177660452;8364.790880227998;8369.623366948494;8545.529995850226;8341.749747507569;8423.326133909288;8425.199606037417;8426.452280601756;8426.662933482654;2268.115434980355;2292.403974966504;2293;2294.242899843056;2295.5638428698576;2238.7201599800023;2289.2331069091792;2329.988350058256;2336.6027775278158;2341.531693661266;2221.6334304839684;2232.497688020199;2255.391044418006;2299.528596637685;2308.4690521180137;2182.8690278583335;2203.6143674856835;2228.19784877444;2231.8995645196005;2232.810211132056;2209.0501084533644;2266.218154736613;2272.829537784656;2273.943151421211;2279.669447930041;8257.83484330316;8460.83078338436;8559.27246184075;8567.95716021422;8592.398532102756;4872.317875497433;4998.4751601081725;4998.57512111471;5014.34813474246;5095.949040509585;3253.9511907321407;3345.3142105868237;3363.394588973984;3416.9658303416895;3430.9142271443166;1082.6697857153565;1082.8592283003238;1096.2490693874722;1115.4757264085868;1136.7612801311734;11718.472668729843;11722.296662200295;11789.410529473493;11792.815939696235;11840.526378944833;4092.324766413568;4456.242438785414;4466.196084704784;4497.707649002804;4512.210363186495;8984.146506081912;8991.100889910957;8998.01021887592;9000.189982901571;9001.144891235323;5134.127198376285;5134.666246693953;5137.434882162959;5138.820141295037;5140.511651393112;4255.319148936217;4400.9119817604105;4720.150372932836;4807.927881081787;4837.32277481153;3428.194374322032;3534.717222622184;3575.392183328788;3601.513795637608;3627.9455808162897;1101.911847052234;1114.2367478277406;1121.3384103379046;1152.9654110376703;1158.9710257243637;935.3172184305495;941.1905761045496;942.9575669094908;943.528235882059;952.4904176265665;5538.196961440569;5590.440955904377;5752.079667253303;5785.913211301834;6012.549058820518;911.5943405184762;912.7809325761903;929.4562680831654;962.3936919740519;1005.9748506287401;3665.6151104134215;3820.312343778091;3861.2470568239487;3889.9416508752392;4138.0689344897155;10139.2902496826;10601.098906592872;10663.253572250023;10672.359658420519;10706.357618542912;10137.898621013843;10293.3823970562;10466.947665261778;10481.842772358421;10486.895131048745;7447.553146811317;7894.368450523944;8066.596670166468;8079.757607271791;8080.191980801873;5539.8892022160135;5541.750621221974;5665.12190610456;5692.914606280826;5769.336526299529;9698;9708.951455242679;9731.513424328614;9803.656872009446;9862.704118876445;8895.110488951053;9252.907470925475;9275.814483710423;9470.479123648265;9507.239420846454;7118.288171183048;7299.4160467163565;7750.147483776667;7872.330851877426;8034.517928924283;7968.163342848918;8259.83480330378;8262.83474330498;8264.545450000307;8268.958655206685;7304.744333948286;7375.373093286916;7420.740274090597;7506.747975607187;7664.80837979055;7110.253423390676;7178.712851485882;7179.425645948416;7225.169105552929;7300.196978332273;6351.618902865843;6456;6504.60972341661;6590.308017658077;6597.175353080865;4715.406526410529;4823.252395878644;4864.197407427876;4927.9507204927495;4967.925481117858;5067.493250674903;5103.591712662904;5133.460986596503;5195.68825870449;5301.4168441472175 13:56:30 INFO - PROCESS | 11770 | |4;prototype.html;315.64805242155006;330.04781206220065;330.14492464516894;332.92133487500496;338.9610194827596;5053.519915608012;5168.664036837612;5235.50262725041;5252.947470525293;5281.339832520935;5022.34709487767;5109.6678715883445;5137.845864624058;5157.3295471588735;5159.948400515994;4060.4924384451942;4092.3247664135383;4105.548389677148;4110.486189226347;4129.979350103245;3784.6593806557403;3918.314294998364;4136.710430269883;4143.197708996596;4181.477315335583;3980.7412518186225;4042.9071760103543;4061.8375264989363;4081.9183616327655;4106.753594784308;4065.8373665053364;4068.7558746475306;4071.918561628751;4081.551029386765;4104.774237416941;3621.9456708149137;3622.8188590570367;3627.5102861113673;3635.3456377851976;3643.2895585360866;4952.430470495867;5033.446320904734;5061.670991385585;5067.239914012891;5072.619553533463;4604.355390245369;4635.5364463553715;4667.463241727177;4675.438947326308;4692.577668009862;5335.466453354672;5378.3596003219;5380.757865896005;5399.460053994609;5409.810656626999;3695.7782533048103;3857.961420385788;3861.227754449121;3873;3900.2199560088097;5574.721263936827;5583.609147359686;5587.245721827542;5609.298837645294;5609.467100625434;3964.365701487806;3975.344068228768;3978.542467616261;4044.5550989391145;4062.0048088217986;3987.860424885115;4027.8791636250958;4029.133736246721;4051.756894586334;4085.775282359439;4617.676762626584;4618.35343051973;4619.360127154811;4624.514425985223;4630.536946305342;5439.755211015514;5441;5448.645838020516;5449.773800894767;5451.781928722886;1234.160770675931;1261.9777979836363;1350.7298540291783;1366.7266546690503;1371.3760239091189;846.2341580869323;876.513534988075;882.5763633455849;887.5650931043871;897.9359459041058;4557.701055199319;4567.474740404829;4603.562661547147;4629.652776041743;4637.09878949629;4792.496787837227;4793.376861008047;4805.231163013901;4805.951940480621;4815.446223684251;4590.495045545054;4592.265237561974;4594.33382159585;4633.930491042637;4651.279051746985;2421.69728783902;2558.411565339982;2566.4610431809156;2573.6139579062915;2580.9354766130996;4917.082337888227;4950.42577859511;4956.224514272019;4990.852104016024;5013.523715247045;4861.392325959255;4870.707757534559;4880.682755620874;4887.608991280689;4905.950940490621;5358.97320513395;5774.364819869811;5779.653220806765;5783.306003279633;5790.392008839011;5604.607677462538;5606.85982850432;5615.606907516598;5623.943760562505;5641.5204707600315;5440.809571664972;5494.131995121677;5507.586930980273;5567.3040869891265;5589.972050139723;5736.512396446349;5747.137929310469;5747.597668163188;5751.252337196138;5761.423857614205;3999.5600483947323;4001.8999525010945;4008.1382502762044;4008.579099194659;4035.233305671913;5282.841514754564;5309.256704061358;5570.387257401601;5608.523275521463;5617.522510586646;5287.656302340336;5328.6944698549105;5487.451254874481;5495.2856128703015;5508.283923089973;5430.972845135749;5476.561875049907;5481.328194900434;5484.561235101262;5488.862778430571;5253.50091741284;5350.384705758887;5361.5710743141235;5413.918791218056;5433.56531477473;5437.673739575638;5448.155535891943;5470.699111548903;5471.562275018068;5478.863028424162;5349.491798279158;5364.049772625119;5366.865828354323;5372.838814835562;5379.73101344939 13:56:30 INFO - PROCESS | 11770 | |5;yui.html;640.2349192714707;670.4643089499533;699.5522865366163;710.9111361079865;712.6009434716558;13819.239941803196;14717.264136793157;14726.263686815642;15466.767998480003;16057.277422516016;13938.860611393882;14056.437742490314;14163.858361416384;14191.929040354784;14238.71522569548;799.6361655446786;825.4387016828554;826.6858593734372;827.9006519217702;827.9296259817922;670.2091531992247;686.6806934775328;788.0740130346849;810.8824220488026;815.5188438821094;863.6804382378529;867.4448353054019;867.9305655547541;868.6699054359335;868.8827008353854;862.7627402464373;863.2877875752466;864.2222000199807;864.2783275964578;864.8010957479784;508.47118996243864;517.9974100129513;605.9970748411387;621.3879328861068;628.9811305660837;13755.518556850562;13825.824804891596;13885.4445822167;13906.652333691638;13908.652283692887;12931.288779117145;13053.54312599064;13418.530351437652;13448;13563.186208827501;11955.64133076009;12004.279743215435;12029.819552706716;12120.515179392814;12254.399665734807;3726.06848287928;3751.756135851161;3832.597577254404;3990.940135897964;4357.716748411375;48133.75933120347;48221.27668084981;50255.74872125616;66287;66674.66662666704;10981.890181098246;11018.669439916655;11046.281991670516;11256.662300131009;11349.943250283695;19981.700274495895;20146.59706805885;20151.093200805706;20330.79669203289;20339.491512712302;7947.602619868983;7998.320142787812;8003.959980200062;8372.623231954576;8392.076871544125;4438.467383913951;4618.584327410549;4651.86044418668;4729.07782982322;4862.78117484714;3184.2039490127468;3254.8698052077652;3256.9674303256666;3298.5876765404323;3309.50357446385;576.1242910775682;580.5181699189662;580.5587753307432;606.2088973889117;611.9510439164856;580.4195804195804;633.3444884544566;693.0366790161679;729.1396152539947;730.5580124024889;8438.451500652438;8711.869321960176;9439.292053096045;9659.812261953539;10242.692719218436;608.333874407523;648.2350826025241;719.0688058963655;734.6326836581709;755.2070326157512;4204.306289462204;4555.362249285103;4708.199606066977;4799.616030717534;4810.807567697323;50493.24260136101;50614.49385506098;80392.59803701061;82943.17056829475;86416.56791716;44672.10655786866;57626.423735762946;70672;71501;74063;64100.67949660222;64926;65316;65902;67185.66407167933;8355.373346998878;8759;8777.385583009383;8815.691450799191;8891.78786777339;32443.513347300282;43216;43686.781566091966;43884.561154388044;43991.78004109959;35281;53467.73266133644;59743.40256597378;60548.39451605604;61187.69406152941;11511.597094101666;11563.942180289045;11637.825432618349;11707.473163707824;11845.170838041255;12543.24740515572;12761.425735842095;12775.433544729223;13564.321783910567;13628.386722597308;11430.25703329281;11470.090574300986;11675.241109327866;11857.525698971944;12106.636800895987;11223.270487418291;11233.49449274801;11238.157138214503;11304.604338848101;12240.755184896074;10932.234743567873;10967.945160274148;11403.258788178742;11424.314541127558;11492.425378731197;10179.847302290324;10191.898081019392;10509.579616815241;10617.628383006559;10828.350298982086;9600.519974001412;10399.4099060035;10490.265681402228;10564.630237941943;10621.628243011457 13:56:30 INFO - PROCESS | 11770 | __end_tp_report 13:56:30 INFO - PROCESS | 11770 | __start_cc_report 13:56:30 INFO - PROCESS | 11770 | _x_x_mozilla_cycle_collect,1090 13:56:30 INFO - PROCESS | 11770 | __end_cc_report 13:56:30 INFO - PROCESS | 11770 | __startTimestamp1477947390975__endTimestamp 13:56:30 INFO - PROCESS | 11770 | 13:56:30 INFO - PROCESS | 11770 | ------- Summary: start ------- 13:56:30 INFO - PROCESS | 11770 | Number of tests: 6 13:56:30 INFO - PROCESS | 11770 | 13:56:30 INFO - PROCESS | 11770 | [#0] dojo.html Cycles:165 Average:5311.29 Median:5540.72 stddev:607.89 (11.0%) stddev-sans-first:582.70 13:56:30 INFO - PROCESS | 11770 | Values: 3025.4 3064.0 3087.1 3099.8 3106.8 5226.2 5296.6 5301.7 5371.1 5390.9 5328.1 5338.9 5354.7 5355.4 5366.8 4812.8 4835.8 4846.7 4891.4 4904.7 4837.9 4849.2 4871.5 4884.6 4885.3 4878.1 4882.0 4896.3 4926.7 4927.2 4972.8 4975.9 4990.3 4991.1 5041.4 4701.0 4730.2 4730.6 4891.9 4892.6 5191.7 5245.8 5270.2 5278.6 5308.2 5623.2 5664.6 5733.8 5735.2 5738.1 5535.3 5766.8 5770.8 5775.4 5782.2 5264.1 5350.3 5391.5 5397.6 5402.8 5842.5 5874.5 5877.6 5877.9 5882.0 5507.8 5643.8 5651.1 5653.2 5660.1 5617.8 5633.8 5655.0 5710.7 5717.8 5724.4 5726.7 5744.4 5746.9 5774.3 5757.3 5760.5 5763.7 5764.7 5811.0 4235.6 4290.7 4310.4 4311.4 4377.9 3851.0 3857.4 3871.9 3906.3 3925.8 5330.5 5333.6 5339.5 5340.3 5341.3 5540.7 5583.4 5630.0 5638.6 5646.3 5388.5 5453.5 5479.9 5494.7 5556.3 4996.8 5011.0 5011.0 5012.1 5070.7 5692.5 5928.1 5959.5 5964.1 5966.5 5609.6 5731.0 5778.3 5784.9 5868.5 5916.6 5962.2 5971.9 5977.4 5977.9 5680.3 5684.1 5685.1 5693.4 5693.6 5504.7 5546.8 5625.3 5661.2 5685.2 5583.1 5590.0 5591.6 5593.0 5656.2 5514.0 5550.5 5556.7 5562.5 5566.5 5362.1 5399.5 5509.7 5549.3 5572.0 5654.9 5699.7 5704.4 5753.4 5765.6 5253.4 5570.9 5581.1 5583.7 5585.6 13:56:30 INFO - PROCESS | 11770 | 13:56:30 INFO - PROCESS | 11770 | [#1] ext.html Cycles:180 Average:56510.84 Median:38986.42 stddev:107024.60 (274.5%) stddev-sans-first:107242.40 13:56:30 INFO - PROCESS | 11770 | Values: 562.1 582.0 584.6 598.0 604.6 33439.0 34003.5 34120.1 34129.3 34148.0 43105.6 43956.0 44029.6 47098.8 47113.5 8683.4 8908.2 8915.3 8917.3 8921.2 8150.6 8342.1 8748.7 8829.6 10355.6 10386.4 10447.2 10454.7 10460.6 10481.5 10731.9 10822.1 10832.4 10833.3 10837.3 10541.9 10595.6 10609.4 10613.6 10616.7 41794.0 42097.4 42140.0 42154.4 42222.8 3347.1 3411.1 3465.3 3505.8 3629.2 30311.7 31304.0 31337.7 31374.0 31652.5 4203.7 4209.3 4289.4 4296.3 4341.8 310971.0 311259.4 312020.0 312493.6 312592.0 55926.2 56347.4 56569.7 56626.7 56668.0 59641.7 59726.0 59752.4 59761.4 59787.1 15858.8 16060.4 16084.6 16087.8 16094.9 12259.9 12317.3 12318.0 12324.3 12327.5 14571.2 14650.9 16212.3 16492.5 16598.2 4830.1 5935.0 5960.0 5975.4 6027.4 968.2 986.2 999.8 1007.4 1026.3 30424.8 30933.2 31072.0 32183.4 32294.8 1013.4 1078.6 1092.7 1131.8 1137.9 15630.5 16374.3 16653.6 16655.7 16664.7 445252.0 446855.0 448739.0 449207.0 450376.0 53788.7 54312.7 54626.5 55247.7 56973.4 1345.1 1352.8 1354.5 1355.5 1360.5 30122.3 32360.4 32420.4 32611.0 33086.5 49440.8 49836.5 49868.0 49948.5 50047.0 439415.0 440282.0 441784.0 442019.3 442934.0 39024.6 39362.2 40215.0 40367.0 40415.2 45599.5 46755.3 47641.3 47923.3 48313.5 38012.8 39833.6 39876.2 40355.6 40652.2 38444.8 38948.2 40154.6 40226.6 40795.8 39227.6 39290.6 39682.0 39816.6 40832.2 32674.7 35494.3 35640.8 36035.0 36123.8 26793.3 27106.7 27277.7 27492.5 27566.1 13:56:30 INFO - PROCESS | 11770 | 13:56:30 INFO - PROCESS | 11770 | [#2] jquery.html Cycles:180 Average:27782.27 Median:22593.93 stddev:77826.56 (344.5%) stddev-sans-first:78017.67 13:56:30 INFO - PROCESS | 11770 | Values: 372.5 397.3 403.7 406.4 420.1 13464.0 18464.9 18585.7 18664.0 18827.6 17781.8 18062.5 18295.5 18303.2 18329.5 5429.6 5469.1 5696.3 5696.7 5699.9 5580.4 5655.2 5656.8 5669.9 5675.1 5397.4 5629.5 5633.4 5641.7 5642.3 5518.9 5603.4 5604.3 5612.9 5625.3 4997.2 5081.4 5081.9 5088.9 5269.8 13404.3 13633.2 13675.6 13740.2 13756.5 2307.1 2383.1 2384.0 2829.4 2832.5 9737.0 9845.2 9946.7 10081.3 10482.8 1797.6 1849.5 1916.6 1925.5 1925.6 79055.0 82284.0 82506.2 82571.6 82614.0 8761.3 9051.8 9293.8 10742.8 10897.3 12670.0 12700.5 12726.8 12753.6 12757.0 7261.6 7362.7 7363.8 7383.5 7537.2 7336.4 7393.7 7603.5 7635.9 7689.0 3884.4 3943.3 3959.6 4088.0 4089.9 1834.5 1872.6 1897.7 1907.9 1948.5 890.6 945.1 947.4 955.7 1018.2 18029.2 19492.2 19573.8 19579.0 19584.9 947.1 969.9 989.8 990.9 1049.2 7962.6 10906.6 10918.7 10920.5 10942.9 465744.0 466549.0 466663.0 469844.0 484729.0 89995.6 92272.5 92392.5 93909.5 94190.5 921.0 944.2 957.3 960.3 962.9 16220.4 16455.3 17299.0 17317.4 17614.3 40006.8 40023.0 41098.0 41268.6 41708.6 50402.0 50738.7 56911.1 57554.4 57984.4 7945.5 8332.6 8391.0 8580.4 8656.6 12906.7 13254.6 13352.3 13812.7 13995.4 11266.2 11299.8 11357.1 11488.7 12204.3 11423.0 11468.4 11531.0 11645.4 11721.6 10261.9 10461.6 10649.4 10776.4 10811.4 8169.3 8354.7 8501.8 8527.0 8774.6 10151.4 10631.7 11357.5 11490.0 11736.6 13:56:30 INFO - PROCESS | 11770 | 13:56:30 INFO - PROCESS | 11770 | [#3] mootools.html Cycles:180 Average:5527.43 Median:5081.72 stddev:3107.89 (61.2%) stddev-sans-first:3100.51 13:56:30 INFO - PROCESS | 11770 | Values: 1319.2 1452.2 1486.8 1601.4 1753.0 7432.0 8071.1 8364.8 8369.6 8545.5 8341.7 8423.3 8425.2 8426.5 8426.7 2268.1 2292.4 2293.0 2294.2 2295.6 2238.7 2289.2 2330.0 2336.6 2341.5 2221.6 2232.5 2255.4 2299.5 2308.5 2182.9 2203.6 2228.2 2231.9 2232.8 2209.1 2266.2 2272.8 2273.9 2279.7 8257.8 8460.8 8559.3 8568.0 8592.4 4872.3 4998.5 4998.6 5014.3 5095.9 3254.0 3345.3 3363.4 3417.0 3430.9 1082.7 1082.9 1096.2 1115.5 1136.8 11718.5 11722.3 11789.4 11792.8 11840.5 4092.3 4456.2 4466.2 4497.7 4512.2 8984.1 8991.1 8998.0 9000.2 9001.1 5134.1 5134.7 5137.4 5138.8 5140.5 4255.3 4400.9 4720.2 4807.9 4837.3 3428.2 3534.7 3575.4 3601.5 3627.9 1101.9 1114.2 1121.3 1153.0 1159.0 935.3 941.2 943.0 943.5 952.5 5538.2 5590.4 5752.1 5785.9 6012.5 911.6 912.8 929.5 962.4 1006.0 3665.6 3820.3 3861.2 3889.9 4138.1 10139.3 10601.1 10663.3 10672.4 10706.4 10137.9 10293.4 10466.9 10481.8 10486.9 7447.6 7894.4 8066.6 8079.8 8080.2 5539.9 5541.8 5665.1 5692.9 5769.3 9698.0 9709.0 9731.5 9803.7 9862.7 8895.1 9252.9 9275.8 9470.5 9507.2 7118.3 7299.4 7750.1 7872.3 8034.5 7968.2 8259.8 8262.8 8264.5 8269.0 7304.7 7375.4 7420.7 7506.7 7664.8 7110.3 7178.7 7179.4 7225.2 7300.2 6351.6 6456.0 6504.6 6590.3 6597.2 4715.4 4823.3 4864.2 4928.0 4967.9 5067.5 5103.6 5133.5 5195.7 5301.4 13:56:30 INFO - PROCESS | 11770 | 13:56:30 INFO - PROCESS | 11770 | [#4] prototype.html Cycles:180 Average:4469.69 Median:4933.75 stddev:1318.29 (26.7%) stddev-sans-first:1284.59 13:56:30 INFO - PROCESS | 11770 | Values: 315.6 330.0 330.1 332.9 339.0 5053.5 5168.7 5235.5 5252.9 5281.3 5022.3 5109.7 5137.8 5157.3 5159.9 4060.5 4092.3 4105.5 4110.5 4130.0 3784.7 3918.3 4136.7 4143.2 4181.5 3980.7 4042.9 4061.8 4081.9 4106.8 4065.8 4068.8 4071.9 4081.6 4104.8 3621.9 3622.8 3627.5 3635.3 3643.3 4952.4 5033.4 5061.7 5067.2 5072.6 4604.4 4635.5 4667.5 4675.4 4692.6 5335.5 5378.4 5380.8 5399.5 5409.8 3695.8 3858.0 3861.2 3873.0 3900.2 5574.7 5583.6 5587.2 5609.3 5609.5 3964.4 3975.3 3978.5 4044.6 4062.0 3987.9 4027.9 4029.1 4051.8 4085.8 4617.7 4618.4 4619.4 4624.5 4630.5 5439.8 5441.0 5448.6 5449.8 5451.8 1234.2 1262.0 1350.7 1366.7 1371.4 846.2 876.5 882.6 887.6 897.9 4557.7 4567.5 4603.6 4629.7 4637.1 4792.5 4793.4 4805.2 4806.0 4815.4 4590.5 4592.3 4594.3 4633.9 4651.3 2421.7 2558.4 2566.5 2573.6 2580.9 4917.1 4950.4 4956.2 4990.9 5013.5 4861.4 4870.7 4880.7 4887.6 4906.0 5359.0 5774.4 5779.7 5783.3 5790.4 5604.6 5606.9 5615.6 5623.9 5641.5 5440.8 5494.1 5507.6 5567.3 5590.0 5736.5 5747.1 5747.6 5751.3 5761.4 3999.6 4001.9 4008.1 4008.6 4035.2 5282.8 5309.3 5570.4 5608.5 5617.5 5287.7 5328.7 5487.5 5495.3 5508.3 5431.0 5476.6 5481.3 5484.6 5488.9 5253.5 5350.4 5361.6 5413.9 5433.6 5437.7 5448.2 5470.7 5471.6 5478.9 5349.5 5364.0 5366.9 5372.8 5379.7 13:56:30 INFO - PROCESS | 11770 | 13:56:30 INFO - PROCESS | 11770 | [#5] yui.html Cycles:180 Average:16095.66 Median:4635.22 stddev:20452.77 (441.2%) stddev-sans-first:20477.22 13:56:30 INFO - PROCESS | 11770 | Values: 640.2 670.5 699.6 710.9 712.6 13819.2 14717.3 14726.3 15466.8 16057.3 13938.9 14056.4 14163.9 14191.9 14238.7 799.6 825.4 826.7 827.9 827.9 670.2 686.7 788.1 810.9 815.5 863.7 867.4 867.9 868.7 868.9 862.8 863.3 864.2 864.3 864.8 508.5 518.0 606.0 621.4 629.0 13755.5 13825.8 13885.4 13906.7 13908.7 12931.3 13053.5 13418.5 13448.0 13563.2 11955.6 12004.3 12029.8 12120.5 12254.4 3726.1 3751.8 3832.6 3990.9 4357.7 48133.8 48221.3 50255.7 66287.0 66674.7 10981.9 11018.7 11046.3 11256.7 11349.9 19981.7 20146.6 20151.1 20330.8 20339.5 7947.6 7998.3 8004.0 8372.6 8392.1 4438.5 4618.6 4651.9 4729.1 4862.8 3184.2 3254.9 3257.0 3298.6 3309.5 576.1 580.5 580.6 606.2 612.0 580.4 633.3 693.0 729.1 730.6 8438.5 8711.9 9439.3 9659.8 10242.7 608.3 648.2 719.1 734.6 755.2 4204.3 4555.4 4708.2 4799.6 4810.8 50493.2 50614.5 80392.6 82943.2 86416.6 44672.1 57626.4 70672.0 71501.0 74063.0 64100.7 64926.0 65316.0 65902.0 67185.7 8355.4 8759.0 8777.4 8815.7 8891.8 32443.5 43216.0 43686.8 43884.6 43991.8 35281.0 53467.7 59743.4 60548.4 61187.7 11511.6 11563.9 11637.8 11707.5 11845.2 12543.2 12761.4 12775.4 13564.3 13628.4 11430.3 11470.1 11675.2 11857.5 12106.6 11223.3 11233.5 11238.2 11304.6 12240.8 10932.2 10967.9 11403.3 11424.3 11492.4 10179.8 10191.9 10509.6 10617.6 10828.4 9600.5 10399.4 10490.3 10564.6 10621.6 13:56:30 INFO - PROCESS | 11770 | -------- Summary: end -------- 13:56:30 INFO - PROCESS | 11770 | 13:56:31 INFO - TEST-INFO | 11770: exit 0 13:56:31 INFO - TEST-OK | dromaeo_css | took 1118116ms 13:56:31 INFO - TEST-START | kraken 13:56:31 INFO - operating with platform_type : linux_ 13:56:31 INFO - Initialising browser for kraken test... 13:56:31 INFO - TEST-INFO | started process 12080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTNl_YP/profile http://localhost:36700/getInfo.html) 13:56:35 INFO - PROCESS | 12080 | __metrics Screen width/height:1600/1200 13:56:35 INFO - PROCESS | 12080 | colorDepth:24 13:56:35 INFO - PROCESS | 12080 | Browser inner width/height: 1024/697 13:56:35 INFO - PROCESS | 12080 | __metrics 13:56:36 INFO - PROCESS | 12080 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:56:36 INFO - PROCESS | 12080 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:56:37 INFO - PROCESS | 12080 | console.error: PushService: 13:56:37 INFO - PROCESS | 12080 | stateChangeProcessEnqueue: Error transitioning state 13:56:37 INFO - PROCESS | 12080 | UnknownError 13:56:37 INFO - TEST-INFO | 12080: exit 0 13:56:37 INFO - Browser initialized. 13:56:37 INFO - Running cycle 1/1 for kraken test... 13:56:37 INFO - TEST-INFO | started process 12163 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTNl_YP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:56:49 INFO - PROCESS | 12163 | RSS: Main: 175337472 13:56:49 INFO - PROCESS | 12163 | 13:56:52 INFO - PROCESS | 12163 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36700/tests/kraken/driver.html?testName=audio-beat-detection) 13:56:53 INFO - PROCESS | 12163 | RSS: Main: 231374848 13:56:53 INFO - PROCESS | 12163 | 13:56:56 INFO - PROCESS | 12163 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36700/tests/kraken/driver.html?testName=audio-dft) 13:56:56 INFO - PROCESS | 12163 | RSS: Main: 218923008 13:56:56 INFO - PROCESS | 12163 | 13:56:59 INFO - PROCESS | 12163 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36700/tests/kraken/driver.html?testName=audio-fft) 13:57:00 INFO - PROCESS | 12163 | RSS: Main: 300462080 13:57:00 INFO - PROCESS | 12163 | 13:57:02 INFO - PROCESS | 12163 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36700/tests/kraken/driver.html?testName=audio-oscillator) 13:57:03 INFO - PROCESS | 12163 | RSS: Main: 211300352 13:57:03 INFO - PROCESS | 12163 | 13:57:05 INFO - PROCESS | 12163 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36700/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:57:05 INFO - PROCESS | 12163 | RSS: Main: 214360064 13:57:05 INFO - PROCESS | 12163 | 13:57:08 INFO - PROCESS | 12163 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36700/tests/kraken/driver.html?testName=imaging-darkroom) 13:57:09 INFO - PROCESS | 12163 | RSS: Main: 250826752 13:57:09 INFO - PROCESS | 12163 | 13:57:12 INFO - PROCESS | 12163 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36700/tests/kraken/driver.html?testName=imaging-desaturate) 13:57:13 INFO - PROCESS | 12163 | RSS: Main: 249372672 13:57:13 INFO - PROCESS | 12163 | 13:57:15 INFO - PROCESS | 12163 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36700/tests/kraken/driver.html?testName=json-parse-financial) 13:57:16 INFO - PROCESS | 12163 | RSS: Main: 248909824 13:57:16 INFO - PROCESS | 12163 | 13:57:18 INFO - PROCESS | 12163 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36700/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:57:18 INFO - PROCESS | 12163 | RSS: Main: 211390464 13:57:18 INFO - PROCESS | 12163 | 13:57:20 INFO - PROCESS | 12163 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36700/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:57:21 INFO - PROCESS | 12163 | RSS: Main: 218726400 13:57:21 INFO - PROCESS | 12163 | 13:57:23 INFO - PROCESS | 12163 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36700/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:57:23 INFO - PROCESS | 12163 | RSS: Main: 228569088 13:57:23 INFO - PROCESS | 12163 | 13:57:26 INFO - PROCESS | 12163 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36700/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:57:27 INFO - PROCESS | 12163 | RSS: Main: 237686784 13:57:27 INFO - PROCESS | 12163 | 13:57:29 INFO - PROCESS | 12163 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36700/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:57:30 INFO - PROCESS | 12163 | RSS: Main: 234164224 13:57:30 INFO - PROCESS | 12163 | 13:57:32 INFO - PROCESS | 12163 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36700/tests/kraken/driver.html?testName=ai-astar) 13:57:32 INFO - PROCESS | 12163 | RSS: Main: 285437952 13:57:32 INFO - PROCESS | 12163 | 13:57:32 INFO - PROCESS | 12163 | __start_tp_report 13:57:32 INFO - PROCESS | 12163 | _x_x_mozilla_page_load 13:57:32 INFO - PROCESS | 12163 | _x_x_mozilla_page_load_details 13:57:32 INFO - PROCESS | 12163 | |i|pagename|runs| 13:57:32 INFO - PROCESS | 12163 | |0;ai-astar;104;112;111;110;111;110;110;109;112;110 13:57:32 INFO - PROCESS | 12163 | |1;audio-beat-detection;150;124;123;163;135;122;125;122;164;124 13:57:32 INFO - PROCESS | 12163 | |2;audio-dft;162;160;160;161;163;161;161;163;162;161 13:57:32 INFO - PROCESS | 12163 | |3;audio-fft;74;76;76;108;76;76;76;75;102;76 13:57:32 INFO - PROCESS | 12163 | |4;audio-oscillator;82;82;124;82;82;82;102;82;83;114 13:57:32 INFO - PROCESS | 12163 | |5;imaging-gaussian-blur;117;118;117;118;117;117;117;118;117;117 13:57:32 INFO - PROCESS | 12163 | |6;imaging-darkroom;146;145;146;146;145;147;146;145;146;146 13:57:32 INFO - PROCESS | 12163 | |7;imaging-desaturate;85;85;84;84;85;85;86;85;86;86 13:57:32 INFO - PROCESS | 12163 | |8;json-parse-financial;54;53;53;52;52;53;53;53;64;53 13:57:32 INFO - PROCESS | 12163 | |9;json-stringify-tinderbox;60;61;61;61;61;60;60;62;61;61 13:57:32 INFO - PROCESS | 12163 | |10;stanford-crypto-aes;80;80;80;80;80;81;86;86;88;83 13:57:32 INFO - PROCESS | 12163 | |11;stanford-crypto-ccm;143;147;136;133;129;131;130;135;171;152 13:57:32 INFO - PROCESS | 12163 | |12;stanford-crypto-pbkdf2;170;165;165;166;171;168;165;170;164;169 13:57:32 INFO - PROCESS | 12163 | |13;stanford-crypto-sha256-iterative;63;63;64;65;64;64;65;63;63;63 13:57:32 INFO - PROCESS | 12163 | __end_tp_report 13:57:32 INFO - PROCESS | 12163 | __start_cc_report 13:57:32 INFO - PROCESS | 12163 | _x_x_mozilla_cycle_collect,1725 13:57:32 INFO - PROCESS | 12163 | __end_cc_report 13:57:32 INFO - PROCESS | 12163 | __startTimestamp1477947452447__endTimestamp 13:57:32 INFO - PROCESS | 12163 | 13:57:32 INFO - PROCESS | 12163 | ------- Summary: start ------- 13:57:32 INFO - PROCESS | 12163 | Number of tests: 14 13:57:32 INFO - PROCESS | 12163 | 13:57:32 INFO - PROCESS | 12163 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:2.28 (2.1%) stddev-sans-first:1.01 13:57:32 INFO - PROCESS | 12163 | Values: 104.0 112.0 111.0 110.0 111.0 110.0 110.0 109.0 112.0 110.0 13:57:32 INFO - PROCESS | 12163 | 13:57:32 INFO - PROCESS | 12163 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:130.00 stddev:17.24 (13.3%) stddev-sans-first:17.43 13:57:32 INFO - PROCESS | 12163 | Values: 150.0 124.0 123.0 163.0 135.0 122.0 125.0 122.0 164.0 124.0 13:57:32 INFO - PROCESS | 12163 | 13:57:32 INFO - PROCESS | 12163 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 13:57:32 INFO - PROCESS | 12163 | Values: 162.0 160.0 160.0 161.0 163.0 161.0 161.0 163.0 162.0 161.0 13:57:32 INFO - PROCESS | 12163 | 13:57:32 INFO - PROCESS | 12163 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:12.48 (16.4%) stddev-sans-first:12.94 13:57:32 INFO - PROCESS | 12163 | Values: 74.0 76.0 76.0 108.0 76.0 76.0 76.0 75.0 102.0 76.0 13:57:32 INFO - PROCESS | 12163 | 13:57:32 INFO - PROCESS | 12163 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:82.00 stddev:15.94 (19.4%) stddev-sans-first:16.53 13:57:32 INFO - PROCESS | 12163 | Values: 82.0 82.0 124.0 82.0 82.0 82.0 102.0 82.0 83.0 114.0 13:57:32 INFO - PROCESS | 12163 | 13:57:32 INFO - PROCESS | 12163 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 13:57:32 INFO - PROCESS | 12163 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 13:57:32 INFO - PROCESS | 12163 | 13:57:32 INFO - PROCESS | 12163 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 13:57:32 INFO - PROCESS | 12163 | Values: 146.0 145.0 146.0 146.0 145.0 147.0 146.0 145.0 146.0 146.0 13:57:32 INFO - PROCESS | 12163 | 13:57:32 INFO - PROCESS | 12163 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 13:57:32 INFO - PROCESS | 12163 | Values: 85.0 85.0 84.0 84.0 85.0 85.0 86.0 85.0 86.0 86.0 13:57:32 INFO - PROCESS | 12163 | 13:57:32 INFO - PROCESS | 12163 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:53.00 stddev:3.56 (6.7%) stddev-sans-first:3.77 13:57:32 INFO - PROCESS | 12163 | Values: 54.0 53.0 53.0 52.0 52.0 53.0 53.0 53.0 64.0 53.0 13:57:32 INFO - PROCESS | 12163 | 13:57:32 INFO - PROCESS | 12163 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 13:57:32 INFO - PROCESS | 12163 | Values: 60.0 61.0 61.0 61.0 61.0 60.0 60.0 62.0 61.0 61.0 13:57:32 INFO - PROCESS | 12163 | 13:57:32 INFO - PROCESS | 12163 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:3.13 (3.8%) stddev-sans-first:3.20 13:57:32 INFO - PROCESS | 12163 | Values: 80.0 80.0 80.0 80.0 80.0 81.0 86.0 86.0 88.0 83.0 13:57:32 INFO - PROCESS | 12163 | 13:57:32 INFO - PROCESS | 12163 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:139.50 stddev:13.12 (9.4%) stddev-sans-first:13.89 13:57:32 INFO - PROCESS | 12163 | Values: 143.0 147.0 136.0 133.0 129.0 131.0 130.0 135.0 171.0 152.0 13:57:32 INFO - PROCESS | 12163 | 13:57:32 INFO - PROCESS | 12163 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:168.50 stddev:2.58 (1.5%) stddev-sans-first:2.55 13:57:32 INFO - PROCESS | 12163 | Values: 170.0 165.0 165.0 166.0 171.0 168.0 165.0 170.0 164.0 169.0 13:57:32 INFO - PROCESS | 12163 | 13:57:32 INFO - PROCESS | 12163 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 13:57:32 INFO - PROCESS | 12163 | Values: 63.0 63.0 64.0 65.0 64.0 64.0 65.0 63.0 63.0 63.0 13:57:32 INFO - PROCESS | 12163 | -------- Summary: end -------- 13:57:32 INFO - PROCESS | 12163 | 13:57:33 INFO - TEST-INFO | 12163: exit 0 13:57:33 INFO - TEST-OK | kraken | took 61833ms 13:57:33 INFO - SUITE-END | took 1179s 13:57:34 INFO - Completed test suite (00:19:40) 13:57:34 INFO - javascript benchmark 13:57:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3025.379797141586, 3064.0, 3087.1201707513364, 3099.845007749612, 3106.766992475565, 5226.163813789794, 5296.576273898088, 5301.7084060376665, 5371.140617501195, 5390.865228369288, 5328.067588172074, 5338.946610533893, 5354.732263386834, 5355.384130824957, 5366.838994830152, 4812.831550895719, 4835.830745923893, 4846.733429661367, 4891.4130304363525, 4904.730239836807, 4837.927431088537, 4849.199882019462, 4871.537203965618, 4884.5848102911295, 4885.291632713254, 4878.0731660984475, 4881.975590122062, 4896.290037944496, 4926.679765815228, 4927.236278376839, 4972.801087956477, 4975.925361119586, 4990.30135780991, 4991.076650819574, 5041.395032596112, 4700.952990470086, 4730.195866702668, 4730.550597693248, 4891.902161956777, 4892.559669629751, 5191.740412979374, 5245.816396426107, 5270.235815806686, 5278.551323137538, 5308.203769434577, 5623.156526521014, 5664.631798933097, 5733.82798516041, 5735.225744524478, 5738.110592858114, 5535.308086489189, 5766.769329226826, 5770.826875193751, 5775.422457754233, 5782.190493330937, 5264.131418315973, 5350.250964864961, 5391.514763671288, 5397.595180361489, 5402.810901618424, 5842.532597392198, 5874.530037596982, 5877.617954832922, 5877.882442351129, 5881.9705901470215, 5507.752151153208, 5643.830685079454, 5651.124075768263, 5653.236813030188, 5660.066089095336, 5617.8033768817895, 5633.802816901389, 5655.0103731847585, 5710.71446427677, 5717.828465146053, 5724.398938111522, 5726.656400615976, 5744.396838331999, 5746.9425305747245, 5774.335951365562, 5757.337906140764, 5760.53915686744, 5763.740631671585, 5764.654120752768, 5811.012127938261, 4235.618794308465, 4290.699651024398, 4310.353446982977, 4311.417958575615, 4377.934330985037, 3851.017990412427, 3857.4406711026745, 3871.941920871133, 3906.2968665640456, 3925.7840818755244, 5330.546903513167, 5333.599980001438, 5339.546138578186, 5340.25236466895, 5341.278927344759, 5540.722963851791, 5583.3858275589655, 5630.042892708249, 5638.632061915942, 5646.265985421869, 5388.5419739321815, 5453.536449401845, 5479.863003424946, 5494.697791621419, 5556.277683901148, 4996.800127994912, 5011.022850544109, 5011.047900898818, 5012.097822392005, 5070.670406423571, 5692.516136128475, 5928.110783382527, 5959.4934430573885, 5964.075568286922, 5966.463018328198, 5609.635373700697, 5730.971345143247, 5778.27771528559, 5784.913226301524, 5868.501177399969, 5916.585838991229, 5962.16529685853, 5971.880562388815, 5977.432143946318, 5977.850553736017, 5680.318361796611, 5684.147377893349, 5685.118806584986, 5693.373728889902, 5693.572982026281, 5504.697241651587, 5546.833594992157, 5625.268715067015, 5661.150827375926, 5685.20407142992, 5583.106702927512, 5590.0, 5591.580631452576, 5593.0, 5656.208130861765, 5514.0, 5550.47270509301, 5556.694381809039, 5562.527185189142, 5566.526845218202, 5362.1420572708175, 5399.541039011728, 5509.696966666872, 5549.250851135045, 5572.024895643165, 5654.915176272277, 5699.658020518782, 5704.429557044428, 5753.424657534213, 5765.56758243125, 5253.422123566481, 5570.86072848182, 5581.10702287632, 5583.748731307182, 5585.581081418829], "value": 5269.782869495691, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.0990136933831, 581.9883602327953, 584.6170758153411, 597.9864130299144, 604.6009633641797, 33439.0, 34003.48994765074, 34120.14699632507, 34129.293535323224, 34148.0, 43105.568944310544, 43956.0, 44029.55970440303, 47098.764506177504, 47113.52886471143, 8683.39216254864, 8908.242799362062, 8915.331350148732, 8917.33120015998, 8921.241694455979, 8150.5517196554165, 8342.082370939192, 8748.69379571715, 8829.558522073903, 10355.585776568929, 10386.428746418944, 10447.216458765584, 10454.68635940923, 10460.633877814278, 10481.475926203697, 10731.892681073206, 10822.080123189538, 10832.350058996406, 10833.349999000045, 10837.349759014485, 10541.947290263577, 10595.629152979609, 10609.363438193734, 10613.628523001658, 10616.734581635521, 41794.0, 42097.368539471936, 42140.0, 42154.36768448476, 42222.78888605568, 3347.129746265964, 3411.1472131967007, 3465.324261768956, 3505.7545971781988, 3629.237860049393, 30311.69688303111, 31304.0, 31337.686623133934, 31374.0, 31652.525212121836, 4203.726757760735, 4209.284421648296, 4289.399484072233, 4296.2696341621995, 4341.826326946918, 310971.0, 311259.44370278233, 312020.0, 312493.56349765597, 312592.0, 55926.161107583415, 56347.43652563422, 56569.71715141398, 56626.7168664154, 56668.0, 59641.70179149076, 59726.0, 59752.402475975556, 59761.40238597646, 59787.10319345213, 15858.841411585736, 16060.357585696675, 16084.597885052968, 16087.839121608635, 16094.919525402298, 12259.877401226053, 12317.26096434199, 12318.0, 12324.322162280982, 12327.50689972391, 14571.198584077978, 14650.926745366418, 16212.270447829877, 16492.505224843273, 16598.170091495376, 4830.124881433944, 5934.970325148347, 5959.970200148971, 5975.43233392827, 6027.397260273938, 968.1867231525553, 986.2356673578034, 999.7500624843789, 1007.4106647611229, 1026.3226270661328, 30424.847875760923, 30933.226669333446, 31072.0, 32183.35633287368, 32294.83852580769, 1013.366645846346, 1078.6224821312478, 1092.721515826469, 1131.8132508136066, 1137.9487923043482, 15630.531084067496, 16374.345026199057, 16653.583660408585, 16655.6668866622, 16664.666706665797, 445252.0, 446855.0, 448739.0, 449207.0, 450376.0, 53788.73105634525, 54312.72843635835, 54626.453735462135, 55247.723761380934, 56973.43026569764, 1345.0853419674715, 1352.7700290950365, 1354.4514471639002, 1355.525566051874, 1360.53741727813, 30122.292853682913, 32360.35279294448, 32420.35159296848, 32611.0, 33086.503702444, 49440.752796237226, 49836.501634983186, 49868.0, 49948.50051499584, 50047.0, 439415.0, 440282.0, 441784.0, 442019.26874753035, 442934.0, 39024.6097539021, 39362.2127557453, 40215.0, 40367.0, 40415.1916961665, 45599.544004560856, 46755.29867052065, 47641.285380718626, 47923.28115078346, 48313.516864830905, 38012.80993595014, 39833.60166398299, 39876.220137112694, 40355.59644403518, 40652.18695626012, 38444.80777596206, 38948.221035578565, 40154.59845401625, 40226.59773402228, 40795.796021019705, 39227.607723922396, 39290.607093928695, 39682.0, 39816.60183398245, 40832.1833563333, 32674.673253267163, 35494.29011419809, 35640.82179589086, 36035.0, 36123.81938090398, 26793.330166745207, 27106.72893271121, 27277.727222727517, 27492.539253275063, 27566.061343209574], "value": 19782.0019707059, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.48596936228, 397.2868700682277, 403.6750415915188, 406.3863566015317, 420.10727204690033, 13464.0, 18464.907675461636, 18585.721214181798, 18663.97348145853, 18827.62344753104, 17781.822181778178, 18062.5484362891, 18295.451136465894, 18303.17635706393, 18329.54176145597, 5429.56563474923, 5469.124940009599, 5696.287964004499, 5696.743646535895, 5699.914501282484, 5580.441955804427, 5655.1517272409055, 5656.802011929583, 5669.8582535436735, 5675.091985282355, 5397.379301380352, 5629.521490673298, 5633.436656334375, 5641.746121424525, 5642.322921249435, 5518.944810551903, 5603.439656034364, 5604.299462567159, 5612.859678508029, 5625.268715067056, 4997.150484417622, 5081.441041485434, 5081.923771143436, 5088.872778180576, 5269.762860671279, 13404.262765547892, 13633.182009079486, 13675.589732308046, 13740.244286564235, 13756.518521851687, 2307.1348244408346, 2383.142068855228, 2383.988080059589, 2829.3633932365055, 2832.5326321156986, 9736.977617350147, 9845.163161131313, 9946.701598952042, 10081.294309398345, 10482.842757358645, 1797.63148554546, 1849.4636555398918, 1916.6166766646586, 1925.4512463947708, 1925.643755905162, 79055.0, 82284.0, 82506.17493825105, 82571.58714206451, 82614.0, 8761.255293300013, 9051.81896362069, 9293.767655808659, 10742.78514429707, 10897.29167604119, 12670.0, 12700.491980320683, 12726.809097863354, 12753.553625623059, 12757.0, 7261.552469838383, 7362.7423040193335, 7363.77908662741, 7383.520071195355, 7537.2085930977555, 7336.37640800538, 7393.741219057307, 7603.505772124794, 7635.923640763633, 7689.0, 3884.4173373994126, 3943.3099207638547, 3959.5644479107277, 4087.959120408758, 4089.8568550100604, 1834.5413646588354, 1872.5786697992842, 1897.6679081160742, 1907.8759880607715, 1948.5031317014354, 890.5591732092655, 945.135201290825, 947.3842002698301, 955.6655170690203, 1018.1803648063232, 18029.18868650914, 19492.220311187393, 19573.804261957484, 19579.0, 19584.902075489816, 947.1475671895212, 969.9321047526746, 989.8416253399422, 990.9009099090033, 1049.2445439283704, 7962.562059086806, 10906.563737450413, 10918.727031824268, 10920.453977301104, 10942.890571094347, 465744.0, 466549.0, 466663.0, 469844.0, 484729.0, 89995.55002224947, 92272.53863730638, 92392.53803731073, 93909.5304523473, 94190.52904735433, 920.9815803683889, 944.1832814615308, 957.2581249531669, 960.2893858544627, 962.9470379129075, 16220.432284869972, 16455.341786328412, 17298.97267978124, 17317.393891213746, 17614.295428183243, 40006.799965999984, 40023.0, 41098.0, 41268.587314126475, 41708.58291417168, 50402.0, 50738.74630626823, 56911.146332804215, 57554.42445575491, 57984.4201557979, 7945.523268603903, 8332.583370831555, 8391.0, 8580.442271252348, 8656.567171641518, 12906.741865162456, 13254.602361929157, 13352.265625390308, 13812.654683632587, 13995.370208340853, 11266.211365204357, 11299.774004519699, 11357.148213883827, 11488.712782180512, 12204.32876191818, 11423.0, 11468.369239691898, 11531.0, 11645.359505226956, 11721.589744358907, 10261.897381026392, 10461.581536738446, 10649.361038337725, 10776.407297598707, 10811.35131892089, 8169.346452283684, 8354.679409400174, 8501.829963400822, 8527.0, 8774.561271936505, 10151.390916544735, 10631.681049568526, 11357.545698172311, 11490.0, 11736.589219377282], "value": 8742.965480189087, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.182107093602, 1452.2085463422434, 1486.8067151270334, 1601.4154833485782, 1753.0, 7432.0, 8071.112177660452, 8364.790880227998, 8369.623366948494, 8545.529995850226, 8341.749747507569, 8423.326133909288, 8425.199606037417, 8426.452280601756, 8426.662933482654, 2268.115434980355, 2292.403974966504, 2293.0, 2294.242899843056, 2295.5638428698576, 2238.7201599800023, 2289.2331069091792, 2329.988350058256, 2336.6027775278158, 2341.531693661266, 2221.6334304839684, 2232.497688020199, 2255.391044418006, 2299.528596637685, 2308.4690521180137, 2182.8690278583335, 2203.6143674856835, 2228.19784877444, 2231.8995645196005, 2232.810211132056, 2209.0501084533644, 2266.218154736613, 2272.829537784656, 2273.943151421211, 2279.669447930041, 8257.83484330316, 8460.83078338436, 8559.27246184075, 8567.95716021422, 8592.398532102756, 4872.317875497433, 4998.4751601081725, 4998.57512111471, 5014.34813474246, 5095.949040509585, 3253.9511907321407, 3345.3142105868237, 3363.394588973984, 3416.9658303416895, 3430.9142271443166, 1082.6697857153565, 1082.8592283003238, 1096.2490693874722, 1115.4757264085868, 1136.7612801311734, 11718.472668729843, 11722.296662200295, 11789.410529473493, 11792.815939696235, 11840.526378944833, 4092.324766413568, 4456.242438785414, 4466.196084704784, 4497.707649002804, 4512.210363186495, 8984.146506081912, 8991.100889910957, 8998.01021887592, 9000.189982901571, 9001.144891235323, 5134.127198376285, 5134.666246693953, 5137.434882162959, 5138.820141295037, 5140.511651393112, 4255.319148936217, 4400.9119817604105, 4720.150372932836, 4807.927881081787, 4837.32277481153, 3428.194374322032, 3534.717222622184, 3575.392183328788, 3601.513795637608, 3627.9455808162897, 1101.911847052234, 1114.2367478277406, 1121.3384103379046, 1152.9654110376703, 1158.9710257243637, 935.3172184305495, 941.1905761045496, 942.9575669094908, 943.528235882059, 952.4904176265665, 5538.196961440569, 5590.440955904377, 5752.079667253303, 5785.913211301834, 6012.549058820518, 911.5943405184762, 912.7809325761903, 929.4562680831654, 962.3936919740519, 1005.9748506287401, 3665.6151104134215, 3820.312343778091, 3861.2470568239487, 3889.9416508752392, 4138.0689344897155, 10139.2902496826, 10601.098906592872, 10663.253572250023, 10672.359658420519, 10706.357618542912, 10137.898621013843, 10293.3823970562, 10466.947665261778, 10481.842772358421, 10486.895131048745, 7447.553146811317, 7894.368450523944, 8066.596670166468, 8079.757607271791, 8080.191980801873, 5539.8892022160135, 5541.750621221974, 5665.12190610456, 5692.914606280826, 5769.336526299529, 9698.0, 9708.951455242679, 9731.513424328614, 9803.656872009446, 9862.704118876445, 8895.110488951053, 9252.907470925475, 9275.814483710423, 9470.479123648265, 9507.239420846454, 7118.288171183048, 7299.4160467163565, 7750.147483776667, 7872.330851877426, 8034.517928924283, 7968.163342848918, 8259.83480330378, 8262.83474330498, 8264.545450000307, 8268.958655206685, 7304.744333948286, 7375.373093286916, 7420.740274090597, 7506.747975607187, 7664.80837979055, 7110.253423390676, 7178.712851485882, 7179.425645948416, 7225.169105552929, 7300.196978332273, 6351.618902865843, 6456.0, 6504.60972341661, 6590.308017658077, 6597.175353080865, 4715.406526410529, 4823.252395878644, 4864.197407427876, 4927.9507204927495, 4967.925481117858, 5067.493250674903, 5103.591712662904, 5133.460986596503, 5195.68825870449, 5301.4168441472175], "value": 4444.218223845116, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.64805242155006, 330.04781206220065, 330.14492464516894, 332.92133487500496, 338.9610194827596, 5053.519915608012, 5168.664036837612, 5235.50262725041, 5252.947470525293, 5281.339832520935, 5022.34709487767, 5109.6678715883445, 5137.845864624058, 5157.3295471588735, 5159.948400515994, 4060.4924384451942, 4092.3247664135383, 4105.548389677148, 4110.486189226347, 4129.979350103245, 3784.6593806557403, 3918.314294998364, 4136.710430269883, 4143.197708996596, 4181.477315335583, 3980.7412518186225, 4042.9071760103543, 4061.8375264989363, 4081.9183616327655, 4106.753594784308, 4065.8373665053364, 4068.7558746475306, 4071.918561628751, 4081.551029386765, 4104.774237416941, 3621.9456708149137, 3622.8188590570367, 3627.5102861113673, 3635.3456377851976, 3643.2895585360866, 4952.430470495867, 5033.446320904734, 5061.670991385585, 5067.239914012891, 5072.619553533463, 4604.355390245369, 4635.5364463553715, 4667.463241727177, 4675.438947326308, 4692.577668009862, 5335.466453354672, 5378.3596003219, 5380.757865896005, 5399.460053994609, 5409.810656626999, 3695.7782533048103, 3857.961420385788, 3861.227754449121, 3873.0, 3900.2199560088097, 5574.721263936827, 5583.609147359686, 5587.245721827542, 5609.298837645294, 5609.467100625434, 3964.365701487806, 3975.344068228768, 3978.542467616261, 4044.5550989391145, 4062.0048088217986, 3987.860424885115, 4027.8791636250958, 4029.133736246721, 4051.756894586334, 4085.775282359439, 4617.676762626584, 4618.35343051973, 4619.360127154811, 4624.514425985223, 4630.536946305342, 5439.755211015514, 5441.0, 5448.645838020516, 5449.773800894767, 5451.781928722886, 1234.160770675931, 1261.9777979836363, 1350.7298540291783, 1366.7266546690503, 1371.3760239091189, 846.2341580869323, 876.513534988075, 882.5763633455849, 887.5650931043871, 897.9359459041058, 4557.701055199319, 4567.474740404829, 4603.562661547147, 4629.652776041743, 4637.09878949629, 4792.496787837227, 4793.376861008047, 4805.231163013901, 4805.951940480621, 4815.446223684251, 4590.495045545054, 4592.265237561974, 4594.33382159585, 4633.930491042637, 4651.279051746985, 2421.69728783902, 2558.411565339982, 2566.4610431809156, 2573.6139579062915, 2580.9354766130996, 4917.082337888227, 4950.42577859511, 4956.224514272019, 4990.852104016024, 5013.523715247045, 4861.392325959255, 4870.707757534559, 4880.682755620874, 4887.608991280689, 4905.950940490621, 5358.97320513395, 5774.364819869811, 5779.653220806765, 5783.306003279633, 5790.392008839011, 5604.607677462538, 5606.85982850432, 5615.606907516598, 5623.943760562505, 5641.5204707600315, 5440.809571664972, 5494.131995121677, 5507.586930980273, 5567.3040869891265, 5589.972050139723, 5736.512396446349, 5747.137929310469, 5747.597668163188, 5751.252337196138, 5761.423857614205, 3999.5600483947323, 4001.8999525010945, 4008.1382502762044, 4008.579099194659, 4035.233305671913, 5282.841514754564, 5309.256704061358, 5570.387257401601, 5608.523275521463, 5617.522510586646, 5287.656302340336, 5328.6944698549105, 5487.451254874481, 5495.2856128703015, 5508.283923089973, 5430.972845135749, 5476.561875049907, 5481.328194900434, 5484.561235101262, 5488.862778430571, 5253.50091741284, 5350.384705758887, 5361.5710743141235, 5413.918791218056, 5433.56531477473, 5437.673739575638, 5448.155535891943, 5470.699111548903, 5471.562275018068, 5478.863028424162, 5349.491798279158, 5364.049772625119, 5366.865828354323, 5372.838814835562, 5379.73101344939], "value": 4048.114156739971, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.2349192714707, 670.4643089499533, 699.5522865366163, 710.9111361079865, 712.6009434716558, 13819.239941803196, 14717.264136793157, 14726.263686815642, 15466.767998480003, 16057.277422516016, 13938.860611393882, 14056.437742490314, 14163.858361416384, 14191.929040354784, 14238.71522569548, 799.6361655446786, 825.4387016828554, 826.6858593734372, 827.9006519217702, 827.9296259817922, 670.2091531992247, 686.6806934775328, 788.0740130346849, 810.8824220488026, 815.5188438821094, 863.6804382378529, 867.4448353054019, 867.9305655547541, 868.6699054359335, 868.8827008353854, 862.7627402464373, 863.2877875752466, 864.2222000199807, 864.2783275964578, 864.8010957479784, 508.47118996243864, 517.9974100129513, 605.9970748411387, 621.3879328861068, 628.9811305660837, 13755.518556850562, 13825.824804891596, 13885.4445822167, 13906.652333691638, 13908.652283692887, 12931.288779117145, 13053.54312599064, 13418.530351437652, 13448.0, 13563.186208827501, 11955.64133076009, 12004.279743215435, 12029.819552706716, 12120.515179392814, 12254.399665734807, 3726.06848287928, 3751.756135851161, 3832.597577254404, 3990.940135897964, 4357.716748411375, 48133.75933120347, 48221.27668084981, 50255.74872125616, 66287.0, 66674.66662666704, 10981.890181098246, 11018.669439916655, 11046.281991670516, 11256.662300131009, 11349.943250283695, 19981.700274495895, 20146.59706805885, 20151.093200805706, 20330.79669203289, 20339.491512712302, 7947.602619868983, 7998.320142787812, 8003.959980200062, 8372.623231954576, 8392.076871544125, 4438.467383913951, 4618.584327410549, 4651.86044418668, 4729.07782982322, 4862.78117484714, 3184.2039490127468, 3254.8698052077652, 3256.9674303256666, 3298.5876765404323, 3309.50357446385, 576.1242910775682, 580.5181699189662, 580.5587753307432, 606.2088973889117, 611.9510439164856, 580.4195804195804, 633.3444884544566, 693.0366790161679, 729.1396152539947, 730.5580124024889, 8438.451500652438, 8711.869321960176, 9439.292053096045, 9659.812261953539, 10242.692719218436, 608.333874407523, 648.2350826025241, 719.0688058963655, 734.6326836581709, 755.2070326157512, 4204.306289462204, 4555.362249285103, 4708.199606066977, 4799.616030717534, 4810.807567697323, 50493.24260136101, 50614.49385506098, 80392.59803701061, 82943.17056829475, 86416.56791716, 44672.10655786866, 57626.423735762946, 70672.0, 71501.0, 74063.0, 64100.67949660222, 64926.0, 65316.0, 65902.0, 67185.66407167933, 8355.373346998878, 8759.0, 8777.385583009383, 8815.691450799191, 8891.78786777339, 32443.513347300282, 43216.0, 43686.781566091966, 43884.561154388044, 43991.78004109959, 35281.0, 53467.73266133644, 59743.40256597378, 60548.39451605604, 61187.69406152941, 11511.597094101666, 11563.942180289045, 11637.825432618349, 11707.473163707824, 11845.170838041255, 12543.24740515572, 12761.425735842095, 12775.433544729223, 13564.321783910567, 13628.386722597308, 11430.25703329281, 11470.090574300986, 11675.241109327866, 11857.525698971944, 12106.636800895987, 11223.270487418291, 11233.49449274801, 11238.157138214503, 11304.604338848101, 12240.755184896074, 10932.234743567873, 10967.945160274148, 11403.258788178742, 11424.314541127558, 11492.425378731197, 10179.847302290324, 10191.898081019392, 10509.579616815241, 10617.628383006559, 10828.350298982086, 9600.519974001412, 10399.4099060035, 10490.265681402228, 10564.630237941943, 10621.628243011457], "value": 6791.751609360222, "unit": "score"}], "name": "dromaeo_css", "value": 6936.384504523241, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 111.0, 110.0, 111.0, 110.0, 110.0, 109.0, 112.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 124.0, 123.0, 163.0, 135.0, 122.0, 125.0, 122.0, 164.0, 124.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 161.0, 163.0, 161.0, 161.0, 163.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 108.0, 76.0, 76.0, 76.0, 75.0, 102.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 124.0, 82.0, 82.0, 82.0, 102.0, 82.0, 83.0, 114.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 147.0, 146.0, 145.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 85.0, 85.0, 86.0, 85.0, 86.0, 86.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 52.0, 52.0, 53.0, 53.0, 53.0, 64.0, 53.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 60.0, 60.0, 62.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 80.0, 80.0, 81.0, 86.0, 86.0, 88.0, 83.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 147.0, 136.0, 133.0, 129.0, 131.0, 130.0, 135.0, 171.0, 152.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 165.0, 165.0, 166.0, 171.0, 168.0, 165.0, 170.0, 164.0, 169.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 65.0, 64.0, 64.0, 65.0, 63.0, 63.0, 63.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1496.6000000000001, "alertThreshold": 2.0}]} 13:57:34 INFO - Return code: 0 13:57:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:57:34 INFO - # TBPL SUCCESS # 13:57:34 INFO - Running post-action listener: _resource_record_post_action 13:57:34 INFO - [mozharness: 2016-10-31 20:57:34.272069Z] Finished run-tests step (success) 13:57:34 INFO - Running post-run listener: _resource_record_post_run 13:57:34 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409518080; Read time: 0; Write time: 334916 13:57:34 INFO - TinderboxPrint: CPU usage
13.1% 13:57:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 0 13:57:34 INFO - TinderboxPrint: I/O write bytes / time
409,518,080 / 334,916 13:57:34 INFO - TinderboxPrint: CPU idle
8,305.6 (86.9%) 13:57:34 INFO - TinderboxPrint: CPU user
1,200.2 (12.6%) 13:57:34 INFO - TinderboxPrint: Swap in / out
0 / 0 13:57:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120274944; Read time: 0; Write time: 77716 13:57:34 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288284672; Read time: 0; Write time: 257176 13:57:34 INFO - Running post-run listener: _upload_blobber_files 13:57:34 INFO - Blob upload gear active. 13:57:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:57:34 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 13:57:34 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'] 13:57:34 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 13:57:35 INFO - (blobuploader) - INFO - Open directory for files ... 13:57:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:57:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:57:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:57:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:57:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:57:36 INFO - (blobuploader) - INFO - Done attempting. 13:57:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:57:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:57:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:57:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:57:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:57:36 INFO - (blobuploader) - INFO - Done attempting. 13:57:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:57:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:57:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:57:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:57:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:57:40 INFO - (blobuploader) - INFO - Done attempting. 13:57:40 INFO - (blobuploader) - INFO - Iteration through files over. 13:57:40 INFO - Return code: 0 13:57:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:57:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:57:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8696f167edd51d8ee2782889691cd060599e6d3b84efd5635f9b7d7f93da453637e03465929201d8ccd65b37dd9ebe4015a31a668929acb34b837b947e72dc55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7e8db2ddf0f8d9ccd7ce2ca3d542ad347e20fc5aaa548160336d7b0c8c79c55df9d715feb929fca7a85198dabc49b2617b18454efe8d88843788066170cab713", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/649d57b373fb2deba5cdd8b7add561c2cd0dcb77800e80052c490f76e397b08d507586ec3f06f88fbbe1296b1bb014cd15d42fa819cf2a17eb738d2f25ac298b"} 13:57:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:57:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:57:40 INFO - Contents: 13:57:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8696f167edd51d8ee2782889691cd060599e6d3b84efd5635f9b7d7f93da453637e03465929201d8ccd65b37dd9ebe4015a31a668929acb34b837b947e72dc55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7e8db2ddf0f8d9ccd7ce2ca3d542ad347e20fc5aaa548160336d7b0c8c79c55df9d715feb929fca7a85198dabc49b2617b18454efe8d88843788066170cab713", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/649d57b373fb2deba5cdd8b7add561c2cd0dcb77800e80052c490f76e397b08d507586ec3f06f88fbbe1296b1bb014cd15d42fa819cf2a17eb738d2f25ac298b"} 13:57:40 INFO - Running post-run listener: copy_logs_to_upload_dir 13:57:40 INFO - Copying logs to upload dir... 13:57:40 INFO - mkdir: /builds/slave/test/build/upload/logs 13:57:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.787375 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-31 13:57:40.126569) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 13:57:40.129717) ========= 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=17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8696f167edd51d8ee2782889691cd060599e6d3b84efd5635f9b7d7f93da453637e03465929201d8ccd65b37dd9ebe4015a31a668929acb34b837b947e72dc55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7e8db2ddf0f8d9ccd7ce2ca3d542ad347e20fc5aaa548160336d7b0c8c79c55df9d715feb929fca7a85198dabc49b2617b18454efe8d88843788066170cab713", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/649d57b373fb2deba5cdd8b7add561c2cd0dcb77800e80052c490f76e397b08d507586ec3f06f88fbbe1296b1bb014cd15d42fa819cf2a17eb738d2f25ac298b"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8696f167edd51d8ee2782889691cd060599e6d3b84efd5635f9b7d7f93da453637e03465929201d8ccd65b37dd9ebe4015a31a668929acb34b837b947e72dc55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7e8db2ddf0f8d9ccd7ce2ca3d542ad347e20fc5aaa548160336d7b0c8c79c55df9d715feb929fca7a85198dabc49b2617b18454efe8d88843788066170cab713", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/649d57b373fb2deba5cdd8b7add561c2cd0dcb77800e80052c490f76e397b08d507586ec3f06f88fbbe1296b1bb014cd15d42fa819cf2a17eb738d2f25ac298b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 13:57:40.157874) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 13:57:40.158237) ========= 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=17051fcd5208b27b50bedfeb000001dd-1477946218.213474-1927602029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 13:57:40.244341) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 13:57:40.244652) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 13:57:40.245050) ========= ========= Total master_lag: 0.18 =========