builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-065 starttime: 1475578149.79 results: success (0) buildid: 20161004003016 builduid: 4edf2d81dcbb46398f80e49e12edce49 revision: f927dc3ad86478c7b54507fa8cf862cff4f372b4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 03:49:09.793532) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 03:49:09.793997) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 03:49:09.794331) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 03:49:09.809183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 03:49:09.809497) ========= 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=523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 03:49:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-10-04 03:49:10 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117965 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 03:49:09.941430) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 03:49:09.941743) ========= 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=523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021179 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 03:49:09.991034) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 03:49:09.991405) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f927dc3ad86478c7b54507fa8cf862cff4f372b4 --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 f927dc3ad86478c7b54507fa8cf862cff4f372b4 --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=523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 03:49:10,230 truncating revision to first 12 chars 2016-10-04 03:49:10,230 Setting DEBUG logging. 2016-10-04 03:49:10,230 attempt 1/10 2016-10-04 03:49:10,230 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f927dc3ad864?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 03:49:11,768 unpacking tar archive at: fx-team-f927dc3ad864/testing/mozharness/ program finished with exit code 0 elapsedTime=1.858677 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 03:49:11.863072) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 03:49:11.863405) ========= script_repo_revision: f927dc3ad86478c7b54507fa8cf862cff4f372b4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 03:49:11.863797) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 03:49:11.864063) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 03:49:11.872079) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-04 03:49:11.872372) ========= /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=523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:49:12 INFO - MultiFileLogger online at 20161004 03:49:12 in /builds/slave/test 03:49:12 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 03:49:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:49:12 INFO - {'append_to_log': False, 03:49:12 INFO - 'base_work_dir': '/builds/slave/test', 03:49:12 INFO - 'blob_upload_branch': 'Fx-Team', 03:49:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:49:12 INFO - 'branch': 'Fx-Team', 03:49:12 INFO - 'buildbot_json_path': 'buildprops.json', 03:49:12 INFO - 'config_files': ('talos/linux_config.py',), 03:49:12 INFO - 'default_actions': ('clobber', 03:49:12 INFO - 'read-buildbot-config', 03:49:12 INFO - 'download-and-extract', 03:49:12 INFO - 'populate-webroot', 03:49:12 INFO - 'create-virtualenv', 03:49:12 INFO - 'install', 03:49:12 INFO - 'run-tests'), 03:49:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:49:12 INFO - 'download_minidump_stackwalk': True, 03:49:12 INFO - 'download_symbols': 'ondemand', 03:49:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:49:12 INFO - 'tooltool.py': '/tools/tooltool.py', 03:49:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:49:12 INFO - '/tools/misc-python/virtualenv.py')}, 03:49:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:49:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:49:12 INFO - 'installer_path': 'installer.exe', 03:49:12 INFO - 'log_level': 'info', 03:49:12 INFO - 'log_name': 'talos', 03:49:12 INFO - 'log_to_console': True, 03:49:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:49:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:49:12 INFO - 'opt_config_files': (), 03:49:12 INFO - 'pip_index': False, 03:49:12 INFO - 'sps_profile': False, 03:49:12 INFO - 'sps_profile_interval': 0, 03:49:12 INFO - 'suite': 'dromaeojs', 03:49:12 INFO - 'system_bits': '32', 03:49:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:49:12 INFO - 'title': 'talos-linux64-ix-065', 03:49:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:49:12 INFO - 'use_talos_json': True, 03:49:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:49:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:49:12 INFO - 'work_dir': 'build'} 03:49:12 INFO - [mozharness: 2016-10-04 10:49:12.215671Z] Running clobber step. 03:49:12 INFO - Running pre-action listener: _resource_record_pre_action 03:49:12 INFO - Running main action method: clobber 03:49:12 INFO - rmtree: /builds/slave/test/build 03:49:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:49:12 INFO - Running post-action listener: _resource_record_post_action 03:49:12 INFO - [mozharness: 2016-10-04 10:49:12.678324Z] Finished clobber step (success) 03:49:12 INFO - [mozharness: 2016-10-04 10:49:12.678424Z] Running read-buildbot-config step. 03:49:12 INFO - Running pre-action listener: _resource_record_pre_action 03:49:12 INFO - Running main action method: read_buildbot_config 03:49:12 INFO - Using buildbot properties: 03:49:12 INFO - { 03:49:12 INFO - "project": "", 03:49:12 INFO - "product": "firefox", 03:49:12 INFO - "script_repo_revision": "production", 03:49:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:49:12 INFO - "repository": "", 03:49:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 03:49:12 INFO - "buildid": "20161004003016", 03:49:12 INFO - "pgo_build": "True", 03:49:12 INFO - "basedir": "/builds/slave/test", 03:49:12 INFO - "buildnumber": 499, 03:49:12 INFO - "slavename": "talos-linux64-ix-065", 03:49:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:49:12 INFO - "platform": "ubuntu64_hw", 03:49:12 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 03:49:12 INFO - "branch": "fx-team", 03:49:12 INFO - "repo_path": "integration/fx-team", 03:49:12 INFO - "revision": "f927dc3ad86478c7b54507fa8cf862cff4f372b4", 03:49:12 INFO - "stage_platform": "linux64-pgo", 03:49:12 INFO - "builduid": "4edf2d81dcbb46398f80e49e12edce49", 03:49:12 INFO - "slavebuilddir": "test" 03:49:12 INFO - } 03:49:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:49:12 INFO - Running post-action listener: _resource_record_post_action 03:49:12 INFO - [mozharness: 2016-10-04 10:49:12.681113Z] Finished read-buildbot-config step (success) 03:49:12 INFO - [mozharness: 2016-10-04 10:49:12.681201Z] Running download-and-extract step. 03:49:12 INFO - Running pre-action listener: _resource_record_pre_action 03:49:12 INFO - Running main action method: download_and_extract 03:49:12 INFO - mkdir: /builds/slave/test/build/tests 03:49: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')]} 03:49:12 INFO - trying https://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:49:12 INFO - Downloading https://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/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 03:49:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/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 03:49:13 INFO - Downloaded 1361 bytes. 03:49:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:49:13 INFO - Using the following test package requirements: 03:49:13 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:49:13 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:49:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:49:13 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:49:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:49:13 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:49:13 INFO - u'jsshell-linux-x86_64.zip'], 03:49:13 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:49:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:49:13 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:49:13 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:49:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:49:13 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:49:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:49:13 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:49:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:49:13 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:49:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:49:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:49:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:49:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:49:13 INFO - Fetch https://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:49:13 INFO - Http code: 200 03:49:13 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 03:49:13 INFO - x-amz-cf-id: ID0B5UTjcXNxrBLK0qRiHOffQVvMaL1uILYRSj-_mowE83DmetD0qg== 03:49:13 INFO - x-amz-version-id: TipXfbvhtvHySptASAqQ8Xx.pkssPi80 03:49:14 INFO - Expected file size: 21992467 03:49:14 INFO - Obtained file size: 21992467 03:49:18 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 03:49:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:49:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:49:18 INFO - Fetch https://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:49:18 INFO - Http code: 200 03:49:18 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 03:49:18 INFO - x-amz-cf-id: da2c6y5fczY_8G5yTNUTjL5h3Lq9jFDCzkRaogeT6JLS0Qv0sPNXgg== 03:49:18 INFO - x-amz-version-id: TipXfbvhtvHySptASAqQ8Xx.pkssPi80 03:49:18 INFO - Expected file size: 21992467 03:49:18 INFO - Obtained file size: 21992467 03:49:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:49:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:49:23 INFO - Fetch https://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:49:23 INFO - Http code: 200 03:49:23 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 03:49:23 INFO - x-amz-cf-id: 5673X7RWThN1bVEGY9Pqm1XfDDH3lHl97R4r09sYe0IFGIY-ZwzzWQ== 03:49:23 INFO - x-amz-version-id: 7ucONoGSoB6Il6W2OKO4asyLnpo4zH8O 03:49:24 INFO - Expected file size: 14409006 03:49:24 INFO - Obtained file size: 14409006 03:49: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')]} 03:49:24 INFO - trying https://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:49:24 INFO - Downloading https://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/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 03:49:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/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 03:49:25 INFO - Downloaded 59707736 bytes. 03:49:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:49:25 INFO - mkdir: /builds/slave/test/properties 03:49:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:49:25 INFO - Writing to file /builds/slave/test/properties/build_url 03:49:25 INFO - Contents: 03:49:25 INFO - build_url:https://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:49:26 INFO - Running post-action listener: _resource_record_post_action 03:49:26 INFO - Running post-action listener: set_extra_try_arguments 03:49:26 INFO - [mozharness: 2016-10-04 10:49:26.328511Z] Finished download-and-extract step (success) 03:49:26 INFO - [mozharness: 2016-10-04 10:49:26.328736Z] Running populate-webroot step. 03:49:26 INFO - Running pre-action listener: _resource_record_pre_action 03:49:26 INFO - Running main action method: populate_webroot 03:49:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:49:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:49:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:49:26 INFO - '--tppagecycles', 03:49:26 INFO - '7'], 03:49:26 INFO - 'tests': ['tsvgm']}}, 03:49:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:49:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:49:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:49:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:49:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:49:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:49:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:26 INFO - 'talos_options': ['--disable-e10s'], 03:49:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:49:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:49:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:26 INFO - 'talos_options': ['--disable-e10s'], 03:49:26 INFO - 'tests': ['damp', 'tps']}, 03:49:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:26 INFO - 'tests': ['damp', 'tps']}, 03:49:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:49:26 INFO - 'tests': ['dromaeo_dom']}, 03:49:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:49:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:49:26 INFO - 'tests': ['basic_compositor_video']}, 03:49:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:49:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:49:26 INFO - 'tests': ['a11yr', 03:49:26 INFO - 'ts_paint', 03:49:26 INFO - 'tpaint', 03:49:26 INFO - 'sessionrestore', 03:49:26 INFO - 'sessionrestore_no_auto_restore', 03:49:26 INFO - 'tabpaint']}, 03:49:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:49:26 INFO - 'ts_paint', 03:49:26 INFO - 'tpaint', 03:49:26 INFO - 'sessionrestore', 03:49:26 INFO - 'sessionrestore_no_auto_restore', 03:49:26 INFO - 'tabpaint']}, 03:49:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:49:26 INFO - 'ts_paint', 03:49:26 INFO - 'tpaint', 03:49:26 INFO - 'sessionrestore', 03:49:26 INFO - 'sessionrestore_no_auto_restore', 03:49:26 INFO - 'tabpaint']}, 03:49:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:49:26 INFO - 'ts_paint', 03:49:26 INFO - 'tpaint', 03:49:26 INFO - 'sessionrestore', 03:49:26 INFO - 'sessionrestore_no_auto_restore', 03:49:26 INFO - 'tabpaint']}, 03:49:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:49:26 INFO - 'tests': ['a11yr', 03:49:26 INFO - 'ts_paint', 03:49:26 INFO - 'tpaint', 03:49:26 INFO - 'sessionrestore', 03:49:26 INFO - 'sessionrestore_no_auto_restore', 03:49:26 INFO - 'tabpaint']}, 03:49:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:49:26 INFO - 'tests': ['a11yr', 03:49:26 INFO - 'ts_paint', 03:49:26 INFO - 'tpaint', 03:49:26 INFO - 'sessionrestore', 03:49:26 INFO - 'sessionrestore_no_auto_restore', 03:49:26 INFO - 'tabpaint']}, 03:49:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:49:26 INFO - 'tests': ['tsvgx', 03:49:26 INFO - 'tsvgr_opacity', 03:49:26 INFO - 'tart', 03:49:26 INFO - 'tscrollx', 03:49:26 INFO - 'cart']}, 03:49:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:49:26 INFO - 'tsvgr_opacity', 03:49:26 INFO - 'tart', 03:49:26 INFO - 'tscrollx', 03:49:26 INFO - 'cart']}, 03:49:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:26 INFO - 'talos_options': ['--disable-e10s'], 03:49:26 INFO - 'tests': ['tp5o']}, 03:49:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:26 INFO - 'tests': ['tp5o']}, 03:49:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:26 INFO - 'talos_options': ['--disable-e10s', 03:49:26 INFO - '--xperf_path', 03:49:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:49:26 INFO - 'tests': ['tp5n']}, 03:49:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:26 INFO - 'talos_options': ['--xperf_path', 03:49:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:49:26 INFO - 'tests': ['tp5n']}}, 03:49:26 INFO - 'talos.zip': {'path': '', 03:49:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:49:26 INFO - Running post-action listener: _resource_record_post_action 03:49:26 INFO - [mozharness: 2016-10-04 10:49:26.346484Z] Finished populate-webroot step (success) 03:49:26 INFO - [mozharness: 2016-10-04 10:49:26.346572Z] Running create-virtualenv step. 03:49:26 INFO - Running pre-action listener: _resource_record_pre_action 03:49:26 INFO - Running main action method: create_virtualenv 03:49:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:49:26 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 03:49:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:49:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:49:26 INFO - Using real prefix '/usr' 03:49:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:49:26 INFO - Installing distribute.............................................................................................................................................................................................done. 03:49:28 INFO - Installing pip.................done. 03:49:28 INFO - Return code: 0 03:49:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:49:29 INFO - Reading from file tmpfile_stdout 03:49:29 INFO - Output received: 03:49:29 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) 03:49:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd36fc5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12437b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d2790>, '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 0x12d3690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3b20>, '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': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', '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 03:49:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:49:29 INFO - Using env: {'DISPLAY': ':0', 03:49:29 INFO - 'HOME': '/home/cltbld', 03:49:29 INFO - 'LANG': 'en_US.UTF-8', 03:49:29 INFO - 'LANGUAGE': 'en_US:en', 03:49:29 INFO - 'LOGNAME': 'cltbld', 03:49:29 INFO - 'MAIL': '/var/mail/cltbld', 03:49:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:29 INFO - 'MOZ_NO_REMOTE': '1', 03:49:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:29 INFO - 'NO_EM_RESTART': '1', 03:49:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:29 INFO - 'PWD': '/builds/slave/test', 03:49:29 INFO - 'SHELL': '/bin/bash', 03:49:29 INFO - 'SHLVL': '1', 03:49:29 INFO - 'TERM': 'linux', 03:49:29 INFO - 'TMOUT': '86400', 03:49:29 INFO - 'USER': 'cltbld', 03:49:29 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', 03:49:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:29 INFO - '_': '/tools/buildbot/bin/python'} 03:49:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:29 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 03:49:29 INFO - Cleaning up... 03:49:29 INFO - Return code: 0 03:49:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd36fc5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12437b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d2790>, '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 0x12d3690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3b20>, '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': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', '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 03:49:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:49:29 INFO - Using env: {'DISPLAY': ':0', 03:49:29 INFO - 'HOME': '/home/cltbld', 03:49:29 INFO - 'LANG': 'en_US.UTF-8', 03:49:29 INFO - 'LANGUAGE': 'en_US:en', 03:49:29 INFO - 'LOGNAME': 'cltbld', 03:49:29 INFO - 'MAIL': '/var/mail/cltbld', 03:49:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:29 INFO - 'MOZ_NO_REMOTE': '1', 03:49:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:29 INFO - 'NO_EM_RESTART': '1', 03:49:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:29 INFO - 'PWD': '/builds/slave/test', 03:49:29 INFO - 'SHELL': '/bin/bash', 03:49:29 INFO - 'SHLVL': '1', 03:49:29 INFO - 'TERM': 'linux', 03:49:29 INFO - 'TMOUT': '86400', 03:49:29 INFO - 'USER': 'cltbld', 03:49:29 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', 03:49:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:29 INFO - '_': '/tools/buildbot/bin/python'} 03:49:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:29 INFO - Downloading/unpacking psutil>=3.1.1 03:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:49:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:49:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:49:31 INFO - Installing collected packages: psutil 03:49:31 INFO - Running setup.py install for psutil 03:49:31 INFO - building 'psutil._psutil_linux' extension 03:49:31 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 03:49:31 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 03:49:31 INFO - building 'psutil._psutil_posix' extension 03:49:31 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 03:49:31 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 03:49:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:49:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:49:32 INFO - Successfully installed psutil 03:49:32 INFO - Cleaning up... 03:49:32 INFO - Return code: 0 03:49:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd36fc5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12437b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d2790>, '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 0x12d3690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3b20>, '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': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', '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 03:49:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:49:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:49:32 INFO - Using env: {'DISPLAY': ':0', 03:49:32 INFO - 'HOME': '/home/cltbld', 03:49:32 INFO - 'LANG': 'en_US.UTF-8', 03:49:32 INFO - 'LANGUAGE': 'en_US:en', 03:49:32 INFO - 'LOGNAME': 'cltbld', 03:49:32 INFO - 'MAIL': '/var/mail/cltbld', 03:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:32 INFO - 'MOZ_NO_REMOTE': '1', 03:49:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:32 INFO - 'NO_EM_RESTART': '1', 03:49:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:32 INFO - 'PWD': '/builds/slave/test', 03:49:32 INFO - 'SHELL': '/bin/bash', 03:49:32 INFO - 'SHLVL': '1', 03:49:32 INFO - 'TERM': 'linux', 03:49:32 INFO - 'TMOUT': '86400', 03:49:32 INFO - 'USER': 'cltbld', 03:49:32 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', 03:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:32 INFO - '_': '/tools/buildbot/bin/python'} 03:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:49:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:49:34 INFO - Installing collected packages: mozsystemmonitor 03:49:34 INFO - Running setup.py install for mozsystemmonitor 03:49:34 INFO - Successfully installed mozsystemmonitor 03:49:34 INFO - Cleaning up... 03:49:34 INFO - Return code: 0 03:49:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd36fc5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12437b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d2790>, '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 0x12d3690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3b20>, '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': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', '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 03:49:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:49:34 INFO - Using env: {'DISPLAY': ':0', 03:49:34 INFO - 'HOME': '/home/cltbld', 03:49:34 INFO - 'LANG': 'en_US.UTF-8', 03:49:34 INFO - 'LANGUAGE': 'en_US:en', 03:49:34 INFO - 'LOGNAME': 'cltbld', 03:49:34 INFO - 'MAIL': '/var/mail/cltbld', 03:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:34 INFO - 'MOZ_NO_REMOTE': '1', 03:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:34 INFO - 'NO_EM_RESTART': '1', 03:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:34 INFO - 'PWD': '/builds/slave/test', 03:49:34 INFO - 'SHELL': '/bin/bash', 03:49:34 INFO - 'SHLVL': '1', 03:49:34 INFO - 'TERM': 'linux', 03:49:34 INFO - 'TMOUT': '86400', 03:49:34 INFO - 'USER': 'cltbld', 03:49:34 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', 03:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:34 INFO - '_': '/tools/buildbot/bin/python'} 03:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:34 INFO - Downloading/unpacking jsonschema==2.5.1 03:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:49:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:36 INFO - Downloading functools32-3.2.3-2.tar.gz 03:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:49:36 INFO - warning: no files found matching '*.txt' 03:49:36 INFO - no previously-included directories found matching 'build' 03:49:36 INFO - no previously-included directories found matching 'dist' 03:49:36 INFO - no previously-included directories found matching '.git*' 03:49:36 INFO - Installing collected packages: jsonschema, functools32 03:49:36 INFO - Running setup.py install for functools32 03:49:36 INFO - warning: no files found matching '*.txt' 03:49:36 INFO - no previously-included directories found matching 'build' 03:49:36 INFO - no previously-included directories found matching 'dist' 03:49:36 INFO - no previously-included directories found matching '.git*' 03:49:36 INFO - Successfully installed jsonschema functools32 03:49:36 INFO - Cleaning up... 03:49:37 INFO - Return code: 0 03:49:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:49:37 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')]} 03:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:37 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')]} 03:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:37 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 0x7fd36fc5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12437b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d2790>, '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 0x12d3690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3b20>, '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': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', '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 03:49:37 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 03:49:37 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 03:49:37 INFO - Using env: {'DISPLAY': ':0', 03:49:37 INFO - 'HOME': '/home/cltbld', 03:49:37 INFO - 'LANG': 'en_US.UTF-8', 03:49:37 INFO - 'LANGUAGE': 'en_US:en', 03:49:37 INFO - 'LOGNAME': 'cltbld', 03:49:37 INFO - 'MAIL': '/var/mail/cltbld', 03:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:37 INFO - 'MOZ_NO_REMOTE': '1', 03:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:37 INFO - 'NO_EM_RESTART': '1', 03:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:37 INFO - 'PWD': '/builds/slave/test', 03:49:37 INFO - 'SHELL': '/bin/bash', 03:49:37 INFO - 'SHLVL': '1', 03:49:37 INFO - 'TERM': 'linux', 03:49:37 INFO - 'TMOUT': '86400', 03:49:37 INFO - 'USER': 'cltbld', 03:49:37 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', 03:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:37 INFO - '_': '/tools/buildbot/bin/python'} 03:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:49:37 INFO - Cleaning up... 03:49:37 INFO - Return code: 0 03:49:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:49:37 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')]} 03:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:37 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')]} 03:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:37 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 0x7fd36fc5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12437b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d2790>, '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 0x12d3690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3b20>, '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': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', '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 03:49:37 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 03:49:37 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 03:49:37 INFO - Using env: {'DISPLAY': ':0', 03:49:37 INFO - 'HOME': '/home/cltbld', 03:49:37 INFO - 'LANG': 'en_US.UTF-8', 03:49:37 INFO - 'LANGUAGE': 'en_US:en', 03:49:37 INFO - 'LOGNAME': 'cltbld', 03:49:37 INFO - 'MAIL': '/var/mail/cltbld', 03:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:37 INFO - 'MOZ_NO_REMOTE': '1', 03:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:37 INFO - 'NO_EM_RESTART': '1', 03:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:37 INFO - 'PWD': '/builds/slave/test', 03:49:37 INFO - 'SHELL': '/bin/bash', 03:49:37 INFO - 'SHLVL': '1', 03:49:37 INFO - 'TERM': 'linux', 03:49:37 INFO - 'TMOUT': '86400', 03:49:37 INFO - 'USER': 'cltbld', 03:49:37 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', 03:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:37 INFO - '_': '/tools/buildbot/bin/python'} 03:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:37 INFO - Downloading/unpacking blobuploader==1.2.4 03:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:39 INFO - Downloading blobuploader-1.2.4.tar.gz 03:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:49:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:49:39 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 03:49:39 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 03:49:39 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 03:49:39 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 03:49:39 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 03:49:39 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 03:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:49:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:49:39 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 03:49:39 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 03:49:39 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 03:49:39 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 03:49:39 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 03:49:39 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 03:49:40 INFO - Downloading docopt-0.6.1.tar.gz 03:49:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:49:40 INFO - Installing collected packages: blobuploader, requests, docopt 03:49:40 INFO - Running setup.py install for blobuploader 03:49:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:49:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:49:40 INFO - Running setup.py install for requests 03:49:40 INFO - Running setup.py install for docopt 03:49:40 INFO - Successfully installed blobuploader requests docopt 03:49:40 INFO - Cleaning up... 03:49:40 INFO - Return code: 0 03:49:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:40 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 0x7fd36fc5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12437b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d2790>, '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 0x12d3690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3b20>, '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': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', '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 03:49:40 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 03:49:40 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 03:49:40 INFO - Using env: {'DISPLAY': ':0', 03:49:40 INFO - 'HOME': '/home/cltbld', 03:49:40 INFO - 'LANG': 'en_US.UTF-8', 03:49:40 INFO - 'LANGUAGE': 'en_US:en', 03:49:40 INFO - 'LOGNAME': 'cltbld', 03:49:40 INFO - 'MAIL': '/var/mail/cltbld', 03:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:40 INFO - 'MOZ_NO_REMOTE': '1', 03:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:40 INFO - 'NO_EM_RESTART': '1', 03:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:40 INFO - 'PWD': '/builds/slave/test', 03:49:40 INFO - 'SHELL': '/bin/bash', 03:49:40 INFO - 'SHLVL': '1', 03:49:40 INFO - 'TERM': 'linux', 03:49:40 INFO - 'TMOUT': '86400', 03:49:40 INFO - 'USER': 'cltbld', 03:49:40 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', 03:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:40 INFO - '_': '/tools/buildbot/bin/python'} 03:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:49:40 INFO - Running setup.py (path:/tmp/pip-SBHiMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:49:41 INFO - Running setup.py (path:/tmp/pip-sifdYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:49:41 INFO - Running setup.py (path:/tmp/pip-5OYk45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:49:41 INFO - Running setup.py (path:/tmp/pip-ZTSrWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:49:41 INFO - Running setup.py (path:/tmp/pip-C_roZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:49:41 INFO - Running setup.py (path:/tmp/pip-RjWFw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:49:41 INFO - Running setup.py (path:/tmp/pip-fFKVbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:49:41 INFO - Running setup.py (path:/tmp/pip-s330rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:49:41 INFO - Running setup.py (path:/tmp/pip-_xpZEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:49:41 INFO - Running setup.py (path:/tmp/pip-XG4V_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:49:41 INFO - Running setup.py (path:/tmp/pip-5MPuuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:49:41 INFO - Running setup.py (path:/tmp/pip-0QiO5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:49:41 INFO - Running setup.py (path:/tmp/pip-u4oKYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:49:41 INFO - Running setup.py (path:/tmp/pip-Gz5d9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:49:41 INFO - Running setup.py (path:/tmp/pip-uE6nzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:49:42 INFO - Running setup.py (path:/tmp/pip-kue6Ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:49:42 INFO - Running setup.py (path:/tmp/pip-VcXm8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:49:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:49:42 INFO - Running setup.py install for manifestparser 03:49:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:49:42 INFO - Running setup.py install for mozcrash 03:49:42 INFO - Running setup.py install for mozdebug 03:49:42 INFO - Running setup.py install for mozdevice 03:49:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:49:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:49:42 INFO - Running setup.py install for mozfile 03:49:42 INFO - Running setup.py install for mozhttpd 03:49:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:49:42 INFO - Running setup.py install for mozinfo 03:49:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:49:42 INFO - Running setup.py install for mozInstall 03:49:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:49:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:49:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:49:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:49:43 INFO - Running setup.py install for mozleak 03:49:43 INFO - Running setup.py install for mozlog 03:49:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:49:43 INFO - Running setup.py install for moznetwork 03:49:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:49:43 INFO - Running setup.py install for mozprocess 03:49:43 INFO - Running setup.py install for mozprofile 03:49:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:49:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:49:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:49:43 INFO - Running setup.py install for mozrunner 03:49:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:49:43 INFO - Running setup.py install for mozscreenshot 03:49:43 INFO - Running setup.py install for moztest 03:49:43 INFO - Running setup.py install for mozversion 03:49:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:49:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:49:43 INFO - Cleaning up... 03:49:43 INFO - Return code: 0 03:49:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:44 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 0x7fd36fc5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12437b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d2790>, '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 0x12d3690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3b20>, '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': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', '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 03:49:44 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 03:49:44 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 03:49:44 INFO - Using env: {'DISPLAY': ':0', 03:49:44 INFO - 'HOME': '/home/cltbld', 03:49:44 INFO - 'LANG': 'en_US.UTF-8', 03:49:44 INFO - 'LANGUAGE': 'en_US:en', 03:49:44 INFO - 'LOGNAME': 'cltbld', 03:49:44 INFO - 'MAIL': '/var/mail/cltbld', 03:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:44 INFO - 'MOZ_NO_REMOTE': '1', 03:49:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:44 INFO - 'NO_EM_RESTART': '1', 03:49:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:44 INFO - 'PWD': '/builds/slave/test', 03:49:44 INFO - 'SHELL': '/bin/bash', 03:49:44 INFO - 'SHLVL': '1', 03:49:44 INFO - 'TERM': 'linux', 03:49:44 INFO - 'TMOUT': '86400', 03:49:44 INFO - 'USER': 'cltbld', 03:49:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', 03:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:44 INFO - '_': '/tools/buildbot/bin/python'} 03:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:49:44 INFO - Running setup.py (path:/tmp/pip-UOsnM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:49:44 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)) 03:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:49:44 INFO - Running setup.py (path:/tmp/pip-xsGHUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:49:44 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)) 03:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:49:44 INFO - Running setup.py (path:/tmp/pip-n41Qt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:49:44 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)) 03:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:49:44 INFO - Running setup.py (path:/tmp/pip-gVZtlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:49:44 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)) 03:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:49:44 INFO - Running setup.py (path:/tmp/pip-Uv5Ujq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:49:44 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)) 03:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:49:44 INFO - Running setup.py (path:/tmp/pip-eDyhPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:49:44 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)) 03:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:49:44 INFO - Running setup.py (path:/tmp/pip-sFoDWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:49:44 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)) 03:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:49:44 INFO - Running setup.py (path:/tmp/pip-0ElH3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:49:44 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)) 03:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:49:44 INFO - Running setup.py (path:/tmp/pip-iHHHDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:49:44 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)) 03:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:49:44 INFO - Running setup.py (path:/tmp/pip-n3RaRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:49:44 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)) 03:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:49:44 INFO - Running setup.py (path:/tmp/pip-sf78me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:49:45 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)) 03:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:49:45 INFO - Running setup.py (path:/tmp/pip-r7bcBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:49:45 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)) 03:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:49:45 INFO - Running setup.py (path:/tmp/pip-nWOfm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:49:45 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)) 03:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:49:45 INFO - Running setup.py (path:/tmp/pip-1V_gLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:49:45 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)) 03:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:49:45 INFO - Running setup.py (path:/tmp/pip-g8LeFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:49:45 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)) 03:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:49:45 INFO - Running setup.py (path:/tmp/pip-ZDFnKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:49:45 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)) 03:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:49:45 INFO - Running setup.py (path:/tmp/pip-M8urpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:49:45 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)) 03:49:45 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)) 03:49:45 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)) 03:49:45 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)) 03:49:45 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)) 03:49:45 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)) 03:49:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:49:45 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 03:49:45 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 03:49:45 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 03:49:45 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 03:49:45 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 03:49:45 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 03:49:47 INFO - Downloading blessings-1.6.tar.gz 03:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:49:47 INFO - Installing collected packages: blessings 03:49:47 INFO - Running setup.py install for blessings 03:49:47 INFO - Successfully installed blessings 03:49:47 INFO - Cleaning up... 03:49:47 INFO - Return code: 0 03:49:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:49:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:49:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:49:47 INFO - Reading from file tmpfile_stdout 03:49:47 INFO - Current package versions: 03:49:47 INFO - argparse == 1.2.1 03:49:47 INFO - blessings == 1.6 03:49:47 INFO - blobuploader == 1.2.4 03:49:47 INFO - docopt == 0.6.1 03:49:47 INFO - functools32 == 3.2.3-2 03:49:47 INFO - jsonschema == 2.5.1 03:49:47 INFO - manifestparser == 1.1 03:49:47 INFO - mozInstall == 1.12 03:49:47 INFO - mozcrash == 0.17 03:49:47 INFO - mozdebug == 0.1 03:49:47 INFO - mozdevice == 0.48 03:49:47 INFO - mozfile == 1.2 03:49:47 INFO - mozhttpd == 0.7 03:49:47 INFO - mozinfo == 0.9 03:49:47 INFO - mozleak == 0.1 03:49:47 INFO - mozlog == 3.4 03:49:47 INFO - moznetwork == 0.27 03:49:47 INFO - mozprocess == 0.23 03:49:47 INFO - mozprofile == 0.28 03:49:47 INFO - mozrunner == 6.12 03:49:47 INFO - mozscreenshot == 0.1 03:49:47 INFO - mozsystemmonitor == 0.3 03:49:47 INFO - moztest == 0.7 03:49:47 INFO - mozversion == 1.4 03:49:47 INFO - psutil == 3.1.1 03:49:47 INFO - requests == 1.2.3 03:49:47 INFO - wsgiref == 0.1.2 03:49:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:49:47 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')]} 03:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:47 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')]} 03:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:47 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 0x7fd36fc5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12437b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d2790>, '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 0x12d3690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3b20>, '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': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', '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 03:49:47 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 03:49:47 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 03:49:47 INFO - Using env: {'DISPLAY': ':0', 03:49:47 INFO - 'HOME': '/home/cltbld', 03:49:47 INFO - 'LANG': 'en_US.UTF-8', 03:49:47 INFO - 'LANGUAGE': 'en_US:en', 03:49:47 INFO - 'LOGNAME': 'cltbld', 03:49:47 INFO - 'MAIL': '/var/mail/cltbld', 03:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:47 INFO - 'MOZ_NO_REMOTE': '1', 03:49:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:47 INFO - 'NO_EM_RESTART': '1', 03:49:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:47 INFO - 'PWD': '/builds/slave/test', 03:49:47 INFO - 'SHELL': '/bin/bash', 03:49:47 INFO - 'SHLVL': '1', 03:49:47 INFO - 'TERM': 'linux', 03:49:47 INFO - 'TMOUT': '86400', 03:49:47 INFO - 'USER': 'cltbld', 03:49:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', 03:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:47 INFO - '_': '/tools/buildbot/bin/python'} 03:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:48 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)) 03:49:48 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)) 03:49:48 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)) 03:49:48 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)) 03:49:48 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)) 03:49:48 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)) 03:49:48 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)) 03:49:48 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)) 03:49:48 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)) 03:49:48 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)) 03:49:48 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)) 03:49:48 INFO - Cleaning up... 03:49:48 INFO - Return code: 0 03:49:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:49:48 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')]} 03:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:48 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')]} 03:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:48 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 0x7fd36fc5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12437b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d2790>, '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 0x12d3690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3b20>, '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': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', '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 03:49:48 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 03:49:48 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 03:49:48 INFO - Using env: {'DISPLAY': ':0', 03:49:48 INFO - 'HOME': '/home/cltbld', 03:49:48 INFO - 'LANG': 'en_US.UTF-8', 03:49:48 INFO - 'LANGUAGE': 'en_US:en', 03:49:48 INFO - 'LOGNAME': 'cltbld', 03:49:48 INFO - 'MAIL': '/var/mail/cltbld', 03:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:48 INFO - 'MOZ_NO_REMOTE': '1', 03:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:48 INFO - 'NO_EM_RESTART': '1', 03:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:48 INFO - 'PWD': '/builds/slave/test', 03:49:48 INFO - 'SHELL': '/bin/bash', 03:49:48 INFO - 'SHLVL': '1', 03:49:48 INFO - 'TERM': 'linux', 03:49:48 INFO - 'TMOUT': '86400', 03:49:48 INFO - 'USER': 'cltbld', 03:49:48 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', 03:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:48 INFO - '_': '/tools/buildbot/bin/python'} 03:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:49:48 INFO - Cleaning up... 03:49:48 INFO - Return code: 0 03:49:48 INFO - Running post-action listener: _resource_record_post_action 03:49:48 INFO - Running post-action listener: _start_resource_monitoring 03:49:48 INFO - Starting resource monitoring. 03:49:48 INFO - [mozharness: 2016-10-04 10:49:48.321507Z] Finished create-virtualenv step (success) 03:49:48 INFO - [mozharness: 2016-10-04 10:49:48.322018Z] Running install step. 03:49:48 INFO - Running pre-action listener: _resource_record_pre_action 03:49:48 INFO - Running main action method: install 03:49:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:49:48 INFO - Reading from file tmpfile_stdout 03:49:48 INFO - Detecting whether we're running mozinstall >=1.0... 03:49:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:49:48 INFO - Reading from file tmpfile_stdout 03:49:48 INFO - Output received: 03:49:48 INFO - Usage: mozinstall [options] installer 03:49:48 INFO - Options: 03:49:48 INFO - -h, --help show this help message and exit 03:49:48 INFO - -d DEST, --destination=DEST 03:49:48 INFO - Directory to install application into. [default: 03:49:48 INFO - "/builds/slave/test"] 03:49:48 INFO - --app=APP Application being installed. [default: firefox] 03:49:48 INFO - mkdir: /builds/slave/test/build/application 03:49:48 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'] 03:49:48 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 03:50:05 INFO - Reading from file tmpfile_stdout 03:50:05 INFO - Output received: 03:50:05 INFO - /builds/slave/test/build/application/firefox/firefox 03:50:05 INFO - Running post-action listener: _resource_record_post_action 03:50:05 INFO - [mozharness: 2016-10-04 10:50:05.705533Z] Finished install step (success) 03:50:05 INFO - [mozharness: 2016-10-04 10:50:05.705775Z] Running run-tests step. 03:50:05 INFO - Running pre-action listener: _resource_record_pre_action 03:50:05 INFO - Running main action method: run_tests 03:50:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:50:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:50:05 INFO - Python 2.7.3 03:50:05 INFO - Return code: 0 03:50:05 INFO - grabbing minidump binary from tooltool 03:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:05 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 0x12d2790>, '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 0x12d3690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:50:05 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 03:50:05 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 03:50:05 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 03:50:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:50:05 INFO - Return code: 0 03:50:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:50:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:50:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:50:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:50:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:50:05 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://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 03:50:05 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://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 03:50:05 INFO - Using env: {'DISPLAY': ':0', 03:50:05 INFO - 'HOME': '/home/cltbld', 03:50:05 INFO - 'LANG': 'en_US.UTF-8', 03:50:05 INFO - 'LANGUAGE': 'en_US:en', 03:50:05 INFO - 'LOGNAME': 'cltbld', 03:50:05 INFO - 'MAIL': '/var/mail/cltbld', 03:50:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:50:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:05 INFO - 'MOZ_NO_REMOTE': '1', 03:50:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:50:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:05 INFO - 'NO_EM_RESTART': '1', 03:50:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:05 INFO - 'PWD': '/builds/slave/test', 03:50:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:50:05 INFO - 'SHELL': '/bin/bash', 03:50:05 INFO - 'SHLVL': '1', 03:50:05 INFO - 'TERM': 'linux', 03:50:05 INFO - 'TMOUT': '86400', 03:50:05 INFO - 'USER': 'cltbld', 03:50:05 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668', 03:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:05 INFO - '_': '/tools/buildbot/bin/python'} 03:50:05 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://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 03:50:05 INFO - mozversion application_buildid: 20161004003016 03:50:05 INFO - mozversion application_changeset: f927dc3ad86478c7b54507fa8cf862cff4f372b4 03:50:05 INFO - mozversion application_display_name: Nightly 03:50:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:50:05 INFO - mozversion application_name: Firefox 03:50:05 INFO - mozversion application_remotingname: firefox 03:50:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:50:05 INFO - mozversion application_vendor: Mozilla 03:50:05 INFO - mozversion application_version: 52.0a1 03:50:05 INFO - mozversion platform_buildid: 20161004003016 03:50:05 INFO - mozversion platform_changeset: f927dc3ad86478c7b54507fa8cf862cff4f372b4 03:50:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:50:05 INFO - mozversion platform_version: 52.0a1 03:50:05 INFO - using testdate: 1475578205 03:50:05 INFO - actual date: 1475578205 03:50:05 INFO - starting webserver on 'localhost:49332' 03:50:05 INFO - SUITE-START | Running 2 tests 03:50:05 INFO - TEST-START | dromaeo_css 03:50:05 INFO - operating with platform_type : linux_ 03:50:05 INFO - Initialising browser for dromaeo_css test... 03:50:05 INFO - TEST-INFO | started process 2233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvtyI3q/profile http://localhost:49332/getInfo.html) 03:50:10 INFO - PROCESS | 2233 | __metrics Screen width/height:1600/1200 03:50:10 INFO - PROCESS | 2233 | colorDepth:24 03:50:10 INFO - PROCESS | 2233 | Browser inner width/height: 1024/697 03:50:10 INFO - PROCESS | 2233 | __metrics 03:50:10 INFO - PROCESS | 2233 | 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" 03:50:10 INFO - PROCESS | 2233 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:50:11 INFO - PROCESS | 2233 | console.error: PushService: 03:50:11 INFO - PROCESS | 2233 | stateChangeProcessEnqueue: Error transitioning state 03:50:11 INFO - PROCESS | 2233 | UnknownError 03:50:12 INFO - TEST-INFO | 2233: exit 0 03:50:12 INFO - Browser initialized. 03:50:12 INFO - Running cycle 1/1 for dromaeo_css test... 03:50:12 INFO - TEST-INFO | started process 2313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvtyI3q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:24 INFO - PROCESS | 2313 | RSS: Main: 173621248 03:50:24 INFO - PROCESS | 2313 | 03:51:15 INFO - PROCESS | 2313 | 1475578275751 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] 03:53:26 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:49332/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49332/tests/dromaeo/cssquery-ext.html) 03:53:27 INFO - PROCESS | 2313 | RSS: Main: 275091456 03:53:27 INFO - PROCESS | 2313 | 03:56:30 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:49332/tests/dromaeo/cssquery-ext.html (next: http://localhost:49332/tests/dromaeo/cssquery-jquery.html) 03:56:30 INFO - PROCESS | 2313 | RSS: Main: 278790144 03:56:30 INFO - PROCESS | 2313 | 03:59:32 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:49332/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49332/tests/dromaeo/cssquery-mootools.html) 03:59:33 INFO - PROCESS | 2313 | RSS: Main: 217128960 03:59:33 INFO - PROCESS | 2313 | 04:02:35 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:49332/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49332/tests/dromaeo/cssquery-prototype.html) 04:02:35 INFO - PROCESS | 2313 | RSS: Main: 234848256 04:02:35 INFO - PROCESS | 2313 | 04:05:38 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:49332/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49332/tests/dromaeo/cssquery-yui.html) 04:05:39 INFO - PROCESS | 2313 | RSS: Main: 217698304 04:05:39 INFO - PROCESS | 2313 | 04:08:41 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:49332/tests/dromaeo/cssquery-yui.html (next: http://localhost:49332/tests/dromaeo/cssquery-dojo.html) 04:08:42 INFO - PROCESS | 2313 | RSS: Main: 311451648 04:08:42 INFO - PROCESS | 2313 | 04:08:42 INFO - PROCESS | 2313 | __start_tp_report 04:08:42 INFO - PROCESS | 2313 | _x_x_mozilla_page_load 04:08:42 INFO - PROCESS | 2313 | _x_x_mozilla_page_load_details 04:08:42 INFO - PROCESS | 2313 | |i|pagename|runs| 04:08:42 INFO - PROCESS | 2313 | |0;dojo.html;3057.7248047675707;3083.0596668016246;3101.472749632563;3121.8751249950005;3137.1843320736602;5211.140161873296;5289.3123893893835;5360.5443537299325;5432.402435732071;5476.014317422867;5332;5336.066188417031;5412.810551630694;5420.945790542093;5437.238786569884;4838.63710221733;4866.294387313837;4902.3872015998;4910.680805747633;4937.407511098673;4887.975560122212;5020.447750747433;5032.396112466491;5032.773525191357;5096.592272618182;4767.928481072787;4945.604351651859;4967.602591792666;4967.652264341497;5054.924176137342;4789.137955168068;4825.469198388175;4889.902201955941;4902.4852390498845;4980.327655766461;4846.830360937351;4849.515048495157;4857.878553036167;4870.65905386623;4947.109520286383;5350.30446042016;5355.732213389315;5357.4374690657305;5357.651752636105;5363.678179309215;5548.667079975174;5572.832815015556;5589.776408943638;5683.857903552403;5748.109043098327;5691.203231547586;5704.71476426177;5704.971475142598;5707.343655479632;5711.885762284731;5297.682139071707;5299.947000530023;5309.150535914274;5335.599830012765;5345.118055520796;5843.678597677169;5899.115132730125;5904.911426328608;5957;5963.880722385528;5671.319441667027;5679.432056794288;5680.573956953245;5682.204491371212;5689.288838895138;5568.387477377485;5627;5743.310802703619;5746.913796293059;5752.597318187771;5585.69278689676;5626.859328516738;5628.183913332544;5650.463205995424;5721.828345149652;5676.120201368794;5677;5677.261955945701;5681;5741.19623252745;4308.80610372534;4387.692861499728;4392.758398288061;4398.758068306274;4438.778061096932;3876.9418458723144;3890.9416358754643;3937.0354263205127;3953.9802300988313;3977.4033894915992;5405;5407.729613519308;5410;5412.052890744104;5474.178873168977;5744.684042377709;5777.8555536111935;5779.855503612359;5781.103928891029;5784.074548072288;5204.479552044765;5251.422343542207;5260.658057226268;5348.652337598043;5436.238926550286;4914.213725803926;4925.1873440881855;4934.062528119646;4970.776315065831;4979.502049794992;5750.7987220447085;5829.300483941869;5861.853453663693;5863.677497737665;5921.4966727826895;5613.887722245614;5661.971690141523;5696.857578560569;5704.600677952503;5755.539556835527;5826.805504871576;5885.646861188342;5886.646801191942;5932.762689492372;5941.37615550361;5677.68772717488;5685.744141513725;5687.9431205687415;5694.373618902;5700.201971723879;5607.915881261702;5671.206031155559;5789.9710501447225;5793.768249269982;5800.622959507618;5510.448955104457;5520.309961254843;5541.861453463695;5560.91658625129;5585.720713964204;5476.80831170923;5506.063969125338;5512.476314750093;5518.724063796713;5563.693996830213;5434.402215756343;5496.697681627549;5559.555235581063;5573.303337082864;5630.577706671934;5526.861828454321;5592.69240191777;5634.577406694432;5639.520640745583;5714.942850571441;5489.533389661923;5537.141743029837;5543.77824887;5544.972275138599;5604.131359639263 04:08:42 INFO - PROCESS | 2313 | |1;ext.html;555.9240953386466;568.3776264989837;600.1867469578724;600.849787553112;604.9516038716902;32023.51964720528;42788.786056069715;43645.12709745803;43657.56342436575;43694.99999999996;45113.32330015052;45591.31613025807;45591.31613025807;45610.31584526235;45634.7718261409;8113.107558168596;8984.505852178128;9136.954315228415;9138.63445462184;9146.131117543857;7901.762947111567;10523.421211833345;10759.193060520452;10767.676969690921;11149.442527873614;11145.16411269158;11184.664460066171;11207.271527350696;11223.494942727597;11225.550977960871;10955.233133680606;11025.889741102566;11029.83455248172;11030.28303160292;11041.503132359023;10746.140308775279;10805.405702686348;10811.83782243267;10817.891821081847;10824;42905.141897161884;43154.35268470975;43198.56801431977;43239.13521729548;43269.56730432687;3499.7375196860085;3533.8586456541707;3653.8355773990234;3658.981705091484;3701.5373078365205;31676.841615792004;31953;32171.35657286841;32183.356332873445;33505.497417538754;3780.092777733324;3923.117298607819;3936.075022369741;4018.357062869956;4111.602055301212;330264;330527.9999999976;330618.9999999976;331334;331359;35048.64951350505;36105.277894442486;36177.27645447129;58771.70614146902;58949.642014319805;37654.811725941196;37746.43380349297;37793.244135117144;37807.81096094502;37817.24365512729;14868.405263789327;14885;15012.249387530579;15026;15044.172570508726;11375.829362559569;11627.12796540263;11905.702357441134;11932.343721095423;12254.08094392924;8512.616932237941;8578.227959483676;8669.869951950726;8721.389502734748;8737.737867863974;3235.514672799099;3305.2397948471985;3323.7008669219886;3326.86692532296;3386.779859309137;1016.872890888639;1063.574570171922;1067.7010437077631;1067.9305845120043;1092.639428988432;31507;32251.35497290088;32443;32718.345633087203;32960.505592416135;1098.6319582939805;1125.139268459629;1125.9380734059541;1137.3858116616934;1217.1784045769248;16763.078030708428;16777;16962.15189240533;17019.242737297904;17129.48611541656;506952;511650;516102;516531;520973;49631;50112.498875011515;50171.49828501741;50176.49823501791;50227.24659130116;1220.7558488302197;1227.1777908801125;1280.295837289487;1284.7366289910733;1286.1897004886862;28954.565681515214;33074.66925330716;33186.66813331933;33350.499742503394;33702;54885;56856;56908.43091569031;61515.38484615096;61525;513111;516793;517427;518243;518547;27874.303142421602;28072;28173.859130704215;29921.55117673193;39887;46585.767071164424;46659;46796;46934.530654693015;47590.524094758606;38876;39748.602513975646;39928.40107398333;40762.59237407707;41707.37438938358;39640.60359396484;39849.40225896672;40843.795781020905;40995.590044099175;41884.371734423396;40268.39597405983;40658;41652.375214371204;41812.79093604512;44849.327260090475;32912.67087329096;36742.63257367392;37030.259394811415;37425.43861842129;37636.24727505489;27277;27799;27808.304792380353;28079;28113.578296325162 04:08:42 INFO - PROCESS | 2313 | |2;jquery.html;376.1855582663534;392.88999080257537;404.89270343359004;406.1045394904236;416.6625033722685;13154.473821047159;14843.480478183252;18388.540286492844;18507.444776656706;19268.90365548174;18232.72650910234;18514.62970740588;18576.628467430644;18721;18747;5494.0934745767;5711.228984087157;5721.570882183832;5722.79970201043;5725.341585717633;3812.237552489499;4028.5769994150633;5445.319335083114;5466.371367292772;5712.314522257335;5647.407022262665;5671.574631902603;5732.914006289888;5750.511206547449;5754.108113242454;5570.136628822539;5676.631018983773;5733.455321744427;5736.655800651933;5764.250647415851;5531.944680553183;5534.446555344473;5535.280413546254;5535.667859928417;5544.805931792368;12480.313582752944;12519.186252893624;12749.235045897183;12775.48898044077;12800.359982000957;2203.173879202221;2231.319447568491;2271.046160612547;2342.5900467418132;2785;9239.214666753334;9426.245900328026;9489.525523723854;9857.852132218022;10089.848652270222;1892.4795681187645;1902.3817259390753;1937.6124775044907;1953.1601411393094;1971.9014049297477;74391;77004;77157.61421192858;78121.60939195268;78393;10000.299979001546;10634;10740.409277489813;10797.892021079846;10966.396848173426;15055.774163387558;15056.247187640574;15077.396904123712;15079.773803392958;15100.39598416051;7295.52579082358;7838.137804841463;7870.606469676493;7921.049474063149;8064.354851611857;7332.8900066499045;7366.410687145016;7591.848163036819;7615.7334493292465;7626.122995855437;4512.72923624577;4540.296254080623;4594.379758732595;4680.438347398334;4746.216874215785;1793.5247159502742;1833.8759296317442;1837.9697656463811;1894.435898323704;1958.8726732762325;819.2749416766205;955.0786753474047;959.5633986536249;1007.4861820471613;1037.3983089807894;16952.830471695124;18190.18144183515;18205.54486137857;18250.407729257953;18417;947.4599478297305;955.1642312976146;958.2046901072093;973.3964941736027;980.132582664333;9655.22758179344;9961.302708810459;10167.389956602627;10205.234607404325;10231.28381013322;425855;427223;429117;431079;439769;85682.57158714166;87303.56348218219;88474;88562;89350;965.8454647256406;1001.2290536287164;1003.9609004680121;1028.747956750601;1029.7528593137743;15646.608834779221;16201.270942807367;16578.50264492067;16595.419160329813;16679.83320166783;38469;38777.03057423587;38855;40266;40273.59726402698;53779.731101344245;53837.46162538324;54854.45145548653;55190.89618207694;56274.43725562692;7876.291133797757;8006.679732810622;8260.586970651324;8372.455790373606;8373.706920257762;12086.093542984487;12460.937695311828;12638.115331926678;13119.540816071392;13183.340832958505;10354.5340459678;10497.475126243504;10565.52455139536;10810.135189185004;11447.141464390037;10544.209184311361;10901.34591924487;10910.563577457131;10979.560817567528;11017.283876548;10661.733456663645;10721.946390267998;10836.13310935139;10952.890471095187;11147.108231341635;7768.30937372009;7957.403194760301;8007.799805004922;8062;8359;10728.356298622108;10751.086157676686;10801.24391292602;11034.117270618492;11206.663800086011 04:08:42 INFO - PROCESS | 2313 | |3;mootools.html;1407.8029075929371;1425.2944792327798;1563.257452709963;1675.4052311429434;1754.4298103116482;7817.491863028899;8089.433739638228;8329.500229986197;8855.690050848221;8876.467411955278;8338.91661083389;8583.141685831413;8656.307495400368;8899.15458031486;8899.73300800977;2273.499830037393;2289.164454973931;2289.8626082435026;2300.0454811253308;2303.3090072978125;1950.9707354389695;2004.98997505013;2229.7770222977733;2258.9096436142536;2279.2934190400947;2225.532638145983;2284.166279308049;2284.6915666385075;2296.4718114833513;2299.5285966376937;2202.537467131904;2222.9110835566557;2245.438640339915;2254.030766770288;2265.0147185974156;2228.944276393087;2228.9746716510426;2232.307984524786;2239.1155493579945;2242.7196600424945;8671.4363566368;8732.476051436934;8735.43219690718;8735.650573977033;8745.868811967826;5107.540321371094;5276.630635855492;5315.202719592092;5320.5211530962015;5323.387810401776;3382.2220889195623;3527.9294414111573;3586.8385922633543;3590.838412271428;3628.8548458061646;1036.5180191211123;1078.660222030058;1086.6033897627387;1102.895224953628;1126.1947707389256;12285.877141228562;12322.075844311712;12332.876671233262;12350.567730129493;12377.319247441386;4375.562443755599;4670.206064968964;4735.881602959885;4740.549647783455;4767.6662633615315;10216.284860059724;10238.385696858213;10259.384436933658;10272.486375681186;10272.589096436208;5350.892982140414;5355.651882627694;5368.597355198376;5373.113436283048;5378.623496355218;4729.95270047302;4806.735629540409;4922.753862306942;4943.307936888838;4945.159322915113;3689.2990331836863;3710.5361829771277;3717.7397582168987;3819.9427008594894;3840.9615903841163;1056.3292309383596;1075.3440401355167;1147.3402793393666;1156.2137746332407;1171.8652354979115;782.3506489613607;933.2906990687127;940.210223412337;967.5404183013153;972.8005758819567;5753.597248192586;5756.884862302731;5770.307563092372;5809.099589563624;5849.970750146307;951.0632027452954;956.1442508954447;959.2134449751277;964.2719746591279;978.1929907826072;3879.321118804198;4036.3138266494766;4048.1701251243426;4099.077707515785;4103.7742924138865;10705.9464702676;11153.330800152016;11157.66527004191;11172.664820055412;11173.385463799568;10906.781864362669;11108;11123.944380278208;11124.38815865119;11166.888331116585;8096.51420914747;8269.04905935825;8362.163783621589;8365.790855228546;8371.916280837113;5816.534677225896;5864.266966629171;5866.853328666817;5918.408159184047;6043.456088952015;9967.352122112039;10097.343672661253;10163.796724065625;10177.694669159937;10218.131458825786;10291.176705863663;10361.533730981973;10437.843432348369;10473.371597704163;10485.213608979204;7298.452616053711;7317.9754834322175;7338.96330518344;7340.779776606711;7360.374368178551;8182.713605023796;8271.917280827114;8339.916600834156;8377.994640643163;8393.580320984049;6635.834104147435;7373.29953654402;7430.517016393917;7573.431992600466;7641.159472457914;7505.587192704235;7526.698932042657;7549.810554939007;7556.282153195438;7688.423368247292;6716.093327400738;6767.966160169168;6780.864382712417;6811.148606424197;6815.488838337045;5001.57486613642;5113.8977220454635;5131.255967884561;5172.301739265302;5224.2947202127225;5026.648134630541;5126.7180305083575;5198.792048318025;5297.761600728054;5298.496642818926 04:08:42 INFO - PROCESS | 2313 | |4;prototype.html;326.4286094819277;339.6162336559688;340.83810190159693;344.66395264617;344.68977919872094;5079.238114282859;5202.193659982704;5211.635185537005;5265.921011184831;5273.967468705495;4994.275830004647;5128.53843154116;5163.392486794164;5177.239738488913;5192.429747275095;4116.547179810218;4125.216208920303;4125.422440858282;4125.9174816503655;4133.937990930139;3874.1283211277378;3883.9223215535812;4115.341545352744;4118.485189351331;4120.484939382577;4128.876133715993;4130.566290539495;4136.648384887289;4144.21259960608;4152.2733521633745;4119.938200926988;4125.318542947079;4131.690123240754;4133.400656904762;4140.234056699505;3679.1537946272238;3702.9629703702885;3712.535933008374;3713.294474049949;3718.9442158367647;4858.809591650033;5102.489751024905;5123.769430375642;5128.461511541309;5131.692098474104;4666.580007799314;4668.346431499593;4672.556107169813;4672.766361681936;4684;5290.256146222159;5453.345598528163;5479.890402191973;5482.698451585161;5500.669959802424;3864.3044252034624;3893.6301051400355;3894.104355998108;3900.531936167678;3902.8829135125993;5655.971720141414;5670.845078870003;5695.259616249902;5705.4294570543025;5721.71391430431;4082.8366865325056;4083.714140010171;4086.427900093989;4088.9386659200136;4091.2840252956207;4026.363091671683;4082.6121518455698;4095.713300069026;4150.481189851269;4177.811998460016;4712.811487540528;4713.670043097019;4721.763911804396;4728.1252968201;4741.241401375763;5490.588205884575;5523.861903452445;5524.309461317335;5536.7819079802375;5540.750666220029;1367.446184295362;1423.9074460160057;1425.5865798918405;1435.8584924984455;1442.9610680310159;881.9735407937773;904.7511934218143;909.8225845959975;914.7895983923735;915.8397280476023;4643.373144625432;4643.419572553431;4689.859304220879;4690.835820746258;4692.718436893729;4942.57988071018;4951.579115775127;4985.800567977313;5013.348264725635;5020.322256495399;4481.775911204427;4694.50707675696;4706.364640773451;4745.572898439088;4750.501197374226;2633.6181253718105;2637;2639.973600263973;2646.563317052665;2649.629051932731;4991.500849915052;5010.724410157476;5014.84955451337;5015.27278544609;5018.5232402921665;4814;4921.335619691367;5029.698218106852;5036.169032109734;5046.722430266297;5000.849974500771;5008.84973450797;5013.39839219296;5015.598752099823;5018.573421259161;4845.5881250094135;4911.705297682151;4917.868890155356;4942.975285123552;4954.950450495449;4695.788689508912;4846.80612775485;4873.659743570546;4896.4124305083615;4946.851594452172;4980.775865086152;5024.371953505812;5031.597472202142;5044.949550504448;5049.924251136163;3716.1824398632257;3737.9626203737616;3741.214344987583;3783.1866148778145;3914.8629797956933;5471.6169868108855;5602.011285993413;5682.982541197981;5683.175939488834;5696.629719068247;5440.4015558287765;5483.505005222694;5502.944970550243;5505.733681253254;5559.694216818114;5296.788128474818;5451.3458384994055;5506.449355064622;5511.834644960658;5513.145462453166;5394.406615272395;5452.854900470787;5462.3445186577865;5479.972600136974;5482.506574408322;5409.188621706776;5567.805126820542;5579.330480342385;5580.748866301107;5592.309076009977;5367.194920761761;5403.378611459732;5406.24312596229;5413.242146099628;5466.480684334982 04:08:42 INFO - PROCESS | 2313 | |5;yui.html;623.1120653069377;662.8773676869778;684.407987091166;718.2817182817183;723.9601821899794;13639.590812275623;14806.185659788707;14891.329890154942;14958.700825983473;15016.849831501682;14151.363188656509;14275.286235688225;14291.785623215634;14295.571132866005;14317.355718992645;653.1737352249409;660.6003367962362;740.4261697184671;789.4513313247295;789.8459800338936;805.5005896344275;820.8686610142379;822.498276051611;823.2508417340222;823.5799742131526;848.7962888906649;851.5061264466594;852.1606217875387;852.3266619370721;852.5012867472536;851.642310229705;852.3862818770475;852.4288726553224;853.714005808055;854.0434713121313;616.5684021185189;617.7374615788317;618.072890664004;618.6010023534794;618.7401291457599;14395.064320819114;14462.638434039129;14509.201993890332;14520.782188267185;14523.491677791333;15471.613209669737;15558.844411555965;15608.843911560853;15661.530154095395;15674.451394201262;10218.335808172445;10370.792584148276;10387.27289089764;10540.468942904135;10887.510062047228;3645.0887278180453;3671.73626199192;3685.7051435885064;3760.1163726524246;3793.829277682511;77181.22818771796;78793.60603197005;78810.60594697048;78925.60537197278;84125.57937210336;11010.669679909615;11271.416138256869;11295.49170287339;11358.148138889615;11658.53365865356;22272.220472283392;22315;22433.775662243494;22505.774942250697;23264.06943722266;7767;7859;7906.130325664172;7906.446548741533;8149.551774652333;4560.498345182027;4565.863024109282;4688.085823264499;4736.052789442126;4740.45484769249;3493;3588.2285308658766;3605.6935160511125;3605.801680907523;3608.0619039050034;651.9674016299166;656.0880376276979;669.0666520204288;676.1784431915148;691.2258270736706;642.2646070249538;646.9450096741735;648.5719425179359;665.9600423974578;678.5352033856824;8426.283765879969;8796.736097917073;8825;8843.778905527284;9081.049743361658;626.0577830365271;627.7645882793952;679.171410878737;681.9215790184193;685.5715178013742;4230.61924426803;4296.269634162138;4422.159789639958;4423.845165419195;5209.921851172236;81145.59427202826;110982.44508777405;111691.44154279177;115413;120045;63428.36571634225;66348.33651663421;69261;95461.52269238749;106244;47877.28184077242;79683;83159;84232.57883710664;84736.99999999876;8937.46375217489;8991.55042247898;9406.38858474197;9539.379940303857;9835.557399916877;48911.5108848907;49510.257346139115;50106.74946625243;50378.244326335865;51231.74384128056;63035.68482157743;70398;71378.64310678413;73376.63311683621;74460.62769686116;12212.75574488523;13042.608721738363;13097.41061652247;13113.475460981454;13594.45622175102;14920.253987300375;15069.54791356261;15162.166080865658;15185.16481593523;15561.844381556493;12902.161359511601;13212.811515790112;13856.4457421702;13949.16305021702;14321.14073155614;12543.3101179436;12682.87317126817;12781.16922400041;12854.485820567073;12979.870201298243;12271.877281227073;13084.411201496147;13104.934475327562;13137.802932956205;13519.526816561372;10338.933922378132;10574.689826302729;10701.250912436055;10873.673789786319;11069.007578635923;9086.954565227396;9594.313297758075;10503.842442363524;10971.286866353661;11388.772224555629 04:08:42 INFO - PROCESS | 2313 | __end_tp_report 04:08:42 INFO - PROCESS | 2313 | __start_cc_report 04:08:42 INFO - PROCESS | 2313 | _x_x_mozilla_cycle_collect,1314 04:08:42 INFO - PROCESS | 2313 | __end_cc_report 04:08:42 INFO - PROCESS | 2313 | __startTimestamp1475579322204__endTimestamp 04:08:42 INFO - PROCESS | 2313 | 04:08:42 INFO - PROCESS | 2313 | ------- Summary: start ------- 04:08:42 INFO - PROCESS | 2313 | Number of tests: 6 04:08:42 INFO - PROCESS | 2313 | 04:08:42 INFO - PROCESS | 2313 | [#0] dojo.html Cycles:165 Average:5315.98 Median:5518.72 stddev:590.36 (10.7%) stddev-sans-first:564.96 04:08:42 INFO - PROCESS | 2313 | Values: 3057.7 3083.1 3101.5 3121.9 3137.2 5211.1 5289.3 5360.5 5432.4 5476.0 5332.0 5336.1 5412.8 5420.9 5437.2 4838.6 4866.3 4902.4 4910.7 4937.4 4888.0 5020.4 5032.4 5032.8 5096.6 4767.9 4945.6 4967.6 4967.7 5054.9 4789.1 4825.5 4889.9 4902.5 4980.3 4846.8 4849.5 4857.9 4870.7 4947.1 5350.3 5355.7 5357.4 5357.7 5363.7 5548.7 5572.8 5589.8 5683.9 5748.1 5691.2 5704.7 5705.0 5707.3 5711.9 5297.7 5299.9 5309.2 5335.6 5345.1 5843.7 5899.1 5904.9 5957.0 5963.9 5671.3 5679.4 5680.6 5682.2 5689.3 5568.4 5627.0 5743.3 5746.9 5752.6 5585.7 5626.9 5628.2 5650.5 5721.8 5676.1 5677.0 5677.3 5681.0 5741.2 4308.8 4387.7 4392.8 4398.8 4438.8 3876.9 3890.9 3937.0 3954.0 3977.4 5405.0 5407.7 5410.0 5412.1 5474.2 5744.7 5777.9 5779.9 5781.1 5784.1 5204.5 5251.4 5260.7 5348.7 5436.2 4914.2 4925.2 4934.1 4970.8 4979.5 5750.8 5829.3 5861.9 5863.7 5921.5 5613.9 5662.0 5696.9 5704.6 5755.5 5826.8 5885.6 5886.6 5932.8 5941.4 5677.7 5685.7 5687.9 5694.4 5700.2 5607.9 5671.2 5790.0 5793.8 5800.6 5510.4 5520.3 5541.9 5560.9 5585.7 5476.8 5506.1 5512.5 5518.7 5563.7 5434.4 5496.7 5559.6 5573.3 5630.6 5526.9 5592.7 5634.6 5639.5 5714.9 5489.5 5537.1 5543.8 5545.0 5604.1 04:08:42 INFO - PROCESS | 2313 | 04:08:42 INFO - PROCESS | 2313 | [#1] ext.html Cycles:180 Average:60116.67 Median:3656.41 stddev:122932.72 (3362.1%) stddev-sans-first:123196.24 04:08:42 INFO - PROCESS | 2313 | Values: 555.9 568.4 600.2 600.8 605.0 32023.5 42788.8 43645.1 43657.6 43695.0 45113.3 45591.3 45591.3 45610.3 45634.8 8113.1 8984.5 9137.0 9138.6 9146.1 7901.8 10523.4 10759.2 10767.7 11149.4 11145.2 11184.7 11207.3 11223.5 11225.6 10955.2 11025.9 11029.8 11030.3 11041.5 10746.1 10805.4 10811.8 10817.9 10824.0 42905.1 43154.4 43198.6 43239.1 43269.6 3499.7 3533.9 3653.8 3659.0 3701.5 31676.8 31953.0 32171.4 32183.4 33505.5 3780.1 3923.1 3936.1 4018.4 4111.6 330264.0 330528.0 330619.0 331334.0 331359.0 35048.6 36105.3 36177.3 58771.7 58949.6 37654.8 37746.4 37793.2 37807.8 37817.2 14868.4 14885.0 15012.2 15026.0 15044.2 11375.8 11627.1 11905.7 11932.3 12254.1 8512.6 8578.2 8669.9 8721.4 8737.7 3235.5 3305.2 3323.7 3326.9 3386.8 1016.9 1063.6 1067.7 1067.9 1092.6 31507.0 32251.4 32443.0 32718.3 32960.5 1098.6 1125.1 1125.9 1137.4 1217.2 16763.1 16777.0 16962.2 17019.2 17129.5 506952.0 511650.0 516102.0 516531.0 520973.0 49631.0 50112.5 50171.5 50176.5 50227.2 1220.8 1227.2 1280.3 1284.7 1286.2 28954.6 33074.7 33186.7 33350.5 33702.0 54885.0 56856.0 56908.4 61515.4 61525.0 513111.0 516793.0 517427.0 518243.0 518547.0 27874.3 28072.0 28173.9 29921.6 39887.0 46585.8 46659.0 46796.0 46934.5 47590.5 38876.0 39748.6 39928.4 40762.6 41707.4 39640.6 39849.4 40843.8 40995.6 41884.4 40268.4 40658.0 41652.4 41812.8 44849.3 32912.7 36742.6 37030.3 37425.4 37636.2 27277.0 27799.0 27808.3 28079.0 28113.6 04:08:42 INFO - PROCESS | 2313 | 04:08:42 INFO - PROCESS | 2313 | [#2] jquery.html Cycles:180 Average:26293.75 Median:20329.44 stddev:71252.76 (350.5%) stddev-sans-first:71426.07 04:08:42 INFO - PROCESS | 2313 | Values: 376.2 392.9 404.9 406.1 416.7 13154.5 14843.5 18388.5 18507.4 19268.9 18232.7 18514.6 18576.6 18721.0 18747.0 5494.1 5711.2 5721.6 5722.8 5725.3 3812.2 4028.6 5445.3 5466.4 5712.3 5647.4 5671.6 5732.9 5750.5 5754.1 5570.1 5676.6 5733.5 5736.7 5764.3 5531.9 5534.4 5535.3 5535.7 5544.8 12480.3 12519.2 12749.2 12775.5 12800.4 2203.2 2231.3 2271.0 2342.6 2785.0 9239.2 9426.2 9489.5 9857.9 10089.8 1892.5 1902.4 1937.6 1953.2 1971.9 74391.0 77004.0 77157.6 78121.6 78393.0 10000.3 10634.0 10740.4 10797.9 10966.4 15055.8 15056.2 15077.4 15079.8 15100.4 7295.5 7838.1 7870.6 7921.0 8064.4 7332.9 7366.4 7591.8 7615.7 7626.1 4512.7 4540.3 4594.4 4680.4 4746.2 1793.5 1833.9 1838.0 1894.4 1958.9 819.3 955.1 959.6 1007.5 1037.4 16952.8 18190.2 18205.5 18250.4 18417.0 947.5 955.2 958.2 973.4 980.1 9655.2 9961.3 10167.4 10205.2 10231.3 425855.0 427223.0 429117.0 431079.0 439769.0 85682.6 87303.6 88474.0 88562.0 89350.0 965.8 1001.2 1004.0 1028.7 1029.8 15646.6 16201.3 16578.5 16595.4 16679.8 38469.0 38777.0 38855.0 40266.0 40273.6 53779.7 53837.5 54854.5 55190.9 56274.4 7876.3 8006.7 8260.6 8372.5 8373.7 12086.1 12460.9 12638.1 13119.5 13183.3 10354.5 10497.5 10565.5 10810.1 11447.1 10544.2 10901.3 10910.6 10979.6 11017.3 10661.7 10721.9 10836.1 10952.9 11147.1 7768.3 7957.4 8007.8 8062.0 8359.0 10728.4 10751.1 10801.2 11034.1 11206.7 04:08:42 INFO - PROCESS | 2313 | 04:08:42 INFO - PROCESS | 2313 | [#3] mootools.html Cycles:180 Average:5750.74 Median:4864.74 stddev:3309.59 (68.0%) stddev-sans-first:3302.78 04:08:42 INFO - PROCESS | 2313 | Values: 1407.8 1425.3 1563.3 1675.4 1754.4 7817.5 8089.4 8329.5 8855.7 8876.5 8338.9 8583.1 8656.3 8899.2 8899.7 2273.5 2289.2 2289.9 2300.0 2303.3 1951.0 2005.0 2229.8 2258.9 2279.3 2225.5 2284.2 2284.7 2296.5 2299.5 2202.5 2222.9 2245.4 2254.0 2265.0 2228.9 2229.0 2232.3 2239.1 2242.7 8671.4 8732.5 8735.4 8735.7 8745.9 5107.5 5276.6 5315.2 5320.5 5323.4 3382.2 3527.9 3586.8 3590.8 3628.9 1036.5 1078.7 1086.6 1102.9 1126.2 12285.9 12322.1 12332.9 12350.6 12377.3 4375.6 4670.2 4735.9 4740.5 4767.7 10216.3 10238.4 10259.4 10272.5 10272.6 5350.9 5355.7 5368.6 5373.1 5378.6 4730.0 4806.7 4922.8 4943.3 4945.2 3689.3 3710.5 3717.7 3819.9 3841.0 1056.3 1075.3 1147.3 1156.2 1171.9 782.4 933.3 940.2 967.5 972.8 5753.6 5756.9 5770.3 5809.1 5850.0 951.1 956.1 959.2 964.3 978.2 3879.3 4036.3 4048.2 4099.1 4103.8 10705.9 11153.3 11157.7 11172.7 11173.4 10906.8 11108.0 11123.9 11124.4 11166.9 8096.5 8269.0 8362.2 8365.8 8371.9 5816.5 5864.3 5866.9 5918.4 6043.5 9967.4 10097.3 10163.8 10177.7 10218.1 10291.2 10361.5 10437.8 10473.4 10485.2 7298.5 7318.0 7339.0 7340.8 7360.4 8182.7 8271.9 8339.9 8378.0 8393.6 6635.8 7373.3 7430.5 7573.4 7641.2 7505.6 7526.7 7549.8 7556.3 7688.4 6716.1 6768.0 6780.9 6811.1 6815.5 5001.6 5113.9 5131.3 5172.3 5224.3 5026.6 5126.7 5198.8 5297.8 5298.5 04:08:42 INFO - PROCESS | 2313 | 04:08:42 INFO - PROCESS | 2313 | [#4] prototype.html Cycles:180 Average:4440.43 Median:4942.78 stddev:1271.88 (25.7%) stddev-sans-first:1237.40 04:08:42 INFO - PROCESS | 2313 | Values: 326.4 339.6 340.8 344.7 344.7 5079.2 5202.2 5211.6 5265.9 5274.0 4994.3 5128.5 5163.4 5177.2 5192.4 4116.5 4125.2 4125.4 4125.9 4133.9 3874.1 3883.9 4115.3 4118.5 4120.5 4128.9 4130.6 4136.6 4144.2 4152.3 4119.9 4125.3 4131.7 4133.4 4140.2 3679.2 3703.0 3712.5 3713.3 3718.9 4858.8 5102.5 5123.8 5128.5 5131.7 4666.6 4668.3 4672.6 4672.8 4684.0 5290.3 5453.3 5479.9 5482.7 5500.7 3864.3 3893.6 3894.1 3900.5 3902.9 5656.0 5670.8 5695.3 5705.4 5721.7 4082.8 4083.7 4086.4 4088.9 4091.3 4026.4 4082.6 4095.7 4150.5 4177.8 4712.8 4713.7 4721.8 4728.1 4741.2 5490.6 5523.9 5524.3 5536.8 5540.8 1367.4 1423.9 1425.6 1435.9 1443.0 882.0 904.8 909.8 914.8 915.8 4643.4 4643.4 4689.9 4690.8 4692.7 4942.6 4951.6 4985.8 5013.3 5020.3 4481.8 4694.5 4706.4 4745.6 4750.5 2633.6 2637.0 2640.0 2646.6 2649.6 4991.5 5010.7 5014.8 5015.3 5018.5 4814.0 4921.3 5029.7 5036.2 5046.7 5000.8 5008.8 5013.4 5015.6 5018.6 4845.6 4911.7 4917.9 4943.0 4955.0 4695.8 4846.8 4873.7 4896.4 4946.9 4980.8 5024.4 5031.6 5044.9 5049.9 3716.2 3738.0 3741.2 3783.2 3914.9 5471.6 5602.0 5683.0 5683.2 5696.6 5440.4 5483.5 5502.9 5505.7 5559.7 5296.8 5451.3 5506.4 5511.8 5513.1 5394.4 5452.9 5462.3 5480.0 5482.5 5409.2 5567.8 5579.3 5580.7 5592.3 5367.2 5403.4 5406.2 5413.2 5466.5 04:08:42 INFO - PROCESS | 2313 | 04:08:42 INFO - PROCESS | 2313 | [#5] yui.html Cycles:180 Average:19587.23 Median:4738.25 stddev:27762.22 (585.9%) stddev-sans-first:27803.58 04:08:42 INFO - PROCESS | 2313 | Values: 623.1 662.9 684.4 718.3 724.0 13639.6 14806.2 14891.3 14958.7 15016.8 14151.4 14275.3 14291.8 14295.6 14317.4 653.2 660.6 740.4 789.5 789.8 805.5 820.9 822.5 823.3 823.6 848.8 851.5 852.2 852.3 852.5 851.6 852.4 852.4 853.7 854.0 616.6 617.7 618.1 618.6 618.7 14395.1 14462.6 14509.2 14520.8 14523.5 15471.6 15558.8 15608.8 15661.5 15674.5 10218.3 10370.8 10387.3 10540.5 10887.5 3645.1 3671.7 3685.7 3760.1 3793.8 77181.2 78793.6 78810.6 78925.6 84125.6 11010.7 11271.4 11295.5 11358.1 11658.5 22272.2 22315.0 22433.8 22505.8 23264.1 7767.0 7859.0 7906.1 7906.4 8149.6 4560.5 4565.9 4688.1 4736.1 4740.5 3493.0 3588.2 3605.7 3605.8 3608.1 652.0 656.1 669.1 676.2 691.2 642.3 646.9 648.6 666.0 678.5 8426.3 8796.7 8825.0 8843.8 9081.0 626.1 627.8 679.2 681.9 685.6 4230.6 4296.3 4422.2 4423.8 5209.9 81145.6 110982.4 111691.4 115413.0 120045.0 63428.4 66348.3 69261.0 95461.5 106244.0 47877.3 79683.0 83159.0 84232.6 84737.0 8937.5 8991.6 9406.4 9539.4 9835.6 48911.5 49510.3 50106.7 50378.2 51231.7 63035.7 70398.0 71378.6 73376.6 74460.6 12212.8 13042.6 13097.4 13113.5 13594.5 14920.3 15069.5 15162.2 15185.2 15561.8 12902.2 13212.8 13856.4 13949.2 14321.1 12543.3 12682.9 12781.2 12854.5 12979.9 12271.9 13084.4 13104.9 13137.8 13519.5 10338.9 10574.7 10701.3 10873.7 11069.0 9087.0 9594.3 10503.8 10971.3 11388.8 04:08:42 INFO - PROCESS | 2313 | -------- Summary: end -------- 04:08:42 INFO - PROCESS | 2313 | 04:08:43 INFO - TEST-INFO | 2313: exit 0 04:08:43 INFO - TEST-OK | dromaeo_css | took 1117172ms 04:08:43 INFO - TEST-START | kraken 04:08:43 INFO - operating with platform_type : linux_ 04:08:43 INFO - Initialising browser for kraken test... 04:08:43 INFO - TEST-INFO | started process 2712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj9uIMU/profile http://localhost:49332/getInfo.html) 04:08:47 INFO - PROCESS | 2712 | __metrics Screen width/height:1600/1200 04:08:47 INFO - PROCESS | 2712 | colorDepth:24 04:08:47 INFO - PROCESS | 2712 | Browser inner width/height: 1024/697 04:08:47 INFO - PROCESS | 2712 | __metrics 04:08:48 INFO - PROCESS | 2712 | 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" 04:08:48 INFO - PROCESS | 2712 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:08:48 INFO - PROCESS | 2712 | console.error: PushService: 04:08:48 INFO - PROCESS | 2712 | stateChangeProcessEnqueue: Error transitioning state 04:08:48 INFO - PROCESS | 2712 | UnknownError 04:08:49 INFO - TEST-INFO | 2712: exit 0 04:08:49 INFO - Browser initialized. 04:08:49 INFO - Running cycle 1/1 for kraken test... 04:08:49 INFO - TEST-INFO | started process 2872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj9uIMU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:09:01 INFO - PROCESS | 2872 | RSS: Main: 173264896 04:09:01 INFO - PROCESS | 2872 | 04:09:03 INFO - PROCESS | 2872 | Cycle 1(1): loaded http://localhost:49332/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49332/tests/kraken/driver.html?testName=audio-beat-detection) 04:09:04 INFO - PROCESS | 2872 | RSS: Main: 233136128 04:09:04 INFO - PROCESS | 2872 | 04:09:07 INFO - PROCESS | 2872 | Cycle 1(1): loaded http://localhost:49332/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49332/tests/kraken/driver.html?testName=audio-dft) 04:09:08 INFO - PROCESS | 2872 | RSS: Main: 217673728 04:09:08 INFO - PROCESS | 2872 | 04:09:11 INFO - PROCESS | 2872 | Cycle 1(1): loaded http://localhost:49332/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49332/tests/kraken/driver.html?testName=audio-fft) 04:09:11 INFO - PROCESS | 2872 | RSS: Main: 299966464 04:09:11 INFO - PROCESS | 2872 | 04:09:13 INFO - PROCESS | 2872 | Cycle 1(1): loaded http://localhost:49332/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49332/tests/kraken/driver.html?testName=audio-oscillator) 04:09:14 INFO - PROCESS | 2872 | RSS: Main: 208486400 04:09:14 INFO - PROCESS | 2872 | 04:09:16 INFO - PROCESS | 2872 | Cycle 1(1): loaded http://localhost:49332/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49332/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:09:17 INFO - PROCESS | 2872 | RSS: Main: 213766144 04:09:17 INFO - PROCESS | 2872 | 04:09:20 INFO - PROCESS | 2872 | Cycle 1(1): loaded http://localhost:49332/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49332/tests/kraken/driver.html?testName=imaging-darkroom) 04:09:20 INFO - PROCESS | 2872 | RSS: Main: 249577472 04:09:20 INFO - PROCESS | 2872 | 04:09:24 INFO - PROCESS | 2872 | Cycle 1(1): loaded http://localhost:49332/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49332/tests/kraken/driver.html?testName=imaging-desaturate) 04:09:24 INFO - PROCESS | 2872 | RSS: Main: 248565760 04:09:24 INFO - PROCESS | 2872 | 04:09:27 INFO - PROCESS | 2872 | Cycle 1(1): loaded http://localhost:49332/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49332/tests/kraken/driver.html?testName=json-parse-financial) 04:09:28 INFO - PROCESS | 2872 | RSS: Main: 248950784 04:09:28 INFO - PROCESS | 2872 | 04:09:29 INFO - PROCESS | 2872 | Cycle 1(1): loaded http://localhost:49332/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49332/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:09:30 INFO - PROCESS | 2872 | RSS: Main: 211120128 04:09:30 INFO - PROCESS | 2872 | 04:09:32 INFO - PROCESS | 2872 | Cycle 1(1): loaded http://localhost:49332/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49332/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:09:32 INFO - PROCESS | 2872 | RSS: Main: 218304512 04:09:32 INFO - PROCESS | 2872 | 04:09:34 INFO - PROCESS | 2872 | Cycle 1(1): loaded http://localhost:49332/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49332/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:09:35 INFO - PROCESS | 2872 | RSS: Main: 227401728 04:09:35 INFO - PROCESS | 2872 | 04:09:37 INFO - PROCESS | 2872 | Cycle 1(1): loaded http://localhost:49332/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49332/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:09:38 INFO - PROCESS | 2872 | RSS: Main: 236036096 04:09:38 INFO - PROCESS | 2872 | 04:09:41 INFO - PROCESS | 2872 | Cycle 1(1): loaded http://localhost:49332/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49332/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:09:42 INFO - PROCESS | 2872 | RSS: Main: 233414656 04:09:42 INFO - PROCESS | 2872 | 04:09:43 INFO - PROCESS | 2872 | Cycle 1(1): loaded http://localhost:49332/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49332/tests/kraken/driver.html?testName=ai-astar) 04:09:44 INFO - PROCESS | 2872 | RSS: Main: 284082176 04:09:44 INFO - PROCESS | 2872 | 04:09:44 INFO - PROCESS | 2872 | __start_tp_report 04:09:44 INFO - PROCESS | 2872 | _x_x_mozilla_page_load 04:09:44 INFO - PROCESS | 2872 | _x_x_mozilla_page_load_details 04:09:44 INFO - PROCESS | 2872 | |i|pagename|runs| 04:09:44 INFO - PROCESS | 2872 | |0;ai-astar;110;114;114;113;113;113;113;113;112;113 04:09:44 INFO - PROCESS | 2872 | |1;audio-beat-detection;149;123;123;170;130;129;122;126;164;128 04:09:44 INFO - PROCESS | 2872 | |2;audio-dft;161;161;160;160;160;164;161;161;160;161 04:09:44 INFO - PROCESS | 2872 | |3;audio-fft;76;85;76;109;75;75;76;77;99;75 04:09:44 INFO - PROCESS | 2872 | |4;audio-oscillator;83;84;113;84;84;82;101;83;83;115 04:09:44 INFO - PROCESS | 2872 | |5;imaging-gaussian-blur;117;117;117;118;118;117;117;117;118;118 04:09:44 INFO - PROCESS | 2872 | |6;imaging-darkroom;146;145;146;145;145;146;146;145;148;147 04:09:44 INFO - PROCESS | 2872 | |7;imaging-desaturate;95;96;95;95;95;95;96;100;95;95 04:09:44 INFO - PROCESS | 2872 | |8;json-parse-financial;53;52;52;53;56;54;53;54;54;54 04:09:44 INFO - PROCESS | 2872 | |9;json-stringify-tinderbox;61;62;61;61;62;62;61;62;61;61 04:09:44 INFO - PROCESS | 2872 | |10;stanford-crypto-aes;80;80;81;83;81;82;80;95;79;79 04:09:44 INFO - PROCESS | 2872 | |11;stanford-crypto-ccm;133;134;129;130;131;131;137;130;167;141 04:09:44 INFO - PROCESS | 2872 | |12;stanford-crypto-pbkdf2;171;168;169;170;171;167;171;171;167;170 04:09:44 INFO - PROCESS | 2872 | |13;stanford-crypto-sha256-iterative;74;67;67;65;66;68;67;66;67;64 04:09:44 INFO - PROCESS | 2872 | __end_tp_report 04:09:44 INFO - PROCESS | 2872 | __start_cc_report 04:09:44 INFO - PROCESS | 2872 | _x_x_mozilla_cycle_collect,1669 04:09:44 INFO - PROCESS | 2872 | __end_cc_report 04:09:44 INFO - PROCESS | 2872 | __startTimestamp1475579384064__endTimestamp 04:09:44 INFO - PROCESS | 2872 | 04:09:44 INFO - PROCESS | 2872 | ------- Summary: start ------- 04:09:44 INFO - PROCESS | 2872 | Number of tests: 14 04:09:44 INFO - PROCESS | 2872 | 04:09:44 INFO - PROCESS | 2872 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:1.14 (1.0%) stddev-sans-first:0.60 04:09:44 INFO - PROCESS | 2872 | Values: 110.0 114.0 114.0 113.0 113.0 113.0 113.0 113.0 112.0 113.0 04:09:44 INFO - PROCESS | 2872 | 04:09:44 INFO - PROCESS | 2872 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:129.50 stddev:17.92 (13.8%) stddev-sans-first:18.42 04:09:44 INFO - PROCESS | 2872 | Values: 149.0 123.0 123.0 170.0 130.0 129.0 122.0 126.0 164.0 128.0 04:09:44 INFO - PROCESS | 2872 | 04:09:44 INFO - PROCESS | 2872 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 04:09:44 INFO - PROCESS | 2872 | Values: 161.0 161.0 160.0 160.0 160.0 164.0 161.0 161.0 160.0 161.0 04:09:44 INFO - PROCESS | 2872 | 04:09:44 INFO - PROCESS | 2872 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.00 stddev:12.05 (15.9%) stddev-sans-first:12.56 04:09:44 INFO - PROCESS | 2872 | Values: 76.0 85.0 76.0 109.0 75.0 75.0 76.0 77.0 99.0 75.0 04:09:44 INFO - PROCESS | 2872 | 04:09:44 INFO - PROCESS | 2872 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:83.00 stddev:13.25 (16.0%) stddev-sans-first:13.72 04:09:44 INFO - PROCESS | 2872 | Values: 83.0 84.0 113.0 84.0 84.0 82.0 101.0 83.0 83.0 115.0 04:09:44 INFO - PROCESS | 2872 | 04:09:44 INFO - PROCESS | 2872 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:09:44 INFO - PROCESS | 2872 | Values: 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 04:09:44 INFO - PROCESS | 2872 | 04:09:44 INFO - PROCESS | 2872 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 04:09:44 INFO - PROCESS | 2872 | Values: 146.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 148.0 147.0 04:09:44 INFO - PROCESS | 2872 | 04:09:44 INFO - PROCESS | 2872 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.00 stddev:1.57 (1.6%) stddev-sans-first:1.64 04:09:44 INFO - PROCESS | 2872 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 96.0 100.0 95.0 95.0 04:09:44 INFO - PROCESS | 2872 | 04:09:44 INFO - PROCESS | 2872 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:1.18 (2.2%) stddev-sans-first:1.24 04:09:44 INFO - PROCESS | 2872 | Values: 53.0 52.0 52.0 53.0 56.0 54.0 53.0 54.0 54.0 54.0 04:09:44 INFO - PROCESS | 2872 | 04:09:44 INFO - PROCESS | 2872 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 04:09:44 INFO - PROCESS | 2872 | Values: 61.0 62.0 61.0 61.0 62.0 62.0 61.0 62.0 61.0 61.0 04:09:44 INFO - PROCESS | 2872 | 04:09:44 INFO - PROCESS | 2872 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.00 stddev:4.74 (5.8%) stddev-sans-first:4.97 04:09:44 INFO - PROCESS | 2872 | Values: 80.0 80.0 81.0 83.0 81.0 82.0 80.0 95.0 79.0 79.0 04:09:44 INFO - PROCESS | 2872 | 04:09:44 INFO - PROCESS | 2872 | [#11] stanford-crypto-ccm Cycles:10 Average:136.30 Median:133.50 stddev:11.40 (8.5%) stddev-sans-first:12.03 04:09:44 INFO - PROCESS | 2872 | Values: 133.0 134.0 129.0 130.0 131.0 131.0 137.0 130.0 167.0 141.0 04:09:44 INFO - PROCESS | 2872 | 04:09:44 INFO - PROCESS | 2872 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:170.50 stddev:1.65 (1.0%) stddev-sans-first:1.66 04:09:44 INFO - PROCESS | 2872 | Values: 171.0 168.0 169.0 170.0 171.0 167.0 171.0 171.0 167.0 170.0 04:09:44 INFO - PROCESS | 2872 | 04:09:44 INFO - PROCESS | 2872 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:2.69 (4.0%) stddev-sans-first:1.22 04:09:44 INFO - PROCESS | 2872 | Values: 74.0 67.0 67.0 65.0 66.0 68.0 67.0 66.0 67.0 64.0 04:09:44 INFO - PROCESS | 2872 | -------- Summary: end -------- 04:09:44 INFO - PROCESS | 2872 | 04:09:45 INFO - TEST-INFO | 2872: exit 0 04:09:45 INFO - TEST-OK | kraken | took 62172ms 04:09:45 INFO - SUITE-END | took 1179s 04:09:45 INFO - Completed test suite (00:19:39) 04:09:45 INFO - javascript benchmark 04:09:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3057.7248047675707, 3083.0596668016246, 3101.472749632563, 3121.8751249950005, 3137.1843320736602, 5211.140161873296, 5289.3123893893835, 5360.5443537299325, 5432.402435732071, 5476.014317422867, 5332.0, 5336.066188417031, 5412.810551630694, 5420.945790542093, 5437.238786569884, 4838.63710221733, 4866.294387313837, 4902.3872015998, 4910.680805747633, 4937.407511098673, 4887.975560122212, 5020.447750747433, 5032.396112466491, 5032.773525191357, 5096.592272618182, 4767.928481072787, 4945.604351651859, 4967.602591792666, 4967.652264341497, 5054.924176137342, 4789.137955168068, 4825.469198388175, 4889.902201955941, 4902.4852390498845, 4980.327655766461, 4846.830360937351, 4849.515048495157, 4857.878553036167, 4870.65905386623, 4947.109520286383, 5350.30446042016, 5355.732213389315, 5357.4374690657305, 5357.651752636105, 5363.678179309215, 5548.667079975174, 5572.832815015556, 5589.776408943638, 5683.857903552403, 5748.109043098327, 5691.203231547586, 5704.71476426177, 5704.971475142598, 5707.343655479632, 5711.885762284731, 5297.682139071707, 5299.947000530023, 5309.150535914274, 5335.599830012765, 5345.118055520796, 5843.678597677169, 5899.115132730125, 5904.911426328608, 5957.0, 5963.880722385528, 5671.319441667027, 5679.432056794288, 5680.573956953245, 5682.204491371212, 5689.288838895138, 5568.387477377485, 5627.0, 5743.310802703619, 5746.913796293059, 5752.597318187771, 5585.69278689676, 5626.859328516738, 5628.183913332544, 5650.463205995424, 5721.828345149652, 5676.120201368794, 5677.0, 5677.261955945701, 5681.0, 5741.19623252745, 4308.80610372534, 4387.692861499728, 4392.758398288061, 4398.758068306274, 4438.778061096932, 3876.9418458723144, 3890.9416358754643, 3937.0354263205127, 3953.9802300988313, 3977.4033894915992, 5405.0, 5407.729613519308, 5410.0, 5412.052890744104, 5474.178873168977, 5744.684042377709, 5777.8555536111935, 5779.855503612359, 5781.103928891029, 5784.074548072288, 5204.479552044765, 5251.422343542207, 5260.658057226268, 5348.652337598043, 5436.238926550286, 4914.213725803926, 4925.1873440881855, 4934.062528119646, 4970.776315065831, 4979.502049794992, 5750.7987220447085, 5829.300483941869, 5861.853453663693, 5863.677497737665, 5921.4966727826895, 5613.887722245614, 5661.971690141523, 5696.857578560569, 5704.600677952503, 5755.539556835527, 5826.805504871576, 5885.646861188342, 5886.646801191942, 5932.762689492372, 5941.37615550361, 5677.68772717488, 5685.744141513725, 5687.9431205687415, 5694.373618902, 5700.201971723879, 5607.915881261702, 5671.206031155559, 5789.9710501447225, 5793.768249269982, 5800.622959507618, 5510.448955104457, 5520.309961254843, 5541.861453463695, 5560.91658625129, 5585.720713964204, 5476.80831170923, 5506.063969125338, 5512.476314750093, 5518.724063796713, 5563.693996830213, 5434.402215756343, 5496.697681627549, 5559.555235581063, 5573.303337082864, 5630.577706671934, 5526.861828454321, 5592.69240191777, 5634.577406694432, 5639.520640745583, 5714.942850571441, 5489.533389661923, 5537.141743029837, 5543.77824887, 5544.972275138599, 5604.131359639263], "value": 5276.78772329296, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.9240953386466, 568.3776264989837, 600.1867469578724, 600.849787553112, 604.9516038716902, 32023.51964720528, 42788.786056069715, 43645.12709745803, 43657.56342436575, 43694.99999999996, 45113.32330015052, 45591.31613025807, 45591.31613025807, 45610.31584526235, 45634.7718261409, 8113.107558168596, 8984.505852178128, 9136.954315228415, 9138.63445462184, 9146.131117543857, 7901.762947111567, 10523.421211833345, 10759.193060520452, 10767.676969690921, 11149.442527873614, 11145.16411269158, 11184.664460066171, 11207.271527350696, 11223.494942727597, 11225.550977960871, 10955.233133680606, 11025.889741102566, 11029.83455248172, 11030.28303160292, 11041.503132359023, 10746.140308775279, 10805.405702686348, 10811.83782243267, 10817.891821081847, 10824.0, 42905.141897161884, 43154.35268470975, 43198.56801431977, 43239.13521729548, 43269.56730432687, 3499.7375196860085, 3533.8586456541707, 3653.8355773990234, 3658.981705091484, 3701.5373078365205, 31676.841615792004, 31953.0, 32171.35657286841, 32183.356332873445, 33505.497417538754, 3780.092777733324, 3923.117298607819, 3936.075022369741, 4018.357062869956, 4111.602055301212, 330264.0, 330527.9999999976, 330618.9999999976, 331334.0, 331359.0, 35048.64951350505, 36105.277894442486, 36177.27645447129, 58771.70614146902, 58949.642014319805, 37654.811725941196, 37746.43380349297, 37793.244135117144, 37807.81096094502, 37817.24365512729, 14868.405263789327, 14885.0, 15012.249387530579, 15026.0, 15044.172570508726, 11375.829362559569, 11627.12796540263, 11905.702357441134, 11932.343721095423, 12254.08094392924, 8512.616932237941, 8578.227959483676, 8669.869951950726, 8721.389502734748, 8737.737867863974, 3235.514672799099, 3305.2397948471985, 3323.7008669219886, 3326.86692532296, 3386.779859309137, 1016.872890888639, 1063.574570171922, 1067.7010437077631, 1067.9305845120043, 1092.639428988432, 31507.0, 32251.35497290088, 32443.0, 32718.345633087203, 32960.505592416135, 1098.6319582939805, 1125.139268459629, 1125.9380734059541, 1137.3858116616934, 1217.1784045769248, 16763.078030708428, 16777.0, 16962.15189240533, 17019.242737297904, 17129.48611541656, 506952.0, 511650.0, 516102.0, 516531.0, 520973.0, 49631.0, 50112.498875011515, 50171.49828501741, 50176.49823501791, 50227.24659130116, 1220.7558488302197, 1227.1777908801125, 1280.295837289487, 1284.7366289910733, 1286.1897004886862, 28954.565681515214, 33074.66925330716, 33186.66813331933, 33350.499742503394, 33702.0, 54885.0, 56856.0, 56908.43091569031, 61515.38484615096, 61525.0, 513111.0, 516793.0, 517427.0, 518243.0, 518547.0, 27874.303142421602, 28072.0, 28173.859130704215, 29921.55117673193, 39887.0, 46585.767071164424, 46659.0, 46796.0, 46934.530654693015, 47590.524094758606, 38876.0, 39748.602513975646, 39928.40107398333, 40762.59237407707, 41707.37438938358, 39640.60359396484, 39849.40225896672, 40843.795781020905, 40995.590044099175, 41884.371734423396, 40268.39597405983, 40658.0, 41652.375214371204, 41812.79093604512, 44849.327260090475, 32912.67087329096, 36742.63257367392, 37030.259394811415, 37425.43861842129, 37636.24727505489, 27277.0, 27799.0, 27808.304792380353, 28079.0, 28113.578296325162], "value": 19205.148818034824, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.1855582663534, 392.88999080257537, 404.89270343359004, 406.1045394904236, 416.6625033722685, 13154.473821047159, 14843.480478183252, 18388.540286492844, 18507.444776656706, 19268.90365548174, 18232.72650910234, 18514.62970740588, 18576.628467430644, 18721.0, 18747.0, 5494.0934745767, 5711.228984087157, 5721.570882183832, 5722.79970201043, 5725.341585717633, 3812.237552489499, 4028.5769994150633, 5445.319335083114, 5466.371367292772, 5712.314522257335, 5647.407022262665, 5671.574631902603, 5732.914006289888, 5750.511206547449, 5754.108113242454, 5570.136628822539, 5676.631018983773, 5733.455321744427, 5736.655800651933, 5764.250647415851, 5531.944680553183, 5534.446555344473, 5535.280413546254, 5535.667859928417, 5544.805931792368, 12480.313582752944, 12519.186252893624, 12749.235045897183, 12775.48898044077, 12800.359982000957, 2203.173879202221, 2231.319447568491, 2271.046160612547, 2342.5900467418132, 2785.0, 9239.214666753334, 9426.245900328026, 9489.525523723854, 9857.852132218022, 10089.848652270222, 1892.4795681187645, 1902.3817259390753, 1937.6124775044907, 1953.1601411393094, 1971.9014049297477, 74391.0, 77004.0, 77157.61421192858, 78121.60939195268, 78393.0, 10000.299979001546, 10634.0, 10740.409277489813, 10797.892021079846, 10966.396848173426, 15055.774163387558, 15056.247187640574, 15077.396904123712, 15079.773803392958, 15100.39598416051, 7295.52579082358, 7838.137804841463, 7870.606469676493, 7921.049474063149, 8064.354851611857, 7332.8900066499045, 7366.410687145016, 7591.848163036819, 7615.7334493292465, 7626.122995855437, 4512.72923624577, 4540.296254080623, 4594.379758732595, 4680.438347398334, 4746.216874215785, 1793.5247159502742, 1833.8759296317442, 1837.9697656463811, 1894.435898323704, 1958.8726732762325, 819.2749416766205, 955.0786753474047, 959.5633986536249, 1007.4861820471613, 1037.3983089807894, 16952.830471695124, 18190.18144183515, 18205.54486137857, 18250.407729257953, 18417.0, 947.4599478297305, 955.1642312976146, 958.2046901072093, 973.3964941736027, 980.132582664333, 9655.22758179344, 9961.302708810459, 10167.389956602627, 10205.234607404325, 10231.28381013322, 425855.0, 427223.0, 429117.0, 431079.0, 439769.0, 85682.57158714166, 87303.56348218219, 88474.0, 88562.0, 89350.0, 965.8454647256406, 1001.2290536287164, 1003.9609004680121, 1028.747956750601, 1029.7528593137743, 15646.608834779221, 16201.270942807367, 16578.50264492067, 16595.419160329813, 16679.83320166783, 38469.0, 38777.03057423587, 38855.0, 40266.0, 40273.59726402698, 53779.731101344245, 53837.46162538324, 54854.45145548653, 55190.89618207694, 56274.43725562692, 7876.291133797757, 8006.679732810622, 8260.586970651324, 8372.455790373606, 8373.706920257762, 12086.093542984487, 12460.937695311828, 12638.115331926678, 13119.540816071392, 13183.340832958505, 10354.5340459678, 10497.475126243504, 10565.52455139536, 10810.135189185004, 11447.141464390037, 10544.209184311361, 10901.34591924487, 10910.563577457131, 10979.560817567528, 11017.283876548, 10661.733456663645, 10721.946390267998, 10836.13310935139, 10952.890471095187, 11147.108231341635, 7768.30937372009, 7957.403194760301, 8007.799805004922, 8062.0, 8359.0, 10728.356298622108, 10751.086157676686, 10801.24391292602, 11034.117270618492, 11206.663800086011], "value": 8657.836677476971, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.8029075929371, 1425.2944792327798, 1563.257452709963, 1675.4052311429434, 1754.4298103116482, 7817.491863028899, 8089.433739638228, 8329.500229986197, 8855.690050848221, 8876.467411955278, 8338.91661083389, 8583.141685831413, 8656.307495400368, 8899.15458031486, 8899.73300800977, 2273.499830037393, 2289.164454973931, 2289.8626082435026, 2300.0454811253308, 2303.3090072978125, 1950.9707354389695, 2004.98997505013, 2229.7770222977733, 2258.9096436142536, 2279.2934190400947, 2225.532638145983, 2284.166279308049, 2284.6915666385075, 2296.4718114833513, 2299.5285966376937, 2202.537467131904, 2222.9110835566557, 2245.438640339915, 2254.030766770288, 2265.0147185974156, 2228.944276393087, 2228.9746716510426, 2232.307984524786, 2239.1155493579945, 2242.7196600424945, 8671.4363566368, 8732.476051436934, 8735.43219690718, 8735.650573977033, 8745.868811967826, 5107.540321371094, 5276.630635855492, 5315.202719592092, 5320.5211530962015, 5323.387810401776, 3382.2220889195623, 3527.9294414111573, 3586.8385922633543, 3590.838412271428, 3628.8548458061646, 1036.5180191211123, 1078.660222030058, 1086.6033897627387, 1102.895224953628, 1126.1947707389256, 12285.877141228562, 12322.075844311712, 12332.876671233262, 12350.567730129493, 12377.319247441386, 4375.562443755599, 4670.206064968964, 4735.881602959885, 4740.549647783455, 4767.6662633615315, 10216.284860059724, 10238.385696858213, 10259.384436933658, 10272.486375681186, 10272.589096436208, 5350.892982140414, 5355.651882627694, 5368.597355198376, 5373.113436283048, 5378.623496355218, 4729.95270047302, 4806.735629540409, 4922.753862306942, 4943.307936888838, 4945.159322915113, 3689.2990331836863, 3710.5361829771277, 3717.7397582168987, 3819.9427008594894, 3840.9615903841163, 1056.3292309383596, 1075.3440401355167, 1147.3402793393666, 1156.2137746332407, 1171.8652354979115, 782.3506489613607, 933.2906990687127, 940.210223412337, 967.5404183013153, 972.8005758819567, 5753.597248192586, 5756.884862302731, 5770.307563092372, 5809.099589563624, 5849.970750146307, 951.0632027452954, 956.1442508954447, 959.2134449751277, 964.2719746591279, 978.1929907826072, 3879.321118804198, 4036.3138266494766, 4048.1701251243426, 4099.077707515785, 4103.7742924138865, 10705.9464702676, 11153.330800152016, 11157.66527004191, 11172.664820055412, 11173.385463799568, 10906.781864362669, 11108.0, 11123.944380278208, 11124.38815865119, 11166.888331116585, 8096.51420914747, 8269.04905935825, 8362.163783621589, 8365.790855228546, 8371.916280837113, 5816.534677225896, 5864.266966629171, 5866.853328666817, 5918.408159184047, 6043.456088952015, 9967.352122112039, 10097.343672661253, 10163.796724065625, 10177.694669159937, 10218.131458825786, 10291.176705863663, 10361.533730981973, 10437.843432348369, 10473.371597704163, 10485.213608979204, 7298.452616053711, 7317.9754834322175, 7338.96330518344, 7340.779776606711, 7360.374368178551, 8182.713605023796, 8271.917280827114, 8339.916600834156, 8377.994640643163, 8393.580320984049, 6635.834104147435, 7373.29953654402, 7430.517016393917, 7573.431992600466, 7641.159472457914, 7505.587192704235, 7526.698932042657, 7549.810554939007, 7556.282153195438, 7688.423368247292, 6716.093327400738, 6767.966160169168, 6780.864382712417, 6811.148606424197, 6815.488838337045, 5001.57486613642, 5113.8977220454635, 5131.255967884561, 5172.301739265302, 5224.2947202127225, 5026.648134630541, 5126.7180305083575, 5198.792048318025, 5297.761600728054, 5298.496642818926], "value": 4572.92406366238, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.4286094819277, 339.6162336559688, 340.83810190159693, 344.66395264617, 344.68977919872094, 5079.238114282859, 5202.193659982704, 5211.635185537005, 5265.921011184831, 5273.967468705495, 4994.275830004647, 5128.53843154116, 5163.392486794164, 5177.239738488913, 5192.429747275095, 4116.547179810218, 4125.216208920303, 4125.422440858282, 4125.9174816503655, 4133.937990930139, 3874.1283211277378, 3883.9223215535812, 4115.341545352744, 4118.485189351331, 4120.484939382577, 4128.876133715993, 4130.566290539495, 4136.648384887289, 4144.21259960608, 4152.2733521633745, 4119.938200926988, 4125.318542947079, 4131.690123240754, 4133.400656904762, 4140.234056699505, 3679.1537946272238, 3702.9629703702885, 3712.535933008374, 3713.294474049949, 3718.9442158367647, 4858.809591650033, 5102.489751024905, 5123.769430375642, 5128.461511541309, 5131.692098474104, 4666.580007799314, 4668.346431499593, 4672.556107169813, 4672.766361681936, 4684.0, 5290.256146222159, 5453.345598528163, 5479.890402191973, 5482.698451585161, 5500.669959802424, 3864.3044252034624, 3893.6301051400355, 3894.104355998108, 3900.531936167678, 3902.8829135125993, 5655.971720141414, 5670.845078870003, 5695.259616249902, 5705.4294570543025, 5721.71391430431, 4082.8366865325056, 4083.714140010171, 4086.427900093989, 4088.9386659200136, 4091.2840252956207, 4026.363091671683, 4082.6121518455698, 4095.713300069026, 4150.481189851269, 4177.811998460016, 4712.811487540528, 4713.670043097019, 4721.763911804396, 4728.1252968201, 4741.241401375763, 5490.588205884575, 5523.861903452445, 5524.309461317335, 5536.7819079802375, 5540.750666220029, 1367.446184295362, 1423.9074460160057, 1425.5865798918405, 1435.8584924984455, 1442.9610680310159, 881.9735407937773, 904.7511934218143, 909.8225845959975, 914.7895983923735, 915.8397280476023, 4643.373144625432, 4643.419572553431, 4689.859304220879, 4690.835820746258, 4692.718436893729, 4942.57988071018, 4951.579115775127, 4985.800567977313, 5013.348264725635, 5020.322256495399, 4481.775911204427, 4694.50707675696, 4706.364640773451, 4745.572898439088, 4750.501197374226, 2633.6181253718105, 2637.0, 2639.973600263973, 2646.563317052665, 2649.629051932731, 4991.500849915052, 5010.724410157476, 5014.84955451337, 5015.27278544609, 5018.5232402921665, 4814.0, 4921.335619691367, 5029.698218106852, 5036.169032109734, 5046.722430266297, 5000.849974500771, 5008.84973450797, 5013.39839219296, 5015.598752099823, 5018.573421259161, 4845.5881250094135, 4911.705297682151, 4917.868890155356, 4942.975285123552, 4954.950450495449, 4695.788689508912, 4846.80612775485, 4873.659743570546, 4896.4124305083615, 4946.851594452172, 4980.775865086152, 5024.371953505812, 5031.597472202142, 5044.949550504448, 5049.924251136163, 3716.1824398632257, 3737.9626203737616, 3741.214344987583, 3783.1866148778145, 3914.8629797956933, 5471.6169868108855, 5602.011285993413, 5682.982541197981, 5683.175939488834, 5696.629719068247, 5440.4015558287765, 5483.505005222694, 5502.944970550243, 5505.733681253254, 5559.694216818114, 5296.788128474818, 5451.3458384994055, 5506.449355064622, 5511.834644960658, 5513.145462453166, 5394.406615272395, 5452.854900470787, 5462.3445186577865, 5479.972600136974, 5482.506574408322, 5409.188621706776, 5567.805126820542, 5579.330480342385, 5580.748866301107, 5592.309076009977, 5367.194920761761, 5403.378611459732, 5406.24312596229, 5413.242146099628, 5466.480684334982], "value": 4042.1283701679827, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.1120653069377, 662.8773676869778, 684.407987091166, 718.2817182817183, 723.9601821899794, 13639.590812275623, 14806.185659788707, 14891.329890154942, 14958.700825983473, 15016.849831501682, 14151.363188656509, 14275.286235688225, 14291.785623215634, 14295.571132866005, 14317.355718992645, 653.1737352249409, 660.6003367962362, 740.4261697184671, 789.4513313247295, 789.8459800338936, 805.5005896344275, 820.8686610142379, 822.498276051611, 823.2508417340222, 823.5799742131526, 848.7962888906649, 851.5061264466594, 852.1606217875387, 852.3266619370721, 852.5012867472536, 851.642310229705, 852.3862818770475, 852.4288726553224, 853.714005808055, 854.0434713121313, 616.5684021185189, 617.7374615788317, 618.072890664004, 618.6010023534794, 618.7401291457599, 14395.064320819114, 14462.638434039129, 14509.201993890332, 14520.782188267185, 14523.491677791333, 15471.613209669737, 15558.844411555965, 15608.843911560853, 15661.530154095395, 15674.451394201262, 10218.335808172445, 10370.792584148276, 10387.27289089764, 10540.468942904135, 10887.510062047228, 3645.0887278180453, 3671.73626199192, 3685.7051435885064, 3760.1163726524246, 3793.829277682511, 77181.22818771796, 78793.60603197005, 78810.60594697048, 78925.60537197278, 84125.57937210336, 11010.669679909615, 11271.416138256869, 11295.49170287339, 11358.148138889615, 11658.53365865356, 22272.220472283392, 22315.0, 22433.775662243494, 22505.774942250697, 23264.06943722266, 7767.0, 7859.0, 7906.130325664172, 7906.446548741533, 8149.551774652333, 4560.498345182027, 4565.863024109282, 4688.085823264499, 4736.052789442126, 4740.45484769249, 3493.0, 3588.2285308658766, 3605.6935160511125, 3605.801680907523, 3608.0619039050034, 651.9674016299166, 656.0880376276979, 669.0666520204288, 676.1784431915148, 691.2258270736706, 642.2646070249538, 646.9450096741735, 648.5719425179359, 665.9600423974578, 678.5352033856824, 8426.283765879969, 8796.736097917073, 8825.0, 8843.778905527284, 9081.049743361658, 626.0577830365271, 627.7645882793952, 679.171410878737, 681.9215790184193, 685.5715178013742, 4230.61924426803, 4296.269634162138, 4422.159789639958, 4423.845165419195, 5209.921851172236, 81145.59427202826, 110982.44508777405, 111691.44154279177, 115413.0, 120045.0, 63428.36571634225, 66348.33651663421, 69261.0, 95461.52269238749, 106244.0, 47877.28184077242, 79683.0, 83159.0, 84232.57883710664, 84736.99999999876, 8937.46375217489, 8991.55042247898, 9406.38858474197, 9539.379940303857, 9835.557399916877, 48911.5108848907, 49510.257346139115, 50106.74946625243, 50378.244326335865, 51231.74384128056, 63035.68482157743, 70398.0, 71378.64310678413, 73376.63311683621, 74460.62769686116, 12212.75574488523, 13042.608721738363, 13097.41061652247, 13113.475460981454, 13594.45622175102, 14920.253987300375, 15069.54791356261, 15162.166080865658, 15185.16481593523, 15561.844381556493, 12902.161359511601, 13212.811515790112, 13856.4457421702, 13949.16305021702, 14321.14073155614, 12543.3101179436, 12682.87317126817, 12781.16922400041, 12854.485820567073, 12979.870201298243, 12271.877281227073, 13084.411201496147, 13104.934475327562, 13137.802932956205, 13519.526816561372, 10338.933922378132, 10574.689826302729, 10701.250912436055, 10873.673789786319, 11069.007578635923, 9086.954565227396, 9594.313297758075, 10503.842442363524, 10971.286866353661, 11388.772224555629], "value": 7285.749048912209, "unit": "score"}], "name": "dromaeo_css", "value": 7005.191574528865, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 123.0, 170.0, 130.0, 129.0, 122.0, 126.0, 164.0, 128.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 160.0, 164.0, 161.0, 161.0, 160.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 85.0, 76.0, 109.0, 75.0, 75.0, 76.0, 77.0, 99.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 113.0, 84.0, 84.0, 82.0, 101.0, 83.0, 83.0, 115.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 148.0, 147.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 100.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 53.0, 56.0, 54.0, 53.0, 54.0, 54.0, 54.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 62.0, 61.0, 62.0, 61.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 81.0, 83.0, 81.0, 82.0, 80.0, 95.0, 79.0, 79.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 134.0, 129.0, 130.0, 131.0, 131.0, 137.0, 130.0, 167.0, 141.0], "value": 136.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 169.0, 170.0, 171.0, 167.0, 171.0, 171.0, 167.0, 170.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 67.0, 67.0, 65.0, 66.0, 68.0, 67.0, 66.0, 67.0, 64.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1512.3999999999999, "alertThreshold": 2.0}]} 04:09:45 INFO - Return code: 0 04:09:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:09:45 INFO - # TBPL SUCCESS # 04:09:45 INFO - Running post-action listener: _resource_record_post_action 04:09:45 INFO - [mozharness: 2016-10-04 11:09:45.856827Z] Finished run-tests step (success) 04:09:45 INFO - Running post-run listener: _resource_record_post_run 04:09:45 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399953920; Read time: 8; Write time: 356080 04:09:45 INFO - TinderboxPrint: CPU usage
13.1% 04:09:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:09:45 INFO - TinderboxPrint: I/O write bytes / time
399,953,920 / 356,080 04:09:45 INFO - TinderboxPrint: CPU idle
8,295.5 (86.9%) 04:09:45 INFO - TinderboxPrint: CPU user
1,202.4 (12.6%) 04:09:45 INFO - TinderboxPrint: Swap in / out
0 / 0 04:09:45 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111185920; Read time: 0; Write time: 110324 04:09:45 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288768000; Read time: 0; Write time: 245756 04:09:46 INFO - Running post-run listener: _upload_blobber_files 04:09:46 INFO - Blob upload gear active. 04:09:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:09:46 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 04:09:46 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'] 04:09:46 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 04:09:46 INFO - (blobuploader) - INFO - Open directory for files ... 04:09:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:09:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:09:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:49 INFO - (blobuploader) - INFO - Done attempting. 04:09:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:09:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:09:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:50 INFO - (blobuploader) - INFO - Done attempting. 04:09:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:09:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:09:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:51 INFO - (blobuploader) - INFO - Done attempting. 04:09:51 INFO - (blobuploader) - INFO - Iteration through files over. 04:09:51 INFO - Return code: 0 04:09:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:09:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:09:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2f4e984d02a98949dc636e2cba8c9c77242a2d37457d660836b8837b0221627153306122751c0f0e80780d362c726a8de0f30da4044df5af22d9a215dad4372", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df1a28c5d99f0212e1c79da07f1188c763d272348353fea70167d924453b52f34f00da597c76337fafd996b2ce741bd0a2ff2ebd77ace27abc6d27a5548c79fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de7c9aef0c2310c9d406153c6750a841f7cc5a4c3a7e47634d3fea38bf448c0a3c9e505c2962acc0771cd79cdc4c7ec04d723575aa75d91ebd0b65516ece036a"} 04:09:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:09:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:09:51 INFO - Contents: 04:09:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2f4e984d02a98949dc636e2cba8c9c77242a2d37457d660836b8837b0221627153306122751c0f0e80780d362c726a8de0f30da4044df5af22d9a215dad4372", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df1a28c5d99f0212e1c79da07f1188c763d272348353fea70167d924453b52f34f00da597c76337fafd996b2ce741bd0a2ff2ebd77ace27abc6d27a5548c79fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de7c9aef0c2310c9d406153c6750a841f7cc5a4c3a7e47634d3fea38bf448c0a3c9e505c2962acc0771cd79cdc4c7ec04d723575aa75d91ebd0b65516ece036a"} 04:09:51 INFO - Running post-run listener: copy_logs_to_upload_dir 04:09:51 INFO - Copying logs to upload dir... 04:09:51 INFO - mkdir: /builds/slave/test/build/upload/logs 04:09:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.555451 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-04 04:09:51.436685) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 04:09:51.440772) ========= 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=523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668 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/b2f4e984d02a98949dc636e2cba8c9c77242a2d37457d660836b8837b0221627153306122751c0f0e80780d362c726a8de0f30da4044df5af22d9a215dad4372", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df1a28c5d99f0212e1c79da07f1188c763d272348353fea70167d924453b52f34f00da597c76337fafd996b2ce741bd0a2ff2ebd77ace27abc6d27a5548c79fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de7c9aef0c2310c9d406153c6750a841f7cc5a4c3a7e47634d3fea38bf448c0a3c9e505c2962acc0771cd79cdc4c7ec04d723575aa75d91ebd0b65516ece036a"} build_url:https://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/LI6auNC8R22JgkCJfEAT2g/artifacts/public/build/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/b2f4e984d02a98949dc636e2cba8c9c77242a2d37457d660836b8837b0221627153306122751c0f0e80780d362c726a8de0f30da4044df5af22d9a215dad4372", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df1a28c5d99f0212e1c79da07f1188c763d272348353fea70167d924453b52f34f00da597c76337fafd996b2ce741bd0a2ff2ebd77ace27abc6d27a5548c79fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de7c9aef0c2310c9d406153c6750a841f7cc5a4c3a7e47634d3fea38bf448c0a3c9e505c2962acc0771cd79cdc4c7ec04d723575aa75d91ebd0b65516ece036a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 04:09:51.471081) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 04:09:51.471871) ========= 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=523ca41ca1e0623de333ad52000001bf-1475578149.279453-1994796668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 04:09:51.552770) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 04:09:51.553414) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 04:09:51.554003) ========= ========= Total master_lag: 0.16 =========