builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1487251558.63 results: success (0) buildid: 20170216033818 builduid: d31087c738154a178c0233749a736c25 revision: b5dec8abc97b2b8259d71b74c00b0ad90cc37d4e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 05:25:58.626978) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 05:25:58.627461) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 05:25:58.627916) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 05:25:58.645089) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 05:25:58.645531) ========= 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=7de08804244eb36560b44971000001c3-1487251558.475970-857223227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-16 05:25:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2017-02-16 05:25:59 (219 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125502 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 05:25:58.786473) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 05:25:58.787001) ========= 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=7de08804244eb36560b44971000001c3-1487251558.475970-857223227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022063 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 05:25:58.837707) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 05:25:58.838091) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b5dec8abc97b2b8259d71b74c00b0ad90cc37d4e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b5dec8abc97b2b8259d71b74c00b0ad90cc37d4e --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=7de08804244eb36560b44971000001c3-1487251558.475970-857223227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-16 05:25:59,352 truncating revision to first 12 chars 2017-02-16 05:25:59,352 Setting DEBUG logging. 2017-02-16 05:25:59,352 attempt 1/10 2017-02-16 05:25:59,352 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b5dec8abc97b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-16 05:25:59,659 unpacking tar archive at: mozilla-beta-b5dec8abc97b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659823 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 05:25:59.512155) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 05:25:59.512855) ========= script_repo_revision: b5dec8abc97b2b8259d71b74c00b0ad90cc37d4e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 05:25:59.513313) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 05:25:59.513659) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 05:25:59.523608) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-16 05:25:59.524064) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=7de08804244eb36560b44971000001c3-1487251558.475970-857223227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:26:00 INFO - MultiFileLogger online at 20170216 05:26:00 in /builds/slave/test 05:26:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:26:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:26:00 INFO - {'append_to_log': False, 05:26:00 INFO - 'base_work_dir': '/builds/slave/test', 05:26:00 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:26:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:26:00 INFO - 'branch': 'Mozilla-Beta', 05:26:00 INFO - 'buildbot_json_path': 'buildprops.json', 05:26:00 INFO - 'config_files': ('talos/linux_config.py',), 05:26:00 INFO - 'default_actions': ('clobber', 05:26:00 INFO - 'read-buildbot-config', 05:26:00 INFO - 'download-and-extract', 05:26:00 INFO - 'populate-webroot', 05:26:00 INFO - 'create-virtualenv', 05:26:00 INFO - 'install', 05:26:00 INFO - 'run-tests'), 05:26:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:26:00 INFO - 'download_minidump_stackwalk': True, 05:26:00 INFO - 'download_symbols': 'ondemand', 05:26:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:26:00 INFO - 'tooltool.py': '/tools/tooltool.py', 05:26:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:26:00 INFO - '/tools/misc-python/virtualenv.py')}, 05:26:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:26:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:26:00 INFO - 'installer_path': 'installer.exe', 05:26:00 INFO - 'log_level': 'info', 05:26:00 INFO - 'log_name': 'talos', 05:26:00 INFO - 'log_to_console': True, 05:26:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:26:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:26:00 INFO - 'opt_config_files': (), 05:26:00 INFO - 'pip_index': False, 05:26:00 INFO - 'sps_profile': False, 05:26:00 INFO - 'sps_profile_interval': 0, 05:26:00 INFO - 'suite': 'dromaeojs-e10s', 05:26:00 INFO - 'system_bits': '32', 05:26:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:26:00 INFO - 'title': 'talos-linux64-ix-003', 05:26:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:26:00 INFO - 'use_talos_json': True, 05:26:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:26:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:26:00 INFO - 'work_dir': 'build'} 05:26:00 INFO - [mozharness: 2017-02-16 13:26:00.136291Z] Running clobber step. 05:26:00 INFO - Running pre-action listener: _resource_record_pre_action 05:26:00 INFO - Running main action method: clobber 05:26:00 INFO - rmtree: /builds/slave/test/build 05:26:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:26:01 INFO - Running post-action listener: _resource_record_post_action 05:26:01 INFO - [mozharness: 2017-02-16 13:26:01.072073Z] Finished clobber step (success) 05:26:01 INFO - [mozharness: 2017-02-16 13:26:01.072172Z] Running read-buildbot-config step. 05:26:01 INFO - Running pre-action listener: _resource_record_pre_action 05:26:01 INFO - Running main action method: read_buildbot_config 05:26:01 INFO - Using buildbot properties: 05:26:01 INFO - { 05:26:01 INFO - "project": "", 05:26:01 INFO - "product": "firefox", 05:26:01 INFO - "script_repo_revision": "production", 05:26:01 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 05:26:01 INFO - "repository": "", 05:26:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 05:26:01 INFO - "buildid": "20170216033818", 05:26:01 INFO - "pgo_build": "True", 05:26:01 INFO - "basedir": "/builds/slave/test", 05:26:01 INFO - "buildnumber": 410, 05:26:01 INFO - "slavename": "talos-linux64-ix-003", 05:26:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:26:01 INFO - "platform": "ubuntu64_hw", 05:26:01 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:26:01 INFO - "branch": "mozilla-beta", 05:26:01 INFO - "repo_path": "releases/mozilla-beta", 05:26:01 INFO - "revision": "b5dec8abc97b2b8259d71b74c00b0ad90cc37d4e", 05:26:01 INFO - "stage_platform": "linux64-pgo", 05:26:01 INFO - "builduid": "d31087c738154a178c0233749a736c25", 05:26:01 INFO - "slavebuilddir": "test" 05:26:01 INFO - } 05:26:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 05:26:01 INFO - Running post-action listener: _resource_record_post_action 05:26:01 INFO - [mozharness: 2017-02-16 13:26:01.074581Z] Finished read-buildbot-config step (success) 05:26:01 INFO - [mozharness: 2017-02-16 13:26:01.074669Z] Running download-and-extract step. 05:26:01 INFO - Running pre-action listener: _resource_record_pre_action 05:26:01 INFO - Running main action method: download_and_extract 05:26:01 INFO - mkdir: /builds/slave/test/build/tests 05:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:01 INFO - trying https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 05:26:01 INFO - Downloading https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 05:26:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:26:01 INFO - Downloaded 1327 bytes. 05:26:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 05:26:01 INFO - Using the following test package requirements: 05:26:01 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 05:26:01 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:26:01 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:26:01 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:26:01 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 05:26:01 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:26:01 INFO - u'jsshell-linux-x86_64.zip'], 05:26:01 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:26:01 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:26:01 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 05:26:01 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:26:01 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 05:26:01 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:26:01 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 05:26:01 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:26:01 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:26:01 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:26:01 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:26:01 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:26:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 05:26:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:26:01 INFO - Fetch https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 05:26:02 INFO - Http code: 200 05:26:02 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 05:26:02 INFO - x-amz-cf-id: wU323KI3MEYl8A1cEpCNDXjkGc67giwjmFK4F-_Z2uNd-UUm5uswOw== 05:26:02 INFO - x-amz-version-id: 1cVN.lgb5xSirYOuVdRpBSA7eZmPnQj8 05:26:02 INFO - Expected file size: 21958632 05:26:02 INFO - Obtained file size: 21958632 05:26:06 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:26:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 05:26:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:26:06 INFO - Fetch https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 05:26:07 INFO - Http code: 200 05:26:07 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 05:26:07 INFO - x-amz-cf-id: lOZ5tszTFnc--yoH-7Jp-qwHWIs0bB_wByQmE0mDFFmr3hgDllTyEw== 05:26:07 INFO - x-amz-version-id: 1cVN.lgb5xSirYOuVdRpBSA7eZmPnQj8 05:26:07 INFO - Expected file size: 21958632 05:26:07 INFO - Obtained file size: 21958632 05:26:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 05:26:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:26:12 INFO - Fetch https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 05:26:13 INFO - Http code: 200 05:26:13 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 05:26:13 INFO - x-amz-cf-id: KPZg4LIPOE_k5-9MCads8X2MH9B_b12VsLjetybW21PH3UengiOduQ== 05:26:13 INFO - x-amz-version-id: PnYdknJmuCFY3U09BfhwnCumFRvrSGWr 05:26:13 INFO - Expected file size: 14403005 05:26:13 INFO - Obtained file size: 14403005 05:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:13 INFO - trying https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 05:26:13 INFO - Downloading https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 05:26:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:26:14 INFO - Downloaded 57722786 bytes. 05:26:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 05:26:14 INFO - mkdir: /builds/slave/test/properties 05:26:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:26:14 INFO - Writing to file /builds/slave/test/properties/build_url 05:26:14 INFO - Contents: 05:26:14 INFO - build_url:https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 05:26:15 INFO - Running post-action listener: _resource_record_post_action 05:26:15 INFO - Running post-action listener: set_extra_try_arguments 05:26:15 INFO - [mozharness: 2017-02-16 13:26:15.250746Z] Finished download-and-extract step (success) 05:26:15 INFO - [mozharness: 2017-02-16 13:26:15.250972Z] Running populate-webroot step. 05:26:15 INFO - Running pre-action listener: _resource_record_pre_action 05:26:15 INFO - Running main action method: populate_webroot 05:26:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:26:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:26:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:26:15 INFO - '--tppagecycles', 05:26:15 INFO - '7'], 05:26:15 INFO - 'tests': ['tsvgm']}}, 05:26:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:26:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:26:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:26:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:26:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:26:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:26:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:15 INFO - 'talos_options': ['--disable-e10s'], 05:26:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:15 INFO - 'talos_options': ['--disable-e10s'], 05:26:15 INFO - 'tests': ['damp', 'tps']}, 05:26:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:15 INFO - 'tests': ['damp', 'tps']}, 05:26:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:26:15 INFO - 'tests': ['dromaeo_dom']}, 05:26:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:26:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:26:15 INFO - 'tests': ['basic_compositor_video']}, 05:26:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:26:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:26:15 INFO - 'tests': ['a11yr', 05:26:15 INFO - 'ts_paint', 05:26:15 INFO - 'tpaint', 05:26:15 INFO - 'sessionrestore', 05:26:15 INFO - 'sessionrestore_no_auto_restore', 05:26:15 INFO - 'tabpaint']}, 05:26:15 INFO - 'other-e10s': {'tests': ['a11yr', 05:26:15 INFO - 'ts_paint', 05:26:15 INFO - 'tpaint', 05:26:15 INFO - 'sessionrestore', 05:26:15 INFO - 'sessionrestore_no_auto_restore', 05:26:15 INFO - 'tabpaint']}, 05:26:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:26:15 INFO - 'ts_paint', 05:26:15 INFO - 'tpaint', 05:26:15 INFO - 'sessionrestore', 05:26:15 INFO - 'sessionrestore_no_auto_restore', 05:26:15 INFO - 'tabpaint']}, 05:26:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:26:15 INFO - 'ts_paint', 05:26:15 INFO - 'tpaint', 05:26:15 INFO - 'sessionrestore', 05:26:15 INFO - 'sessionrestore_no_auto_restore', 05:26:15 INFO - 'tabpaint']}, 05:26:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:26:15 INFO - 'tests': ['a11yr', 05:26:15 INFO - 'ts_paint', 05:26:15 INFO - 'tpaint', 05:26:15 INFO - 'sessionrestore', 05:26:15 INFO - 'sessionrestore_no_auto_restore', 05:26:15 INFO - 'tabpaint']}, 05:26:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:26:15 INFO - 'tests': ['a11yr', 05:26:15 INFO - 'ts_paint', 05:26:15 INFO - 'tpaint', 05:26:15 INFO - 'sessionrestore', 05:26:15 INFO - 'sessionrestore_no_auto_restore', 05:26:15 INFO - 'tabpaint']}, 05:26:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:26:15 INFO - 'tests': ['tsvgx', 05:26:15 INFO - 'tsvgr_opacity', 05:26:15 INFO - 'tart', 05:26:15 INFO - 'tscrollx', 05:26:15 INFO - 'cart']}, 05:26:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:26:15 INFO - 'tsvgr_opacity', 05:26:15 INFO - 'tart', 05:26:15 INFO - 'tscrollx', 05:26:15 INFO - 'cart']}, 05:26:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:15 INFO - 'talos_options': ['--disable-e10s'], 05:26:15 INFO - 'tests': ['tp5o']}, 05:26:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:15 INFO - 'tests': ['tp5o']}, 05:26:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:15 INFO - 'talos_options': ['--disable-e10s', 05:26:15 INFO - '--xperf_path', 05:26:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:15 INFO - 'tests': ['tp5n']}, 05:26:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:15 INFO - 'talos_options': ['--xperf_path', 05:26:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:15 INFO - 'tests': ['tp5n']}}, 05:26:15 INFO - 'talos.zip': {'path': '', 05:26:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:26:15 INFO - Running post-action listener: _resource_record_post_action 05:26:15 INFO - [mozharness: 2017-02-16 13:26:15.267183Z] Finished populate-webroot step (success) 05:26:15 INFO - [mozharness: 2017-02-16 13:26:15.267271Z] Running create-virtualenv step. 05:26:15 INFO - Running pre-action listener: _resource_record_pre_action 05:26:15 INFO - Running main action method: create_virtualenv 05:26:15 INFO - Creating virtualenv /builds/slave/test/build/venv 05:26:15 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 05:26:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:26:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:26:15 INFO - Using real prefix '/usr' 05:26:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:26:15 INFO - Installing distribute.............................................................................................................................................................................................done. 05:26:17 INFO - Installing pip.................done. 05:26:17 INFO - Return code: 0 05:26:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:26:18 INFO - Reading from file tmpfile_stdout 05:26:18 INFO - Output received: 05:26:18 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) 05:26:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:18 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 0x7f8e948d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a4f60>, '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 0x21a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a61d0>, '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': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', '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 05:26:18 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 05:26:18 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 05:26:18 INFO - Using env: {'DISPLAY': ':0', 05:26:18 INFO - 'HOME': '/home/cltbld', 05:26:18 INFO - 'LANG': 'en_US.UTF-8', 05:26:18 INFO - 'LANGUAGE': 'en_US:en', 05:26:18 INFO - 'LOGNAME': 'cltbld', 05:26:18 INFO - 'MAIL': '/var/mail/cltbld', 05:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:18 INFO - 'MOZ_NO_REMOTE': '1', 05:26:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:18 INFO - 'NO_EM_RESTART': '1', 05:26:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:18 INFO - 'PWD': '/builds/slave/test', 05:26:18 INFO - 'SHELL': '/bin/bash', 05:26:18 INFO - 'SHLVL': '1', 05:26:18 INFO - 'TERM': 'linux', 05:26:18 INFO - 'TMOUT': '86400', 05:26:18 INFO - 'USER': 'cltbld', 05:26:18 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', 05:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:18 INFO - '_': '/tools/buildbot/bin/python'} 05:26:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:18 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 05:26:18 INFO - Cleaning up... 05:26:18 INFO - Return code: 0 05:26:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:18 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 0x7f8e948d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a4f60>, '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 0x21a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a61d0>, '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': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', '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 05:26:18 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 05:26:18 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 05:26:18 INFO - Using env: {'DISPLAY': ':0', 05:26:18 INFO - 'HOME': '/home/cltbld', 05:26:18 INFO - 'LANG': 'en_US.UTF-8', 05:26:18 INFO - 'LANGUAGE': 'en_US:en', 05:26:18 INFO - 'LOGNAME': 'cltbld', 05:26:18 INFO - 'MAIL': '/var/mail/cltbld', 05:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:18 INFO - 'MOZ_NO_REMOTE': '1', 05:26:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:18 INFO - 'NO_EM_RESTART': '1', 05:26:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:18 INFO - 'PWD': '/builds/slave/test', 05:26:18 INFO - 'SHELL': '/bin/bash', 05:26:18 INFO - 'SHLVL': '1', 05:26:18 INFO - 'TERM': 'linux', 05:26:18 INFO - 'TMOUT': '86400', 05:26:18 INFO - 'USER': 'cltbld', 05:26:18 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', 05:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:18 INFO - '_': '/tools/buildbot/bin/python'} 05:26:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:18 INFO - Downloading/unpacking psutil>=3.1.1 05:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:26:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:20 INFO - Installing collected packages: psutil 05:26:20 INFO - Running setup.py install for psutil 05:26:20 INFO - building 'psutil._psutil_linux' extension 05:26:20 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 05:26:20 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 05:26:20 INFO - building 'psutil._psutil_posix' extension 05:26:20 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 05:26:21 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 05:26:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:21 INFO - Successfully installed psutil 05:26:21 INFO - Cleaning up... 05:26:21 INFO - Return code: 0 05:26:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:26:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:21 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 0x7f8e948d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a4f60>, '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 0x21a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a61d0>, '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': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', '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 05:26:21 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 05:26:21 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 05:26:21 INFO - Using env: {'DISPLAY': ':0', 05:26:21 INFO - 'HOME': '/home/cltbld', 05:26:21 INFO - 'LANG': 'en_US.UTF-8', 05:26:21 INFO - 'LANGUAGE': 'en_US:en', 05:26:21 INFO - 'LOGNAME': 'cltbld', 05:26:21 INFO - 'MAIL': '/var/mail/cltbld', 05:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:21 INFO - 'MOZ_NO_REMOTE': '1', 05:26:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:21 INFO - 'NO_EM_RESTART': '1', 05:26:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:21 INFO - 'PWD': '/builds/slave/test', 05:26:21 INFO - 'SHELL': '/bin/bash', 05:26:21 INFO - 'SHLVL': '1', 05:26:21 INFO - 'TERM': 'linux', 05:26:21 INFO - 'TMOUT': '86400', 05:26:21 INFO - 'USER': 'cltbld', 05:26:21 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', 05:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:21 INFO - '_': '/tools/buildbot/bin/python'} 05:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:26:21 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 05:26:21 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 05:26:21 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 05:26:21 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 05:26:21 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 05:26:21 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 05:26:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:26:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:26:23 INFO - Installing collected packages: mozsystemmonitor 05:26:23 INFO - Running setup.py install for mozsystemmonitor 05:26:23 INFO - Successfully installed mozsystemmonitor 05:26:23 INFO - Cleaning up... 05:26:23 INFO - Return code: 0 05:26:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:26:23 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')]} 05:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:23 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')]} 05:26:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:23 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 0x7f8e948d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a4f60>, '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 0x21a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a61d0>, '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': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', '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 05:26:23 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 05:26:23 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 05:26:23 INFO - Using env: {'DISPLAY': ':0', 05:26:23 INFO - 'HOME': '/home/cltbld', 05:26:23 INFO - 'LANG': 'en_US.UTF-8', 05:26:23 INFO - 'LANGUAGE': 'en_US:en', 05:26:23 INFO - 'LOGNAME': 'cltbld', 05:26:23 INFO - 'MAIL': '/var/mail/cltbld', 05:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:23 INFO - 'MOZ_NO_REMOTE': '1', 05:26:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:23 INFO - 'NO_EM_RESTART': '1', 05:26:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:23 INFO - 'PWD': '/builds/slave/test', 05:26:23 INFO - 'SHELL': '/bin/bash', 05:26:23 INFO - 'SHLVL': '1', 05:26:23 INFO - 'TERM': 'linux', 05:26:23 INFO - 'TMOUT': '86400', 05:26:23 INFO - 'USER': 'cltbld', 05:26:23 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', 05:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:23 INFO - '_': '/tools/buildbot/bin/python'} 05:26:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:23 INFO - Downloading/unpacking jsonschema==2.5.1 05:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:26:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:26 INFO - Downloading functools32-3.2.3-2.tar.gz 05:26:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:26:26 INFO - warning: no files found matching '*.txt' 05:26:26 INFO - no previously-included directories found matching 'build' 05:26:26 INFO - no previously-included directories found matching 'dist' 05:26:26 INFO - no previously-included directories found matching '.git*' 05:26:26 INFO - Installing collected packages: jsonschema, functools32 05:26:26 INFO - Running setup.py install for functools32 05:26:26 INFO - warning: no files found matching '*.txt' 05:26:26 INFO - no previously-included directories found matching 'build' 05:26:26 INFO - no previously-included directories found matching 'dist' 05:26:26 INFO - no previously-included directories found matching '.git*' 05:26:26 INFO - Successfully installed jsonschema functools32 05:26:26 INFO - Cleaning up... 05:26:26 INFO - Return code: 0 05:26:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8e948d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a4f60>, '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 0x21a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a61d0>, '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': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', '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 05:26:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:26:26 INFO - Using env: {'DISPLAY': ':0', 05:26:26 INFO - 'HOME': '/home/cltbld', 05:26:26 INFO - 'LANG': 'en_US.UTF-8', 05:26:26 INFO - 'LANGUAGE': 'en_US:en', 05:26:26 INFO - 'LOGNAME': 'cltbld', 05:26:26 INFO - 'MAIL': '/var/mail/cltbld', 05:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:26 INFO - 'MOZ_NO_REMOTE': '1', 05:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:26 INFO - 'NO_EM_RESTART': '1', 05:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:26 INFO - 'PWD': '/builds/slave/test', 05:26:26 INFO - 'SHELL': '/bin/bash', 05:26:26 INFO - 'SHLVL': '1', 05:26:26 INFO - 'TERM': 'linux', 05:26:26 INFO - 'TMOUT': '86400', 05:26:26 INFO - 'USER': 'cltbld', 05:26:26 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', 05:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:26 INFO - '_': '/tools/buildbot/bin/python'} 05:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:26:26 INFO - Cleaning up... 05:26:26 INFO - Return code: 0 05:26:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8e948d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a4f60>, '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 0x21a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a61d0>, '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': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', '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 05:26:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:26:26 INFO - Using env: {'DISPLAY': ':0', 05:26:26 INFO - 'HOME': '/home/cltbld', 05:26:26 INFO - 'LANG': 'en_US.UTF-8', 05:26:26 INFO - 'LANGUAGE': 'en_US:en', 05:26:26 INFO - 'LOGNAME': 'cltbld', 05:26:26 INFO - 'MAIL': '/var/mail/cltbld', 05:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:26 INFO - 'MOZ_NO_REMOTE': '1', 05:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:26 INFO - 'NO_EM_RESTART': '1', 05:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:26 INFO - 'PWD': '/builds/slave/test', 05:26:26 INFO - 'SHELL': '/bin/bash', 05:26:26 INFO - 'SHLVL': '1', 05:26:26 INFO - 'TERM': 'linux', 05:26:26 INFO - 'TMOUT': '86400', 05:26:26 INFO - 'USER': 'cltbld', 05:26:26 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', 05:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:26 INFO - '_': '/tools/buildbot/bin/python'} 05:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:26 INFO - Downloading/unpacking blobuploader==1.2.4 05:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:28 INFO - Downloading blobuploader-1.2.4.tar.gz 05:26:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:26:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:26:28 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 05:26:28 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 05:26:28 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 05:26:28 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 05:26:28 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 05:26:28 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 05:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:26:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26:29 INFO - Downloading docopt-0.6.1.tar.gz 05:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:26:29 INFO - Installing collected packages: blobuploader, requests, docopt 05:26:29 INFO - Running setup.py install for blobuploader 05:26:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:26:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:26:29 INFO - Running setup.py install for requests 05:26:30 INFO - Running setup.py install for docopt 05:26:30 INFO - Successfully installed blobuploader requests docopt 05:26:30 INFO - Cleaning up... 05:26:30 INFO - Return code: 0 05:26:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:30 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')]} 05:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:30 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')]} 05:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:30 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 0x7f8e948d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a4f60>, '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 0x21a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a61d0>, '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': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', '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 05:26:30 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 05:26:30 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 05:26:30 INFO - Using env: {'DISPLAY': ':0', 05:26:30 INFO - 'HOME': '/home/cltbld', 05:26:30 INFO - 'LANG': 'en_US.UTF-8', 05:26:30 INFO - 'LANGUAGE': 'en_US:en', 05:26:30 INFO - 'LOGNAME': 'cltbld', 05:26:30 INFO - 'MAIL': '/var/mail/cltbld', 05:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:30 INFO - 'MOZ_NO_REMOTE': '1', 05:26:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:30 INFO - 'NO_EM_RESTART': '1', 05:26:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:30 INFO - 'PWD': '/builds/slave/test', 05:26:30 INFO - 'SHELL': '/bin/bash', 05:26:30 INFO - 'SHLVL': '1', 05:26:30 INFO - 'TERM': 'linux', 05:26:30 INFO - 'TMOUT': '86400', 05:26:30 INFO - 'USER': 'cltbld', 05:26:30 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', 05:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:30 INFO - '_': '/tools/buildbot/bin/python'} 05:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:26:30 INFO - Running setup.py (path:/tmp/pip-PfWNnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:26:30 INFO - Running setup.py (path:/tmp/pip-J7U_RO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:26:30 INFO - Running setup.py (path:/tmp/pip-GRYuyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:26:30 INFO - Running setup.py (path:/tmp/pip-0EUmdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:26:30 INFO - Running setup.py (path:/tmp/pip-0iFGiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:26:30 INFO - Running setup.py (path:/tmp/pip-qwPcjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:26:30 INFO - Running setup.py (path:/tmp/pip-f9mgrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:26:31 INFO - Running setup.py (path:/tmp/pip-1FMlqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:26:31 INFO - Running setup.py (path:/tmp/pip-FIYVsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:26:31 INFO - Running setup.py (path:/tmp/pip-yWieoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:26:31 INFO - Running setup.py (path:/tmp/pip-R_k758-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:26:31 INFO - Running setup.py (path:/tmp/pip-nsNka0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:26:31 INFO - Running setup.py (path:/tmp/pip-r44Eyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:26:31 INFO - Running setup.py (path:/tmp/pip-RiOx4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:31 INFO - Running setup.py (path:/tmp/pip-MCkKpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:26:31 INFO - Running setup.py (path:/tmp/pip-2ydtHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:31 INFO - Running setup.py (path:/tmp/pip-kMIPWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:26:31 INFO - Running setup.py install for manifestparser 05:26:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:26:31 INFO - Running setup.py install for mozcrash 05:26:31 INFO - Running setup.py install for mozdebug 05:26:32 INFO - Running setup.py install for mozdevice 05:26:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:26:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:26:32 INFO - Running setup.py install for mozfile 05:26:32 INFO - Running setup.py install for mozhttpd 05:26:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:26:32 INFO - Running setup.py install for mozinfo 05:26:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:26:32 INFO - Running setup.py install for mozInstall 05:26:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:26:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:26:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:26:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:26:32 INFO - Running setup.py install for mozleak 05:26:32 INFO - Running setup.py install for mozlog 05:26:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:26:32 INFO - Running setup.py install for moznetwork 05:26:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:26:32 INFO - Running setup.py install for mozprocess 05:26:33 INFO - Running setup.py install for mozprofile 05:26:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:26:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:26:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:26:33 INFO - Running setup.py install for mozrunner 05:26:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:26:33 INFO - Running setup.py install for mozscreenshot 05:26:33 INFO - Running setup.py install for moztest 05:26:33 INFO - Running setup.py install for mozversion 05:26:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:26:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:26:33 INFO - Cleaning up... 05:26:33 INFO - Return code: 0 05:26:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:33 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')]} 05:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:33 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')]} 05:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:33 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 0x7f8e948d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a4f60>, '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 0x21a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a61d0>, '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': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', '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 05:26:33 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 05:26:33 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 05:26:33 INFO - Using env: {'DISPLAY': ':0', 05:26:33 INFO - 'HOME': '/home/cltbld', 05:26:33 INFO - 'LANG': 'en_US.UTF-8', 05:26:33 INFO - 'LANGUAGE': 'en_US:en', 05:26:33 INFO - 'LOGNAME': 'cltbld', 05:26:33 INFO - 'MAIL': '/var/mail/cltbld', 05:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:33 INFO - 'MOZ_NO_REMOTE': '1', 05:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:33 INFO - 'NO_EM_RESTART': '1', 05:26:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:33 INFO - 'PWD': '/builds/slave/test', 05:26:33 INFO - 'SHELL': '/bin/bash', 05:26:33 INFO - 'SHLVL': '1', 05:26:33 INFO - 'TERM': 'linux', 05:26:33 INFO - 'TMOUT': '86400', 05:26:33 INFO - 'USER': 'cltbld', 05:26:33 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', 05:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:33 INFO - '_': '/tools/buildbot/bin/python'} 05:26:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:26:33 INFO - Running setup.py (path:/tmp/pip-tlYZxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:26:33 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)) 05:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:26:33 INFO - Running setup.py (path:/tmp/pip-t4qaBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:26:33 INFO - Running setup.py (path:/tmp/pip-ugbWFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:26:34 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)) 05:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:26:34 INFO - Running setup.py (path:/tmp/pip-Ze2zHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:26:34 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)) 05:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:26:34 INFO - Running setup.py (path:/tmp/pip-HUbSeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:26:34 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)) 05:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:26:34 INFO - Running setup.py (path:/tmp/pip-XRJKz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:26:34 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)) 05:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:26:34 INFO - Running setup.py (path:/tmp/pip-qjpjT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:26:34 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)) 05:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:26:34 INFO - Running setup.py (path:/tmp/pip-lcOqKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:26:34 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)) 05:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:26:34 INFO - Running setup.py (path:/tmp/pip-6J46un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:26:34 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)) 05:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:26:34 INFO - Running setup.py (path:/tmp/pip-rhdj5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:26:34 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)) 05:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:26:34 INFO - Running setup.py (path:/tmp/pip-cgLDmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:26:34 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)) 05:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:26:34 INFO - Running setup.py (path:/tmp/pip-pTc3da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:26:34 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)) 05:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:26:34 INFO - Running setup.py (path:/tmp/pip-UQPihV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:26:34 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)) 05:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:26:34 INFO - Running setup.py (path:/tmp/pip-eqY7I8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:26:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:34 INFO - Running setup.py (path:/tmp/pip-MCTmlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:34 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)) 05:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:26:34 INFO - Running setup.py (path:/tmp/pip-F1K_tE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 05:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:34 INFO - Running setup.py (path:/tmp/pip-vSVzxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:35 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)) 05:26:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:26:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:26:35 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)) 05:26:35 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)) 05:26:35 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)) 05:26:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:26:35 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 05:26:35 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 05:26:35 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 05:26:35 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 05:26:35 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 05:26:35 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 05:26:37 INFO - Downloading blessings-1.6.tar.gz 05:26:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:26:37 INFO - Installing collected packages: blessings 05:26:37 INFO - Running setup.py install for blessings 05:26:37 INFO - Successfully installed blessings 05:26:37 INFO - Cleaning up... 05:26:37 INFO - Return code: 0 05:26:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:26:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:37 INFO - Reading from file tmpfile_stdout 05:26:37 INFO - Current package versions: 05:26:37 INFO - argparse == 1.2.1 05:26:37 INFO - blessings == 1.6 05:26:37 INFO - blobuploader == 1.2.4 05:26:37 INFO - docopt == 0.6.1 05:26:37 INFO - functools32 == 3.2.3-2 05:26:37 INFO - jsonschema == 2.5.1 05:26:37 INFO - manifestparser == 1.1 05:26:37 INFO - mozInstall == 1.12 05:26:37 INFO - mozcrash == 1.0 05:26:37 INFO - mozdebug == 0.1 05:26:37 INFO - mozdevice == 0.48 05:26:37 INFO - mozfile == 1.2 05:26:37 INFO - mozhttpd == 0.7 05:26:37 INFO - mozinfo == 0.9 05:26:37 INFO - mozleak == 0.1 05:26:37 INFO - mozlog == 3.4 05:26:37 INFO - moznetwork == 0.27 05:26:37 INFO - mozprocess == 0.23 05:26:37 INFO - mozprofile == 0.28 05:26:37 INFO - mozrunner == 6.13 05:26:37 INFO - mozscreenshot == 0.1 05:26:37 INFO - mozsystemmonitor == 0.3 05:26:37 INFO - moztest == 0.8 05:26:37 INFO - mozversion == 1.4 05:26:37 INFO - psutil == 3.1.1 05:26:37 INFO - requests == 1.2.3 05:26:37 INFO - wsgiref == 0.1.2 05:26:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26: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')]} 05:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26: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')]} 05:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:37 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 0x7f8e948d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a4f60>, '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 0x21a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a61d0>, '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': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', '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 05:26:37 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 05:26:37 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 05:26:37 INFO - Using env: {'DISPLAY': ':0', 05:26:37 INFO - 'HOME': '/home/cltbld', 05:26:37 INFO - 'LANG': 'en_US.UTF-8', 05:26:37 INFO - 'LANGUAGE': 'en_US:en', 05:26:37 INFO - 'LOGNAME': 'cltbld', 05:26:37 INFO - 'MAIL': '/var/mail/cltbld', 05:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:37 INFO - 'MOZ_NO_REMOTE': '1', 05:26:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:37 INFO - 'NO_EM_RESTART': '1', 05:26:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:37 INFO - 'PWD': '/builds/slave/test', 05:26:37 INFO - 'SHELL': '/bin/bash', 05:26:37 INFO - 'SHLVL': '1', 05:26:37 INFO - 'TERM': 'linux', 05:26:37 INFO - 'TMOUT': '86400', 05:26:37 INFO - 'USER': 'cltbld', 05:26:37 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', 05:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:37 INFO - '_': '/tools/buildbot/bin/python'} 05:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:37 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)) 05:26:37 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)) 05:26:37 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)) 05:26:37 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)) 05:26:37 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)) 05:26:37 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)) 05:26:37 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)) 05:26:37 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)) 05:26:37 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)) 05:26:37 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)) 05:26:37 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)) 05:26:37 INFO - Cleaning up... 05:26:37 INFO - Return code: 0 05:26:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:26: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')]} 05:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26: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')]} 05:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e948d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a4f60>, '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 0x21a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a61d0>, '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': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', '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 05:26: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', 'jsonschema'] in /builds/slave/test/build 05:26: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 jsonschema 05:26:37 INFO - Using env: {'DISPLAY': ':0', 05:26:37 INFO - 'HOME': '/home/cltbld', 05:26:37 INFO - 'LANG': 'en_US.UTF-8', 05:26:37 INFO - 'LANGUAGE': 'en_US:en', 05:26:37 INFO - 'LOGNAME': 'cltbld', 05:26:37 INFO - 'MAIL': '/var/mail/cltbld', 05:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:37 INFO - 'MOZ_NO_REMOTE': '1', 05:26:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:37 INFO - 'NO_EM_RESTART': '1', 05:26:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:37 INFO - 'PWD': '/builds/slave/test', 05:26:37 INFO - 'SHELL': '/bin/bash', 05:26:37 INFO - 'SHLVL': '1', 05:26:37 INFO - 'TERM': 'linux', 05:26:37 INFO - 'TMOUT': '86400', 05:26:37 INFO - 'USER': 'cltbld', 05:26:37 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', 05:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:37 INFO - '_': '/tools/buildbot/bin/python'} 05:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:26:38 INFO - Cleaning up... 05:26:38 INFO - Return code: 0 05:26:38 INFO - Running post-action listener: _resource_record_post_action 05:26:38 INFO - Running post-action listener: _start_resource_monitoring 05:26:38 INFO - Starting resource monitoring. 05:26:38 INFO - [mozharness: 2017-02-16 13:26:38.107398Z] Finished create-virtualenv step (success) 05:26:38 INFO - [mozharness: 2017-02-16 13:26:38.107920Z] Running install step. 05:26:38 INFO - Running pre-action listener: _resource_record_pre_action 05:26:38 INFO - Running main action method: install 05:26:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:38 INFO - Reading from file tmpfile_stdout 05:26:38 INFO - Detecting whether we're running mozinstall >=1.0... 05:26:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:26:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:26:38 INFO - Reading from file tmpfile_stdout 05:26:38 INFO - Output received: 05:26:38 INFO - Usage: mozinstall [options] installer 05:26:38 INFO - Options: 05:26:38 INFO - -h, --help show this help message and exit 05:26:38 INFO - -d DEST, --destination=DEST 05:26:38 INFO - Directory to install application into. [default: 05:26:38 INFO - "/builds/slave/test"] 05:26:38 INFO - --app=APP Application being installed. [default: firefox] 05:26:38 INFO - mkdir: /builds/slave/test/build/application 05:26:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:26:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:26:52 INFO - Reading from file tmpfile_stdout 05:26:52 INFO - Output received: 05:26:52 INFO - /builds/slave/test/build/application/firefox/firefox 05:26:52 INFO - Running post-action listener: _resource_record_post_action 05:26:52 INFO - [mozharness: 2017-02-16 13:26:52.047023Z] Finished install step (success) 05:26:52 INFO - [mozharness: 2017-02-16 13:26:52.047266Z] Running run-tests step. 05:26:52 INFO - Running pre-action listener: _resource_record_pre_action 05:26:52 INFO - Running main action method: run_tests 05:26:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:26:52 INFO - Python 2.7.3 05:26:52 INFO - Return code: 0 05:26:52 INFO - grabbing minidump binary from tooltool 05:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:52 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 0x21a4f60>, '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 0x21a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a61d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:26:52 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 05:26:52 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 05:26:52 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 05:26:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:26:52 INFO - Return code: 0 05:26:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:26:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:26:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:26:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:26:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:26:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:26:52 INFO - Using env: {'DISPLAY': ':0', 05:26:52 INFO - 'HOME': '/home/cltbld', 05:26:52 INFO - 'LANG': 'en_US.UTF-8', 05:26:52 INFO - 'LANGUAGE': 'en_US:en', 05:26:52 INFO - 'LOGNAME': 'cltbld', 05:26:52 INFO - 'MAIL': '/var/mail/cltbld', 05:26:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:26:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:52 INFO - 'MOZ_NO_REMOTE': '1', 05:26:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:26:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:52 INFO - 'NO_EM_RESTART': '1', 05:26:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:52 INFO - 'PWD': '/builds/slave/test', 05:26:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:26:52 INFO - 'SHELL': '/bin/bash', 05:26:52 INFO - 'SHLVL': '1', 05:26:52 INFO - 'TERM': 'linux', 05:26:52 INFO - 'TMOUT': '86400', 05:26:52 INFO - 'USER': 'cltbld', 05:26:52 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1487251558.475970-857223227', 05:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:52 INFO - '_': '/tools/buildbot/bin/python'} 05:26:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:26:52 INFO - mozversion application_buildid: 20170216033818 05:26:52 INFO - mozversion application_changeset: b5dec8abc97b2b8259d71b74c00b0ad90cc37d4e 05:26:52 INFO - mozversion application_display_name: Firefox 05:26:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:26:52 INFO - mozversion application_name: Firefox 05:26:52 INFO - mozversion application_remotingname: firefox 05:26:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:26:52 INFO - mozversion application_vendor: Mozilla 05:26:52 INFO - mozversion application_version: 52.0 05:26:52 INFO - mozversion platform_buildid: 20170216033818 05:26:52 INFO - mozversion platform_changeset: b5dec8abc97b2b8259d71b74c00b0ad90cc37d4e 05:26:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:26:52 INFO - mozversion platform_version: 52.0 05:26:52 INFO - using testdate: 1487251612 05:26:52 INFO - actual date: 1487251612 05:26:52 INFO - starting webserver on 'localhost:33184' 05:26:52 INFO - SUITE-START | Running 2 tests 05:26:52 INFO - TEST-START | dromaeo_css 05:26:52 INFO - operating with platform_type : linux_ 05:26:52 INFO - Initialising browser for dromaeo_css test... 05:26:52 INFO - TEST-INFO | started process 32020 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNwsIvF/profile http://localhost:33184/getInfo.html) 05:26:57 INFO - PROCESS | 32020 | __metrics Screen width/height:1600/1200 05:26:57 INFO - PROCESS | 32020 | colorDepth:24 05:26:57 INFO - PROCESS | 32020 | Browser inner width/height: 1024/697 05:26:57 INFO - PROCESS | 32020 | __metrics 05:26:57 ERROR - PROCESS | 32020 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 05:26:58 INFO - TEST-INFO | 32020: exit 0 05:26:58 INFO - Browser initialized. 05:26:58 INFO - Running cycle 1/1 for dromaeo_css test... 05:26:58 INFO - TEST-INFO | started process 32151 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNwsIvF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:10 INFO - PROCESS | 32151 | RSS: Main: 147243008 05:27:10 INFO - PROCESS | 32151 | 05:30:10 INFO - PROCESS | 32151 | Cycle 1(1): loaded http://localhost:33184/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33184/tests/dromaeo/cssquery-ext.html) 05:30:11 INFO - PROCESS | 32151 | RSS: Main: 154398720 05:30:11 INFO - PROCESS | 32151 | 05:33:13 INFO - PROCESS | 32151 | Cycle 1(1): loaded http://localhost:33184/tests/dromaeo/cssquery-ext.html (next: http://localhost:33184/tests/dromaeo/cssquery-jquery.html) 05:33:14 INFO - PROCESS | 32151 | RSS: Main: 152006656 05:33:14 INFO - PROCESS | 32151 | 05:36:16 INFO - PROCESS | 32151 | Cycle 1(1): loaded http://localhost:33184/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33184/tests/dromaeo/cssquery-mootools.html) 05:36:16 INFO - PROCESS | 32151 | RSS: Main: 151912448 05:36:16 INFO - PROCESS | 32151 | 05:39:18 INFO - PROCESS | 32151 | Cycle 1(1): loaded http://localhost:33184/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33184/tests/dromaeo/cssquery-prototype.html) 05:39:19 INFO - PROCESS | 32151 | RSS: Main: 152694784 05:39:19 INFO - PROCESS | 32151 | 05:42:21 INFO - PROCESS | 32151 | Cycle 1(1): loaded http://localhost:33184/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33184/tests/dromaeo/cssquery-yui.html) 05:42:22 INFO - PROCESS | 32151 | RSS: Main: 154365952 05:42:22 INFO - PROCESS | 32151 | 05:45:24 INFO - PROCESS | 32151 | Cycle 1(1): loaded http://localhost:33184/tests/dromaeo/cssquery-yui.html (next: http://localhost:33184/tests/dromaeo/cssquery-dojo.html) 05:45:24 INFO - PROCESS | 32151 | RSS: Main: 154714112 05:45:24 INFO - PROCESS | 32151 | 05:45:24 INFO - PROCESS | 32151 | __start_tp_report 05:45:24 INFO - PROCESS | 32151 | _x_x_mozilla_page_load 05:45:24 INFO - PROCESS | 32151 | _x_x_mozilla_page_load_details 05:45:24 INFO - PROCESS | 32151 | |i|pagename|runs| 05:45:24 INFO - PROCESS | 32151 | |0;dojo.html;3181.9204519887;3196.184972831929;3212.7751057425976;3214.6624604416534;3217.1313745288758;5497.5601951843855;5521.558275337973;5541.445855414457;5554.638948468347;5563.666180029196;5648.802291919784;5675.801346952858;5679.488846003859;5685.232493613361;5688.061469857468;5124.564412024983;5149.562287205592;5184.792608295683;5209;5229.86925326868;5166.276721259027;5211.3746350438005;5216.973915130419;5221.347331583552;5226.973865130669;5038.093143234235;5067.594592432615;5113.616478764089;5227.503387178231;5241.73791310433;5092.796288148488;5148.536631703146;5188.610854185951;5192.870178245536;5249.816256431045;5113.463086375951;5161.638685292031;5164.845054648366;5169.353830771153;5171.663841850268;5390.434004429557;5629.3526244482;5649.830505084854;5693.117566777156;5708.600397972144;5822.621529600562;5922;5939.762409503614;6000.96999515004;6044.093385992092;5970.850728731773;6034.939650603482;6038.667873266969;6041.939580604182;6046.667433291167;5621.4659607337235;5621.494065534081;5622.550195984352;5627.8593035174445;5643.097104463266;6105.32841387447;6129.205975626751;6152.446279834747;6205.875882482415;6209.2548894133;5937.70311484424;5962.403759624003;5963.075723262901;5966.970165149233;5974.910376344358;5825.7378417971295;5899.085641725539;6063.242094738158;6069.332373439007;6070.544709146831;5865.266841644794;5895.852603684943;5929.970350148222;5931.288245410578;5976.462118409364;5926.2295901532525;5933.762649494059;5934.13954976526;5938.2280303560265;5953.077273022688;4525.79633916468;4599.379083823641;4623.583877451046;4635.420572428447;4646.140464014168;4074.8370065197655;4127;4128.525219599785;4177.665786737054;4201.390798334224;5764.538836893123;5801.274840644919;5801.7389217485315;5803.332616749043;5818.389069147678;6033.155358249848;6105.755769769159;6106;6107.908381374283;6129.264488261437;5540.639858409271;5590.748416321194;5637.408072152447;5688.288963879515;5723.998300297431;5144.2283657450935;5147.408048074444;5169.586433085344;5177.068127737043;5217.608679349064;6224.066390041439;6243.313235544178;6254.186955695731;6255.6872156392;6265.185525881606;5839.153322768259;5942.970285148546;5954.136650185786;6027.758889644365;6052.425019623129;6217.595856269328;6234.438900498977;6253.7185826637;6261.092141639528;6272.310045895039;5875.14810352488;5933.110033495011;5940.61386009908;5940.910886336795;5971.970140149271;5837.824865254049;5888.381719919346;5954.821355359346;6017.217761690952;6033.78881739137;5874.882502350015;5877.147813567094;5884.882302354014;5917.993941030121;5930.34766175729;5854.853628659318;5859.765609375577;5861.912071318849;5884.293884733688;5899.321578018411;5621.128725047624;5736.913946290892;5754.4533269339345;5839;5857.414258574279;5820.854478638068;5894.469497745224;5931.4068593142065;5961.582689211714;5966.671833049224;5749.770009199585;5770.278715160605;5777.94222057774;5782.913256301074;5783.971080144573 05:45:24 INFO - PROCESS | 32151 | |1;ext.html;621.2420846567188;647.7603286783891;649.8018104478132;653.0856800479328;656.1896058367918;38509;42017.57982420175;42083.15833683324;42120.78939605301;42142;42446;42812.571874281246;43077;43091.35362969558;43098.35352469708;8843.602037908293;8982.955085224565;8983.775405614846;8993.595288212045;8995.865062024075;8824.911750882506;8863.290936725047;8867.600957956874;8883;8885.46687198767;8736.825263494726;8776.912230877706;8797.296216302713;8801.295896328278;8806.251468625143;8917.420367676114;8940.061293564147;8941.463512189257;8953.149450802164;8953.149450802195;8831.205191532728;8872.911270887273;8881.289496840238;8883.822323553493;8901.866472002925;40407.39388909169;40848.183036339404;40866.38700419496;40876.79561602203;40880.591194087974;3177.0310055433315;3211.951820722691;3241.8054916705073;3744.8876533704033;4022.0749227677798;31982.6801731982;32073.198170045704;32200.516992245135;32497.187570310696;33032.6696733032;4353.673474489395;4418.094290670405;4456.013324158004;4507.4365704286965;4541.954580454186;332631;336359;338512;338519.99999999756;338758;55555.166672499945;55951.720241398536;56246.43753562494;56350.718246408505;56364.71817640885;57667;57943.4205657938;57966.710166448895;58034;58047.419525805046;15230.847691523164;15463.304151313218;15524.534263972098;15552;15555.922220388826;10698.41158736277;10770.676879693621;10787.892121078845;10812;10829.67510974672;15191.468298609716;15732.842671573138;15747.44883929057;15798;16224;5796.739146738407;5799.3620701722775;5809.593328467051;5895.941040589625;5978.342382337939;998.6953979036464;1099.0273607857105;1105.5958932156277;1105.9603972266045;1136.2216881436243;31236;31274.843625781727;31436.52845207324;31614.683853161176;32118.197045073593;1078.5524007536942;1081.324172392255;1086.8369744538381;1092.2900114925203;1107.2858006585707;16151.528538172402;16731.414400495923;16804.243809028623;16863.241154148094;16886.15569221534;241347;243134;243440;246342;246680;57382.7130864343;57715.422845771005;57719.42280577224;57735.133972990436;57797.71101144468;1333.5865881576742;1363.8840698540537;1366.5080570994435;1379.8068270442145;1392.9651758706113;30119.849400752857;31654;32485.18787030343;33984.490232647026;34084.659153408145;55930.161047583504;56463;56867.715661421425;56880;56883.43116568781;468661;473257;474773;474795;474835;42961.78519107385;43477;43508.56491435045;43732.56267437285;43963.34054989242;46736;47253;47310.52689473061;48338.274925876845;48581;39890.202195956495;39973.80013099916;40894.79552602218;41692;42273.78863105665;40217.59782402139;40389.1922161561;41395;41781.58218417777;42150.57849421589;36804;37217.627823721414;37443.43834842534;37528;37592.43611345887;35800.28399431945;37218.62781372152;37350.6264937358;37513;37679.43480847844;28664.283392915346;28668.42663146767;28751.568726469537;28952.855235723688;28956.42087158287 05:45:24 INFO - PROCESS | 32151 | |2;jquery.html;413.714536969491;422.1367303863599;423.24873349804074;425.43417255050775;440.8633323669663;18145.183466743994;19026.334078307245;19579.118939647713;19628;19751.20995160192;14300.61640587957;14316.71366572668;19688.507787305323;19729;19901.502462438446;5773.278340207464;5796.478316951474;5869.618474799146;5886.20536227608;5890.823275301748;5668.461496157858;5880.529557635379;5893.8821223575505;5898.970505147489;5936.079907614327;5635.690037047961;5782.508486778629;5814.156947242668;5822.243108395903;5872.765089396419;5803.040449370809;5834.504067154276;5869.295684517842;5875.441833025877;5920.733566989453;5169.56058735008;5268.578513718893;5278.9208161877605;5292.92060619091;5338.546223571001;23171.76828231713;23186.53626927469;23456;23609;23626.7637323628;2377.7741114594087;2530.4686015936677;3091.845407729627;3212.229065024401;3276.574045374086;14541.70916581673;14568.417263309455;14745.852541474555;14810.778383242492;15072.54782356531;1857.7863545692148;1859.33064096925;1875.3530032139026;1922.327185485083;1941.0294852573713;78644.60677696575;78792.21207787906;79258;80267.59866200632;80497.59751201324;10739;10748.570057197781;11066.225364224589;11177.72055698614;11313.886861131283;16005.67988640244;16017.67964640724;16028.75956860648;16084;16125.919370403073;7783.766487005399;7896.210378962058;7962.482438641586;8001.679932802623;8233.547154906419;7371.410287177013;7419.369353605004;7559.962200188964;7710.421718371144;7710.7686769397005;6813.897791533131;6814.291509592658;6858.725650974005;7004;7032.191298000693;1987.5490891649176;2033.3696554068285;2033.9084741186682;2051.7332746743127;2081.063521415369;975.8438649816137;1027.671145233533;1048.5962904281907;1074.237291523012;1086.0768346905068;19823.702644460343;19866.70199947002;20060.799392006185;20261.697459469575;20651.58696826085;1057.5611121384693;1070.1385384765338;1106.1372129738816;1108.95564177432;1126.3973774030853;10948;11646.41767911601;11654.708632284091;11679.416029198506;11896.88103118975;427889;428870;430080;440046;444320;76964.23035769683;78895.21736743026;83501;84115.5794221025;84350;1017.8269694151863;1029.45953374479;1037.232447988483;1040.7138037039724;1048.250500891866;17387.217575209397;17713.20290586901;17766.20052097633;17780.199891005195;18182;39953.80023099866;40426;40768.79615601903;40950.385744213265;41956.3706544396;53151.468485316196;53978.46021539735;54133.18800218079;54156;54234;9015.278777697637;9040.954795225982;9077.364584479023;9082.500462474627;9183.954080229556;13221.272829994057;13741;14085.08446950945;14099.224542650252;14105.929470352583;11384.772304554028;11790.882091178979;11830.526778928746;12162.513499460276;12423.633400325776;11478.770424591628;11900;11925.284482931052;11936.641900742992;12030.15788894804;11572;11620.767584648429;12010.219335743148;12025.819612705991;12108.818367724667;8708.346873984603;8920.86618700733;9039.845969382974;9069.682561110329;9127.315451341043;12083.214591051554;12095.395230238277;12243.32661703615;12248.816267755812;12537.749245015231 05:45:24 INFO - PROCESS | 32151 | |3;mootools.html;1482.1699848085073;1495.0730547060823;1631;1732.1685590916368;1781.225167052333;7325.9267407325915;7538.5099968502145;8035.156308587594;8517.31861451084;8535.317174626023;7949.960250198756;8223.424360294766;8225.753227403173;8426.325893928486;8440.788980275496;2367.9289621311345;2391.1630929174826;2392.091005417939;2396.376941995085;2401.3036219496325;2403.387136280246;2453.766892145243;2468.691413573303;2469.506098780242;2471.8393304435244;2348.3307257431634;2379.2267513058327;2383.8688872112025;2390.497995420964;2396.892139853711;2321.3152120124605;2324.476992676651;2346.0615753698485;2350.976490235093;2372.6559648850907;2340.9180678676166;2358.8820558972157;2383.0229605861514;2386.045581767307;2393.0786647140803;8414.116517765608;8489;8489.575521223915;8493.108223636553;8534.573271336409;4962.801487940478;5109.770060347293;5117.232415137722;5118.872028199287;5125.794968201268;3304.80171189727;3332.7333813294877;3388.40702876998;3412.1640198151363;3445.879394221215;1053.899879511445;1079.4171147580298;1081.0432767001182;1109.972250693731;1118.9608363707312;11246.718832029183;11250.324980501196;11293.60472383471;11339.092872570174;11358.318500889973;4274.615284624399;4482.820687172477;4485.237509623372;4523.5024147343765;4566.611837993742;8801.779955501164;8879.28965682744;8886.11138886119;8908.643654253758;8962.32782541299;4967.950320496749;4970.676906001098;4972.129877271463;4976.676516026447;4979.551840334388;4668.136394766979;4770.284457331428;4817.855464336076;4856.538628830255;4884.511548845087;3869.071422858494;3959.6634286086005;3967.325554655658;4035.3139966205817;4042.959570404317;1243.589615426907;1244.9875501244871;1247.600767754328;1251.249250449723;1255.54172726954;781.5193655901579;898.9146031127033;921.8755468011867;936.5083331251147;938.1697197979701;5474.124140137559;5480.780768769284;5540.445955404427;5583.3858275589655;5590.049691552445;452.7985046654273;468.377058512178;981.5386768218925;1040.8290672992882;1083.0469187115289;3836.712246581518;4040.5151381834366;4064.1262128641893;4097.91804163921;4152.007036622438;9735.902640973642;10238.436885971343;10285.794284114276;10325.32885362449;10361.740956475998;9957.203423726229;10135.847962280572;10166.288359814742;10171.084602385821;10200.489975501196;7458.85082298351;7565.924340756632;7569.621518923922;7583.696652133853;7597.050368703912;5607.271054762855;5662.745176466987;5711.685857277889;5803.100519419328;5892.204552385373;9535;9539.666111686058;9627.989061148759;9643.373180743229;9654.903450965401;9465.384749991228;9564;9609.279304052085;9658.517074146404;9674.56464459087;6691.799246022627;6831.385175334244;7134.571925684476;7241.674124664508;7302;8187.590620469072;8196.713115040944;8203.097659257357;8214.753557393287;8223.05434874997;6782.626955517297;6823.112995310578;6845.726170953305;6888.242293347627;7034.226235114031;6750.5274630775375;6812.693428795816;6844.760433384808;6926.06498122747;6957.721691132298;6713.832154196184;6789.762358317435;6832.726690932506;6834.726610935507;6872.725090996304;4843.975780121077;5033.949660503348;5098.847034588968;5110.744462776921;5145.9228111579105;4829;4927.507249275044;5063.87340316495;5094.5669618082875;5120.974395128001 05:45:24 INFO - PROCESS | 32151 | |4;prototype.html;337.45164108323974;339.41450997030125;354.40283122937853;357.76208821133946;358.29058464240785;5487.423820498845;5588.189712491686;5645.463680950314;5658.773649054043;5668.716564171796;5557.444255574441;5569.164625306206;5572.944270557293;5591.720413979295;5638.238837756901;4005.638083051762;4350.825966961325;4372.606465418112;4388.451443569554;4402.9873129180305;4244.893877653068;4299.957000429987;4327.783610819462;4347.804348804311;4348.326009468537;4319.416878721364;4322.243607368714;4323.265044942352;4324.264874971247;4328.394024836525;4325.502567204764;4339.2406328892475;4340.457442819647;4343.305071188594;4344.413504176927;3642.6721595056574;3703.611120832301;3748.887533374003;3760.52993375828;3830.1382189007527;5343.706096164709;5391.16436952273;5394.757235924393;5399.460053994609;5413.242146099549;4934.777934992934;4937.7410908800375;4945.901081978376;4963.4292056413615;4970.2793095001025;5644.548436125141;5809.622374545641;5827.184194212814;5829.88340233193;5834.241548598655;4205.537390887;4208.968802643372;4215.873523794291;4224.704270701052;4225.112726327475;5817.360090390053;6027.457528822427;6041.184440100574;6072.817815465543;6091.969540152271;4251.489821221473;4281.828726850953;4295.487140023059;4295.871123866289;4296.6347860432215;4330.17726631939;4340.417451616283;4347.6304514116655;4360.912781744348;4365.519792822787;4847.636427267969;4954.331165292711;4957.256411538298;4968;4984.77568509418;5852.853678658068;5862.8534286642325;5866.794662186803;5870.53035757147;5959.64593985382;1453.738327101132;1468.9632759180893;1473.5505670770303;1476.1585896039155;1480.6076389756722;957.5068839547639;1011.2516737614112;1014.6753039027587;1014.7716763728102;1024.6874703215442;5542.63972841764;5544.3346798384455;5560.972195138998;5561.277033985637;5576.749046292926;5746.913796293059;5792.594518383673;5798.9130163047585;5826.912596311059;5834.3080506652595;5367.484297784957;5458.935507575985;5464.9453505464435;5489.627593101724;5530.308711411074;3086.583311252997;3095.7091752103283;3097.1947293703797;3104.59640246771;3108.7875728465915;5821.301443826768;5832.88334233313;5964.671943043174;5994.820155395258;6036.698165091816;5763.7406316715005;5818.359980402152;5820.679862607597;5820.738066787005;5879.441453061952;5941.376155503696;5986.880262394728;5988;6007.459328660441;6028.156058151862;5480.945190548044;5671.092625179951;5682.289713785777;5727.226824378822;5804.332501762351;5692.260006199168;5697.635481275224;5697.658140511582;5717.628354156966;5734.340550836707;5978.551608629283;5979.910301345396;6210.161628180138;6227.688615569294;6277.529185311211;4261.595148460891;4273.401723758614;4274.786260687016;4283.528811830758;4330.220560299176;5886.735096920564;6044.607100538451;6066.514678825772;6098.420650038239;6100.627358844225;5819.505342045804;5875.559333049953;5877.001819381431;5879.353271140257;5887.146363777314;5837.532997360286;5849.327327357409;5851.561132914963;5852.736626851717;5884.7940322088525;5698.54411647059;5729.169270455677;5750.48245657876;5811.912821307768;5821.76712931495;5889.5582831286965;5926.525877929669;5927.940720592739;5936.554758393224;5944.405559444021;5637.5489960802215;5771.68255745938;5777.191193232867;5788.797392091256;5810.1575271586225 05:45:24 INFO - PROCESS | 32151 | |5;yui.html;647.3009150117873;647.7441410642796;672.143017652493;739.9445041621876;765.7587859824155;14678.486252981134;15250.313735881884;15266.007709498888;15321.616959576017;15434;12908.93545532271;12982.675433114176;12983.675408114801;13002.804957925615;15290.923545382286;812.6221307092186;814.2142832166958;832.8334333133367;839.9286060684849;842.4439869686008;823.3783493462457;829.7801082713056;833.1918039501704;833.4874052457756;833.4957350802767;877.4340550345023;879.2570278114982;879.5646155153177;880.9911900880974;881.3301890563187;870.316801310971;872.2106493623281;873.253368370044;874.2874557235896;877.2981614708208;644.1561554363799;645.1451826330132;645.5416654175541;647.0552992630764;648.4909346163239;14026.43894244229;14312.42750289987;14359;14380;15151.090934543852;13460.528881489101;14076.718465630733;14221.004529682927;14351.928240358731;14396.712065758626;10544.894551054467;10570.312929659547;10737.731556711067;10871.45642717869;10908.50911708975;3809.771413715186;3820.4269359596005;3854.3640299350573;3863.2273545291055;3928.7446315989655;65344.34655653478;66331;66426;67115.66442167757;67987;10530.368177909197;10639.946800265949;10723.14214862809;10723.30298530593;10848.78302433947;19827.206911723657;19890.303839365843;19976.20095196176;20031.29890453827;20031.899840500704;7144.249853765384;7353.558786472829;7362.852742945218;7431.256874312526;7860.0567931848545;4581.152486789954;4626.329182268552;4631.328457373662;4655.767211639404;4721.291806229093;2922.444735500248;2995.400919816002;3035.028790786971;3035.1501579557757;3035.605371301717;544.8147629805885;545.5635491606698;559.2282649943133;571.5027925704663;581.4795757796749;632.6899819088613;654.1496055128314;690.2510775808204;719.4136778525485;723.6526467295728;8709.564521773886;8975.326850486239;9070.637174512945;9149.313801464918;9180.816383672423;591.8668299632549;635.3202073781102;646.8997305417668;684.5687217053224;686.7836631461174;4255.723377980483;4387.890302742457;4420.809202460139;4462.955370446254;4593.54064593538;90112.5494372524;90420.09579904248;90535.54732226297;91084.54457727668;94282.52858735662;49878.25182622264;70834.9374759379;72109;81208.59395703101;83047.99999999879;70483.29516704768;71463.28536714567;71616.64191679009;71638;72823.63588182026;8265.586720664063;8812.206901378906;8836.513991730517;8925.107489251022;8990.5921692912;48925.5107448921;49391.01217975548;50142.749286254795;50504.24243636422;51548.226776599135;39065.82802515929;39313.41029884497;62143.6892815533;64190;66173.66913165404;11472.139589530652;11494.367809770209;11589.6523104307;11684.766304673689;11769.52921883115;11179.217454778087;11297.661070167907;11662.183647144957;11759.235649682743;11838.171328006956;12145.574904878287;12221.083418743452;12313;12320.646446889274;12457.314847683101;11097.667069987914;11169.609063682732;11403.372814495282;11415.37215453158;11471.655850324503;10763.838542422027;10877;11624.6512604622;11745;12135.08986825974;9520.143187113194;9715.222782177267;9907.603695852085;10095.192384609361;10337.224708147069;10102.848457273;10542.220901141969;10552.314099583502;10623.89376106229;10676.679699609023 05:45:24 INFO - PROCESS | 32151 | __end_tp_report 05:45:24 INFO - PROCESS | 32151 | __start_cc_report 05:45:24 INFO - PROCESS | 32151 | _x_x_mozilla_cycle_collect,322 05:45:24 INFO - PROCESS | 32151 | __end_cc_report 05:45:24 INFO - PROCESS | 32151 | __startTimestamp1487252724552__endTimestamp 05:45:24 INFO - PROCESS | 32151 | 05:45:24 INFO - PROCESS | 32151 | ------- Summary: start ------- 05:45:24 INFO - PROCESS | 32151 | Number of tests: 6 05:45:24 INFO - PROCESS | 32151 | 05:45:24 INFO - PROCESS | 32151 | [#0] dojo.html Cycles:165 Average:5589.61 Median:5818.39 stddev:628.67 (10.8%) stddev-sans-first:601.56 05:45:24 INFO - PROCESS | 32151 | Values: 3181.9 3196.2 3212.8 3214.7 3217.1 5497.6 5521.6 5541.4 5554.6 5563.7 5648.8 5675.8 5679.5 5685.2 5688.1 5124.6 5149.6 5184.8 5209.0 5229.9 5166.3 5211.4 5217.0 5221.3 5227.0 5038.1 5067.6 5113.6 5227.5 5241.7 5092.8 5148.5 5188.6 5192.9 5249.8 5113.5 5161.6 5164.8 5169.4 5171.7 5390.4 5629.4 5649.8 5693.1 5708.6 5822.6 5922.0 5939.8 6001.0 6044.1 5970.9 6034.9 6038.7 6041.9 6046.7 5621.5 5621.5 5622.6 5627.9 5643.1 6105.3 6129.2 6152.4 6205.9 6209.3 5937.7 5962.4 5963.1 5967.0 5974.9 5825.7 5899.1 6063.2 6069.3 6070.5 5865.3 5895.9 5930.0 5931.3 5976.5 5926.2 5933.8 5934.1 5938.2 5953.1 4525.8 4599.4 4623.6 4635.4 4646.1 4074.8 4127.0 4128.5 4177.7 4201.4 5764.5 5801.3 5801.7 5803.3 5818.4 6033.2 6105.8 6106.0 6107.9 6129.3 5540.6 5590.7 5637.4 5688.3 5724.0 5144.2 5147.4 5169.6 5177.1 5217.6 6224.1 6243.3 6254.2 6255.7 6265.2 5839.2 5943.0 5954.1 6027.8 6052.4 6217.6 6234.4 6253.7 6261.1 6272.3 5875.1 5933.1 5940.6 5940.9 5972.0 5837.8 5888.4 5954.8 6017.2 6033.8 5874.9 5877.1 5884.9 5918.0 5930.3 5854.9 5859.8 5861.9 5884.3 5899.3 5621.1 5736.9 5754.5 5839.0 5857.4 5820.9 5894.5 5931.4 5961.6 5966.7 5749.8 5770.3 5777.9 5782.9 5784.0 05:45:24 INFO - PROCESS | 32151 | 05:45:24 INFO - PROCESS | 32151 | [#1] ext.html Cycles:180 Average:52825.92 Median:41543.50 stddev:96087.72 (231.3%) stddev-sans-first:96277.33 05:45:24 INFO - PROCESS | 32151 | Values: 621.2 647.8 649.8 653.1 656.2 38509.0 42017.6 42083.2 42120.8 42142.0 42446.0 42812.6 43077.0 43091.4 43098.4 8843.6 8983.0 8983.8 8993.6 8995.9 8824.9 8863.3 8867.6 8883.0 8885.5 8736.8 8776.9 8797.3 8801.3 8806.3 8917.4 8940.1 8941.5 8953.1 8953.1 8831.2 8872.9 8881.3 8883.8 8901.9 40407.4 40848.2 40866.4 40876.8 40880.6 3177.0 3212.0 3241.8 3744.9 4022.1 31982.7 32073.2 32200.5 32497.2 33032.7 4353.7 4418.1 4456.0 4507.4 4542.0 332631.0 336359.0 338512.0 338520.0 338758.0 55555.2 55951.7 56246.4 56350.7 56364.7 57667.0 57943.4 57966.7 58034.0 58047.4 15230.8 15463.3 15524.5 15552.0 15555.9 10698.4 10770.7 10787.9 10812.0 10829.7 15191.5 15732.8 15747.4 15798.0 16224.0 5796.7 5799.4 5809.6 5895.9 5978.3 998.7 1099.0 1105.6 1106.0 1136.2 31236.0 31274.8 31436.5 31614.7 32118.2 1078.6 1081.3 1086.8 1092.3 1107.3 16151.5 16731.4 16804.2 16863.2 16886.2 241347.0 243134.0 243440.0 246342.0 246680.0 57382.7 57715.4 57719.4 57735.1 57797.7 1333.6 1363.9 1366.5 1379.8 1393.0 30119.8 31654.0 32485.2 33984.5 34084.7 55930.2 56463.0 56867.7 56880.0 56883.4 468661.0 473257.0 474773.0 474795.0 474835.0 42961.8 43477.0 43508.6 43732.6 43963.3 46736.0 47253.0 47310.5 48338.3 48581.0 39890.2 39973.8 40894.8 41692.0 42273.8 40217.6 40389.2 41395.0 41781.6 42150.6 36804.0 37217.6 37443.4 37528.0 37592.4 35800.3 37218.6 37350.6 37513.0 37679.4 28664.3 28668.4 28751.6 28952.9 28956.4 05:45:24 INFO - PROCESS | 32151 | 05:45:24 INFO - PROCESS | 32151 | [#2] jquery.html Cycles:180 Average:27299.82 Median:23321.27 stddev:71555.45 (306.8%) stddev-sans-first:71727.71 05:45:24 INFO - PROCESS | 32151 | Values: 413.7 422.1 423.2 425.4 440.9 18145.2 19026.3 19579.1 19628.0 19751.2 14300.6 14316.7 19688.5 19729.0 19901.5 5773.3 5796.5 5869.6 5886.2 5890.8 5668.5 5880.5 5893.9 5899.0 5936.1 5635.7 5782.5 5814.2 5822.2 5872.8 5803.0 5834.5 5869.3 5875.4 5920.7 5169.6 5268.6 5278.9 5292.9 5338.5 23171.8 23186.5 23456.0 23609.0 23626.8 2377.8 2530.5 3091.8 3212.2 3276.6 14541.7 14568.4 14745.9 14810.8 15072.5 1857.8 1859.3 1875.4 1922.3 1941.0 78644.6 78792.2 79258.0 80267.6 80497.6 10739.0 10748.6 11066.2 11177.7 11313.9 16005.7 16017.7 16028.8 16084.0 16125.9 7783.8 7896.2 7962.5 8001.7 8233.5 7371.4 7419.4 7560.0 7710.4 7710.8 6813.9 6814.3 6858.7 7004.0 7032.2 1987.5 2033.4 2033.9 2051.7 2081.1 975.8 1027.7 1048.6 1074.2 1086.1 19823.7 19866.7 20060.8 20261.7 20651.6 1057.6 1070.1 1106.1 1109.0 1126.4 10948.0 11646.4 11654.7 11679.4 11896.9 427889.0 428870.0 430080.0 440046.0 444320.0 76964.2 78895.2 83501.0 84115.6 84350.0 1017.8 1029.5 1037.2 1040.7 1048.3 17387.2 17713.2 17766.2 17780.2 18182.0 39953.8 40426.0 40768.8 40950.4 41956.4 53151.5 53978.5 54133.2 54156.0 54234.0 9015.3 9041.0 9077.4 9082.5 9184.0 13221.3 13741.0 14085.1 14099.2 14105.9 11384.8 11790.9 11830.5 12162.5 12423.6 11478.8 11900.0 11925.3 11936.6 12030.2 11572.0 11620.8 12010.2 12025.8 12108.8 8708.3 8920.9 9039.8 9069.7 9127.3 12083.2 12095.4 12243.3 12248.8 12537.7 05:45:24 INFO - PROCESS | 32151 | 05:45:24 INFO - PROCESS | 32151 | [#3] mootools.html Cycles:180 Average:5483.48 Median:5006.75 stddev:2991.68 (59.8%) stddev-sans-first:2984.96 05:45:24 INFO - PROCESS | 32151 | Values: 1482.2 1495.1 1631.0 1732.2 1781.2 7325.9 7538.5 8035.2 8517.3 8535.3 7950.0 8223.4 8225.8 8426.3 8440.8 2367.9 2391.2 2392.1 2396.4 2401.3 2403.4 2453.8 2468.7 2469.5 2471.8 2348.3 2379.2 2383.9 2390.5 2396.9 2321.3 2324.5 2346.1 2351.0 2372.7 2340.9 2358.9 2383.0 2386.0 2393.1 8414.1 8489.0 8489.6 8493.1 8534.6 4962.8 5109.8 5117.2 5118.9 5125.8 3304.8 3332.7 3388.4 3412.2 3445.9 1053.9 1079.4 1081.0 1110.0 1119.0 11246.7 11250.3 11293.6 11339.1 11358.3 4274.6 4482.8 4485.2 4523.5 4566.6 8801.8 8879.3 8886.1 8908.6 8962.3 4968.0 4970.7 4972.1 4976.7 4979.6 4668.1 4770.3 4817.9 4856.5 4884.5 3869.1 3959.7 3967.3 4035.3 4043.0 1243.6 1245.0 1247.6 1251.2 1255.5 781.5 898.9 921.9 936.5 938.2 5474.1 5480.8 5540.4 5583.4 5590.0 452.8 468.4 981.5 1040.8 1083.0 3836.7 4040.5 4064.1 4097.9 4152.0 9735.9 10238.4 10285.8 10325.3 10361.7 9957.2 10135.8 10166.3 10171.1 10200.5 7458.9 7565.9 7569.6 7583.7 7597.1 5607.3 5662.7 5711.7 5803.1 5892.2 9535.0 9539.7 9628.0 9643.4 9654.9 9465.4 9564.0 9609.3 9658.5 9674.6 6691.8 6831.4 7134.6 7241.7 7302.0 8187.6 8196.7 8203.1 8214.8 8223.1 6782.6 6823.1 6845.7 6888.2 7034.2 6750.5 6812.7 6844.8 6926.1 6957.7 6713.8 6789.8 6832.7 6834.7 6872.7 4844.0 5033.9 5098.8 5110.7 5145.9 4829.0 4927.5 5063.9 5094.6 5121.0 05:45:24 INFO - PROCESS | 32151 | 05:45:24 INFO - PROCESS | 32151 | [#4] prototype.html Cycles:180 Average:4875.44 Median:5565.22 stddev:1423.23 (25.6%) stddev-sans-first:1385.87 05:45:24 INFO - PROCESS | 32151 | Values: 337.5 339.4 354.4 357.8 358.3 5487.4 5588.2 5645.5 5658.8 5668.7 5557.4 5569.2 5572.9 5591.7 5638.2 4005.6 4350.8 4372.6 4388.5 4403.0 4244.9 4300.0 4327.8 4347.8 4348.3 4319.4 4322.2 4323.3 4324.3 4328.4 4325.5 4339.2 4340.5 4343.3 4344.4 3642.7 3703.6 3748.9 3760.5 3830.1 5343.7 5391.2 5394.8 5399.5 5413.2 4934.8 4937.7 4945.9 4963.4 4970.3 5644.5 5809.6 5827.2 5829.9 5834.2 4205.5 4209.0 4215.9 4224.7 4225.1 5817.4 6027.5 6041.2 6072.8 6092.0 4251.5 4281.8 4295.5 4295.9 4296.6 4330.2 4340.4 4347.6 4360.9 4365.5 4847.6 4954.3 4957.3 4968.0 4984.8 5852.9 5862.9 5866.8 5870.5 5959.6 1453.7 1469.0 1473.6 1476.2 1480.6 957.5 1011.3 1014.7 1014.8 1024.7 5542.6 5544.3 5561.0 5561.3 5576.7 5746.9 5792.6 5798.9 5826.9 5834.3 5367.5 5458.9 5464.9 5489.6 5530.3 3086.6 3095.7 3097.2 3104.6 3108.8 5821.3 5832.9 5964.7 5994.8 6036.7 5763.7 5818.4 5820.7 5820.7 5879.4 5941.4 5986.9 5988.0 6007.5 6028.2 5480.9 5671.1 5682.3 5727.2 5804.3 5692.3 5697.6 5697.7 5717.6 5734.3 5978.6 5979.9 6210.2 6227.7 6277.5 4261.6 4273.4 4274.8 4283.5 4330.2 5886.7 6044.6 6066.5 6098.4 6100.6 5819.5 5875.6 5877.0 5879.4 5887.1 5837.5 5849.3 5851.6 5852.7 5884.8 5698.5 5729.2 5750.5 5811.9 5821.8 5889.6 5926.5 5927.9 5936.6 5944.4 5637.5 5771.7 5777.2 5788.8 5810.2 05:45:24 INFO - PROCESS | 32151 | 05:45:24 INFO - PROCESS | 32151 | [#5] yui.html Cycles:180 Average:17504.28 Median:49634.63 stddev:23829.92 (48.0%) stddev-sans-first:23863.15 05:45:24 INFO - PROCESS | 32151 | Values: 647.3 647.7 672.1 739.9 765.8 14678.5 15250.3 15266.0 15321.6 15434.0 12908.9 12982.7 12983.7 13002.8 15290.9 812.6 814.2 832.8 839.9 842.4 823.4 829.8 833.2 833.5 833.5 877.4 879.3 879.6 881.0 881.3 870.3 872.2 873.3 874.3 877.3 644.2 645.1 645.5 647.1 648.5 14026.4 14312.4 14359.0 14380.0 15151.1 13460.5 14076.7 14221.0 14351.9 14396.7 10544.9 10570.3 10737.7 10871.5 10908.5 3809.8 3820.4 3854.4 3863.2 3928.7 65344.3 66331.0 66426.0 67115.7 67987.0 10530.4 10639.9 10723.1 10723.3 10848.8 19827.2 19890.3 19976.2 20031.3 20031.9 7144.2 7353.6 7362.9 7431.3 7860.1 4581.2 4626.3 4631.3 4655.8 4721.3 2922.4 2995.4 3035.0 3035.2 3035.6 544.8 545.6 559.2 571.5 581.5 632.7 654.1 690.3 719.4 723.7 8709.6 8975.3 9070.6 9149.3 9180.8 591.9 635.3 646.9 684.6 686.8 4255.7 4387.9 4420.8 4463.0 4593.5 90112.5 90420.1 90535.5 91084.5 94282.5 49878.3 70834.9 72109.0 81208.6 83048.0 70483.3 71463.3 71616.6 71638.0 72823.6 8265.6 8812.2 8836.5 8925.1 8990.6 48925.5 49391.0 50142.7 50504.2 51548.2 39065.8 39313.4 62143.7 64190.0 66173.7 11472.1 11494.4 11589.7 11684.8 11769.5 11179.2 11297.7 11662.2 11759.2 11838.2 12145.6 12221.1 12313.0 12320.6 12457.3 11097.7 11169.6 11403.4 11415.4 11471.7 10763.8 10877.0 11624.7 11745.0 12135.1 9520.1 9715.2 9907.6 10095.2 10337.2 10102.8 10542.2 10552.3 10623.9 10676.7 05:45:24 INFO - PROCESS | 32151 | -------- Summary: end -------- 05:45:24 INFO - PROCESS | 32151 | 05:45:25 INFO - TEST-INFO | 32151: exit 0 05:45:25 INFO - TEST-OK | dromaeo_css | took 1112986ms 05:45:25 INFO - TEST-START | kraken 05:45:25 INFO - operating with platform_type : linux_ 05:45:25 INFO - Initialising browser for kraken test... 05:45:25 INFO - TEST-INFO | started process 32506 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfvmi3T/profile http://localhost:33184/getInfo.html) 05:45:29 INFO - PROCESS | 32506 | __metrics Screen width/height:1600/1200 05:45:29 INFO - PROCESS | 32506 | colorDepth:24 05:45:29 INFO - PROCESS | 32506 | Browser inner width/height: 1024/697 05:45:29 INFO - PROCESS | 32506 | __metrics 05:45:30 ERROR - PROCESS | 32506 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 05:45:31 INFO - TEST-INFO | 32506: exit 0 05:45:31 INFO - Browser initialized. 05:45:31 INFO - Running cycle 1/1 for kraken test... 05:45:31 INFO - TEST-INFO | started process 32637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfvmi3T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:45:43 INFO - PROCESS | 32637 | RSS: Main: 147734528 05:45:43 INFO - PROCESS | 32637 | 05:45:45 INFO - PROCESS | 32637 | Cycle 1(1): loaded http://localhost:33184/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33184/tests/kraken/driver.html?testName=audio-beat-detection) 05:45:46 INFO - PROCESS | 32637 | RSS: Main: 153743360 05:45:46 INFO - PROCESS | 32637 | 05:45:48 INFO - PROCESS | 32637 | Cycle 1(1): loaded http://localhost:33184/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33184/tests/kraken/driver.html?testName=audio-dft) 05:45:49 INFO - PROCESS | 32637 | RSS: Main: 153317376 05:45:49 INFO - PROCESS | 32637 | 05:45:52 INFO - PROCESS | 32637 | Cycle 1(1): loaded http://localhost:33184/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33184/tests/kraken/driver.html?testName=audio-fft) 05:45:53 INFO - PROCESS | 32637 | RSS: Main: 152842240 05:45:53 INFO - PROCESS | 32637 | 05:45:55 INFO - PROCESS | 32637 | Cycle 1(1): loaded http://localhost:33184/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33184/tests/kraken/driver.html?testName=audio-oscillator) 05:45:55 INFO - PROCESS | 32637 | RSS: Main: 152076288 05:45:55 INFO - PROCESS | 32637 | 05:45:57 INFO - PROCESS | 32637 | Cycle 1(1): loaded http://localhost:33184/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33184/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:45:58 INFO - PROCESS | 32637 | RSS: Main: 152502272 05:45:58 INFO - PROCESS | 32637 | 05:46:01 INFO - PROCESS | 32637 | Cycle 1(1): loaded http://localhost:33184/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33184/tests/kraken/driver.html?testName=imaging-darkroom) 05:46:02 INFO - PROCESS | 32637 | RSS: Main: 155906048 05:46:02 INFO - PROCESS | 32637 | 05:46:05 INFO - PROCESS | 32637 | Cycle 1(1): loaded http://localhost:33184/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33184/tests/kraken/driver.html?testName=imaging-desaturate) 05:46:05 INFO - PROCESS | 32637 | RSS: Main: 155582464 05:46:05 INFO - PROCESS | 32637 | 05:46:08 INFO - PROCESS | 32637 | Cycle 1(1): loaded http://localhost:33184/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33184/tests/kraken/driver.html?testName=json-parse-financial) 05:46:09 INFO - PROCESS | 32637 | RSS: Main: 154820608 05:46:09 INFO - PROCESS | 32637 | 05:46:10 INFO - PROCESS | 32637 | Cycle 1(1): loaded http://localhost:33184/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33184/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:46:11 INFO - PROCESS | 32637 | RSS: Main: 154644480 05:46:11 INFO - PROCESS | 32637 | 05:46:13 INFO - PROCESS | 32637 | Cycle 1(1): loaded http://localhost:33184/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33184/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:46:13 INFO - PROCESS | 32637 | RSS: Main: 154992640 05:46:13 INFO - PROCESS | 32637 | 05:46:15 INFO - PROCESS | 32637 | Cycle 1(1): loaded http://localhost:33184/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33184/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:46:16 INFO - PROCESS | 32637 | RSS: Main: 154546176 05:46:16 INFO - PROCESS | 32637 | 05:46:18 INFO - PROCESS | 32637 | Cycle 1(1): loaded http://localhost:33184/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33184/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:46:19 INFO - PROCESS | 32637 | RSS: Main: 154456064 05:46:19 INFO - PROCESS | 32637 | 05:46:22 INFO - PROCESS | 32637 | Cycle 1(1): loaded http://localhost:33184/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33184/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:46:23 INFO - PROCESS | 32637 | RSS: Main: 155049984 05:46:23 INFO - PROCESS | 32637 | 05:46:24 INFO - PROCESS | 32637 | Cycle 1(1): loaded http://localhost:33184/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33184/tests/kraken/driver.html?testName=ai-astar) 05:46:24 INFO - PROCESS | 32637 | RSS: Main: 156221440 05:46:24 INFO - PROCESS | 32637 | 05:46:24 INFO - PROCESS | 32637 | __start_tp_report 05:46:24 INFO - PROCESS | 32637 | _x_x_mozilla_page_load 05:46:24 INFO - PROCESS | 32637 | _x_x_mozilla_page_load_details 05:46:24 INFO - PROCESS | 32637 | |i|pagename|runs| 05:46:24 INFO - PROCESS | 32637 | |0;ai-astar;102;115;113;114;117;113;109;112;111;111 05:46:24 INFO - PROCESS | 32637 | |1;audio-beat-detection;153;119;120;161;120;117;118;119;153;118 05:46:24 INFO - PROCESS | 32637 | |2;audio-dft;160;162;163;162;167;163;162;165;165;164 05:46:24 INFO - PROCESS | 32637 | |3;audio-fft;75;76;76;118;74;75;76;76;100;74 05:46:24 INFO - PROCESS | 32637 | |4;audio-oscillator;82;82;108;87;86;84;93;82;81;120 05:46:24 INFO - PROCESS | 32637 | |5;imaging-gaussian-blur;120;117;117;117;117;117;119;116;117;119 05:46:24 INFO - PROCESS | 32637 | |6;imaging-darkroom;147;149;147;146;151;149;147;150;147;154 05:46:24 INFO - PROCESS | 32637 | |7;imaging-desaturate;85;86;85;86;85;85;89;85;85;85 05:46:24 INFO - PROCESS | 32637 | |8;json-parse-financial;50;51;53;52;51;51;52;52;53;51 05:46:24 INFO - PROCESS | 32637 | |9;json-stringify-tinderbox;59;64;62;60;59;58;58;58;60;61 05:46:24 INFO - PROCESS | 32637 | |10;stanford-crypto-aes;76;76;76;74;76;87;81;75;74;75 05:46:24 INFO - PROCESS | 32637 | |11;stanford-crypto-ccm;128;121;125;128;136;127;126;125;172;136 05:46:24 INFO - PROCESS | 32637 | |12;stanford-crypto-pbkdf2;160;160;156;160;158;155;160;156;153;155 05:46:24 INFO - PROCESS | 32637 | |13;stanford-crypto-sha256-iterative;64;64;64;64;64;64;60;63;62;62 05:46:24 INFO - PROCESS | 32637 | __end_tp_report 05:46:24 INFO - PROCESS | 32637 | __start_cc_report 05:46:24 INFO - PROCESS | 32637 | _x_x_mozilla_cycle_collect,800 05:46:24 INFO - PROCESS | 32637 | __end_cc_report 05:46:24 INFO - PROCESS | 32637 | __startTimestamp1487252784927__endTimestamp 05:46:24 INFO - PROCESS | 32637 | 05:46:24 INFO - PROCESS | 32637 | ------- Summary: start ------- 05:46:24 INFO - PROCESS | 32637 | Number of tests: 14 05:46:24 INFO - PROCESS | 32637 | 05:46:24 INFO - PROCESS | 32637 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:4.08 (3.6%) stddev-sans-first:2.39 05:46:24 INFO - PROCESS | 32637 | Values: 102.0 115.0 113.0 114.0 117.0 113.0 109.0 112.0 111.0 111.0 05:46:24 INFO - PROCESS | 32637 | 05:46:24 INFO - PROCESS | 32637 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:120.00 stddev:18.00 (15.0%) stddev-sans-first:17.03 05:46:24 INFO - PROCESS | 32637 | Values: 153.0 119.0 120.0 161.0 120.0 117.0 118.0 119.0 153.0 118.0 05:46:24 INFO - PROCESS | 32637 | 05:46:24 INFO - PROCESS | 32637 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:2.00 (1.2%) stddev-sans-first:1.73 05:46:24 INFO - PROCESS | 32637 | Values: 160.0 162.0 163.0 162.0 167.0 163.0 162.0 165.0 165.0 164.0 05:46:24 INFO - PROCESS | 32637 | 05:46:24 INFO - PROCESS | 32637 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.50 stddev:14.87 (19.7%) stddev-sans-first:15.55 05:46:24 INFO - PROCESS | 32637 | Values: 75.0 76.0 76.0 118.0 74.0 75.0 76.0 76.0 100.0 74.0 05:46:24 INFO - PROCESS | 32637 | 05:46:24 INFO - PROCESS | 32637 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:83.00 stddev:13.18 (15.9%) stddev-sans-first:13.62 05:46:24 INFO - PROCESS | 32637 | Values: 82.0 82.0 108.0 87.0 86.0 84.0 93.0 82.0 81.0 120.0 05:46:24 INFO - PROCESS | 32637 | 05:46:24 INFO - PROCESS | 32637 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.00 stddev:1.26 (1.1%) stddev-sans-first:1.00 05:46:24 INFO - PROCESS | 32637 | Values: 120.0 117.0 117.0 117.0 117.0 117.0 119.0 116.0 117.0 119.0 05:46:24 INFO - PROCESS | 32637 | 05:46:24 INFO - PROCESS | 32637 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:2.45 (1.6%) stddev-sans-first:2.52 05:46:24 INFO - PROCESS | 32637 | Values: 147.0 149.0 147.0 146.0 151.0 149.0 147.0 150.0 147.0 154.0 05:46:24 INFO - PROCESS | 32637 | 05:46:24 INFO - PROCESS | 32637 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:85.00 stddev:1.26 (1.5%) stddev-sans-first:1.32 05:46:24 INFO - PROCESS | 32637 | Values: 85.0 86.0 85.0 86.0 85.0 85.0 89.0 85.0 85.0 85.0 05:46:24 INFO - PROCESS | 32637 | 05:46:24 INFO - PROCESS | 32637 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:0.97 (1.9%) stddev-sans-first:0.83 05:46:24 INFO - PROCESS | 32637 | Values: 50.0 51.0 53.0 52.0 51.0 51.0 52.0 52.0 53.0 51.0 05:46:24 INFO - PROCESS | 32637 | 05:46:24 INFO - PROCESS | 32637 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:1.97 (3.3%) stddev-sans-first:2.06 05:46:24 INFO - PROCESS | 32637 | Values: 59.0 64.0 62.0 60.0 59.0 58.0 58.0 58.0 60.0 61.0 05:46:24 INFO - PROCESS | 32637 | 05:46:24 INFO - PROCESS | 32637 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:76.00 stddev:4.03 (5.3%) stddev-sans-first:4.26 05:46:24 INFO - PROCESS | 32637 | Values: 76.0 76.0 76.0 74.0 76.0 87.0 81.0 75.0 74.0 75.0 05:46:24 INFO - PROCESS | 32637 | 05:46:24 INFO - PROCESS | 32637 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:128.00 stddev:14.69 (11.5%) stddev-sans-first:15.50 05:46:24 INFO - PROCESS | 32637 | Values: 128.0 121.0 125.0 128.0 136.0 127.0 126.0 125.0 172.0 136.0 05:46:24 INFO - PROCESS | 32637 | 05:46:24 INFO - PROCESS | 32637 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.30 Median:159.00 stddev:2.63 (1.7%) stddev-sans-first:2.60 05:46:24 INFO - PROCESS | 32637 | Values: 160.0 160.0 156.0 160.0 158.0 155.0 160.0 156.0 153.0 155.0 05:46:24 INFO - PROCESS | 32637 | 05:46:24 INFO - PROCESS | 32637 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:64.00 stddev:1.37 (2.1%) stddev-sans-first:1.41 05:46:24 INFO - PROCESS | 32637 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 60.0 63.0 62.0 62.0 05:46:24 INFO - PROCESS | 32637 | -------- Summary: end -------- 05:46:24 INFO - PROCESS | 32637 | 05:46:25 INFO - TEST-INFO | 32637: exit 0 05:46:25 INFO - TEST-OK | kraken | took 60658ms 05:46:25 INFO - SUITE-END | took 1173s 05:46:26 INFO - Completed test suite (00:19:33) 05:46:26 INFO - javascript benchmark 05:46:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7208.228271014192, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3181.9204519887, 3196.184972831929, 3212.7751057425976, 3214.6624604416534, 3217.1313745288758, 5497.5601951843855, 5521.558275337973, 5541.445855414457, 5554.638948468347, 5563.666180029196, 5648.802291919784, 5675.801346952858, 5679.488846003859, 5685.232493613361, 5688.061469857468, 5124.564412024983, 5149.562287205592, 5184.792608295683, 5209.0, 5229.86925326868, 5166.276721259027, 5211.3746350438005, 5216.973915130419, 5221.347331583552, 5226.973865130669, 5038.093143234235, 5067.594592432615, 5113.616478764089, 5227.503387178231, 5241.73791310433, 5092.796288148488, 5148.536631703146, 5188.610854185951, 5192.870178245536, 5249.816256431045, 5113.463086375951, 5161.638685292031, 5164.845054648366, 5169.353830771153, 5171.663841850268, 5390.434004429557, 5629.3526244482, 5649.830505084854, 5693.117566777156, 5708.600397972144, 5822.621529600562, 5922.0, 5939.762409503614, 6000.96999515004, 6044.093385992092, 5970.850728731773, 6034.939650603482, 6038.667873266969, 6041.939580604182, 6046.667433291167, 5621.4659607337235, 5621.494065534081, 5622.550195984352, 5627.8593035174445, 5643.097104463266, 6105.32841387447, 6129.205975626751, 6152.446279834747, 6205.875882482415, 6209.2548894133, 5937.70311484424, 5962.403759624003, 5963.075723262901, 5966.970165149233, 5974.910376344358, 5825.7378417971295, 5899.085641725539, 6063.242094738158, 6069.332373439007, 6070.544709146831, 5865.266841644794, 5895.852603684943, 5929.970350148222, 5931.288245410578, 5976.462118409364, 5926.2295901532525, 5933.762649494059, 5934.13954976526, 5938.2280303560265, 5953.077273022688, 4525.79633916468, 4599.379083823641, 4623.583877451046, 4635.420572428447, 4646.140464014168, 4074.8370065197655, 4127.0, 4128.525219599785, 4177.665786737054, 4201.390798334224, 5764.538836893123, 5801.274840644919, 5801.7389217485315, 5803.332616749043, 5818.389069147678, 6033.155358249848, 6105.755769769159, 6106.0, 6107.908381374283, 6129.264488261437, 5540.639858409271, 5590.748416321194, 5637.408072152447, 5688.288963879515, 5723.998300297431, 5144.2283657450935, 5147.408048074444, 5169.586433085344, 5177.068127737043, 5217.608679349064, 6224.066390041439, 6243.313235544178, 6254.186955695731, 6255.6872156392, 6265.185525881606, 5839.153322768259, 5942.970285148546, 5954.136650185786, 6027.758889644365, 6052.425019623129, 6217.595856269328, 6234.438900498977, 6253.7185826637, 6261.092141639528, 6272.310045895039, 5875.14810352488, 5933.110033495011, 5940.61386009908, 5940.910886336795, 5971.970140149271, 5837.824865254049, 5888.381719919346, 5954.821355359346, 6017.217761690952, 6033.78881739137, 5874.882502350015, 5877.147813567094, 5884.882302354014, 5917.993941030121, 5930.34766175729, 5854.853628659318, 5859.765609375577, 5861.912071318849, 5884.293884733688, 5899.321578018411, 5621.128725047624, 5736.913946290892, 5754.4533269339345, 5839.0, 5857.414258574279, 5820.854478638068, 5894.469497745224, 5931.4068593142065, 5961.582689211714, 5966.671833049224, 5749.770009199585, 5770.278715160605, 5777.94222057774, 5782.913256301074, 5783.971080144573], "value": 5547.032600318154, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.2420846567188, 647.7603286783891, 649.8018104478132, 653.0856800479328, 656.1896058367918, 38509.0, 42017.57982420175, 42083.15833683324, 42120.78939605301, 42142.0, 42446.0, 42812.571874281246, 43077.0, 43091.35362969558, 43098.35352469708, 8843.602037908293, 8982.955085224565, 8983.775405614846, 8993.595288212045, 8995.865062024075, 8824.911750882506, 8863.290936725047, 8867.600957956874, 8883.0, 8885.46687198767, 8736.825263494726, 8776.912230877706, 8797.296216302713, 8801.295896328278, 8806.251468625143, 8917.420367676114, 8940.061293564147, 8941.463512189257, 8953.149450802164, 8953.149450802195, 8831.205191532728, 8872.911270887273, 8881.289496840238, 8883.822323553493, 8901.866472002925, 40407.39388909169, 40848.183036339404, 40866.38700419496, 40876.79561602203, 40880.591194087974, 3177.0310055433315, 3211.951820722691, 3241.8054916705073, 3744.8876533704033, 4022.0749227677798, 31982.6801731982, 32073.198170045704, 32200.516992245135, 32497.187570310696, 33032.6696733032, 4353.673474489395, 4418.094290670405, 4456.013324158004, 4507.4365704286965, 4541.954580454186, 332631.0, 336359.0, 338512.0, 338519.99999999756, 338758.0, 55555.166672499945, 55951.720241398536, 56246.43753562494, 56350.718246408505, 56364.71817640885, 57667.0, 57943.4205657938, 57966.710166448895, 58034.0, 58047.419525805046, 15230.847691523164, 15463.304151313218, 15524.534263972098, 15552.0, 15555.922220388826, 10698.41158736277, 10770.676879693621, 10787.892121078845, 10812.0, 10829.67510974672, 15191.468298609716, 15732.842671573138, 15747.44883929057, 15798.0, 16224.0, 5796.739146738407, 5799.3620701722775, 5809.593328467051, 5895.941040589625, 5978.342382337939, 998.6953979036464, 1099.0273607857105, 1105.5958932156277, 1105.9603972266045, 1136.2216881436243, 31236.0, 31274.843625781727, 31436.52845207324, 31614.683853161176, 32118.197045073593, 1078.5524007536942, 1081.324172392255, 1086.8369744538381, 1092.2900114925203, 1107.2858006585707, 16151.528538172402, 16731.414400495923, 16804.243809028623, 16863.241154148094, 16886.15569221534, 241347.0, 243134.0, 243440.0, 246342.0, 246680.0, 57382.7130864343, 57715.422845771005, 57719.42280577224, 57735.133972990436, 57797.71101144468, 1333.5865881576742, 1363.8840698540537, 1366.5080570994435, 1379.8068270442145, 1392.9651758706113, 30119.849400752857, 31654.0, 32485.18787030343, 33984.490232647026, 34084.659153408145, 55930.161047583504, 56463.0, 56867.715661421425, 56880.0, 56883.43116568781, 468661.0, 473257.0, 474773.0, 474795.0, 474835.0, 42961.78519107385, 43477.0, 43508.56491435045, 43732.56267437285, 43963.34054989242, 46736.0, 47253.0, 47310.52689473061, 48338.274925876845, 48581.0, 39890.202195956495, 39973.80013099916, 40894.79552602218, 41692.0, 42273.78863105665, 40217.59782402139, 40389.1922161561, 41395.0, 41781.58218417777, 42150.57849421589, 36804.0, 37217.627823721414, 37443.43834842534, 37528.0, 37592.43611345887, 35800.28399431945, 37218.62781372152, 37350.6264937358, 37513.0, 37679.43480847844, 28664.283392915346, 28668.42663146767, 28751.568726469537, 28952.855235723688, 28956.42087158287], "value": 19579.458564895525, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.714536969491, 422.1367303863599, 423.24873349804074, 425.43417255050775, 440.8633323669663, 18145.183466743994, 19026.334078307245, 19579.118939647713, 19628.0, 19751.20995160192, 14300.61640587957, 14316.71366572668, 19688.507787305323, 19729.0, 19901.502462438446, 5773.278340207464, 5796.478316951474, 5869.618474799146, 5886.20536227608, 5890.823275301748, 5668.461496157858, 5880.529557635379, 5893.8821223575505, 5898.970505147489, 5936.079907614327, 5635.690037047961, 5782.508486778629, 5814.156947242668, 5822.243108395903, 5872.765089396419, 5803.040449370809, 5834.504067154276, 5869.295684517842, 5875.441833025877, 5920.733566989453, 5169.56058735008, 5268.578513718893, 5278.9208161877605, 5292.92060619091, 5338.546223571001, 23171.76828231713, 23186.53626927469, 23456.0, 23609.0, 23626.7637323628, 2377.7741114594087, 2530.4686015936677, 3091.845407729627, 3212.229065024401, 3276.574045374086, 14541.70916581673, 14568.417263309455, 14745.852541474555, 14810.778383242492, 15072.54782356531, 1857.7863545692148, 1859.33064096925, 1875.3530032139026, 1922.327185485083, 1941.0294852573713, 78644.60677696575, 78792.21207787906, 79258.0, 80267.59866200632, 80497.59751201324, 10739.0, 10748.570057197781, 11066.225364224589, 11177.72055698614, 11313.886861131283, 16005.67988640244, 16017.67964640724, 16028.75956860648, 16084.0, 16125.919370403073, 7783.766487005399, 7896.210378962058, 7962.482438641586, 8001.679932802623, 8233.547154906419, 7371.410287177013, 7419.369353605004, 7559.962200188964, 7710.421718371144, 7710.7686769397005, 6813.897791533131, 6814.291509592658, 6858.725650974005, 7004.0, 7032.191298000693, 1987.5490891649176, 2033.3696554068285, 2033.9084741186682, 2051.7332746743127, 2081.063521415369, 975.8438649816137, 1027.671145233533, 1048.5962904281907, 1074.237291523012, 1086.0768346905068, 19823.702644460343, 19866.70199947002, 20060.799392006185, 20261.697459469575, 20651.58696826085, 1057.5611121384693, 1070.1385384765338, 1106.1372129738816, 1108.95564177432, 1126.3973774030853, 10948.0, 11646.41767911601, 11654.708632284091, 11679.416029198506, 11896.88103118975, 427889.0, 428870.0, 430080.0, 440046.0, 444320.0, 76964.23035769683, 78895.21736743026, 83501.0, 84115.5794221025, 84350.0, 1017.8269694151863, 1029.45953374479, 1037.232447988483, 1040.7138037039724, 1048.250500891866, 17387.217575209397, 17713.20290586901, 17766.20052097633, 17780.199891005195, 18182.0, 39953.80023099866, 40426.0, 40768.79615601903, 40950.385744213265, 41956.3706544396, 53151.468485316196, 53978.46021539735, 54133.18800218079, 54156.0, 54234.0, 9015.278777697637, 9040.954795225982, 9077.364584479023, 9082.500462474627, 9183.954080229556, 13221.272829994057, 13741.0, 14085.08446950945, 14099.224542650252, 14105.929470352583, 11384.772304554028, 11790.882091178979, 11830.526778928746, 12162.513499460276, 12423.633400325776, 11478.770424591628, 11900.0, 11925.284482931052, 11936.641900742992, 12030.15788894804, 11572.0, 11620.767584648429, 12010.219335743148, 12025.819612705991, 12108.818367724667, 8708.346873984603, 8920.86618700733, 9039.845969382974, 9069.682561110329, 9127.315451341043, 12083.214591051554, 12095.395230238277, 12243.32661703615, 12248.816267755812, 12537.749245015231], "value": 9527.97315729722, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1482.1699848085073, 1495.0730547060823, 1631.0, 1732.1685590916368, 1781.225167052333, 7325.9267407325915, 7538.5099968502145, 8035.156308587594, 8517.31861451084, 8535.317174626023, 7949.960250198756, 8223.424360294766, 8225.753227403173, 8426.325893928486, 8440.788980275496, 2367.9289621311345, 2391.1630929174826, 2392.091005417939, 2396.376941995085, 2401.3036219496325, 2403.387136280246, 2453.766892145243, 2468.691413573303, 2469.506098780242, 2471.8393304435244, 2348.3307257431634, 2379.2267513058327, 2383.8688872112025, 2390.497995420964, 2396.892139853711, 2321.3152120124605, 2324.476992676651, 2346.0615753698485, 2350.976490235093, 2372.6559648850907, 2340.9180678676166, 2358.8820558972157, 2383.0229605861514, 2386.045581767307, 2393.0786647140803, 8414.116517765608, 8489.0, 8489.575521223915, 8493.108223636553, 8534.573271336409, 4962.801487940478, 5109.770060347293, 5117.232415137722, 5118.872028199287, 5125.794968201268, 3304.80171189727, 3332.7333813294877, 3388.40702876998, 3412.1640198151363, 3445.879394221215, 1053.899879511445, 1079.4171147580298, 1081.0432767001182, 1109.972250693731, 1118.9608363707312, 11246.718832029183, 11250.324980501196, 11293.60472383471, 11339.092872570174, 11358.318500889973, 4274.615284624399, 4482.820687172477, 4485.237509623372, 4523.5024147343765, 4566.611837993742, 8801.779955501164, 8879.28965682744, 8886.11138886119, 8908.643654253758, 8962.32782541299, 4967.950320496749, 4970.676906001098, 4972.129877271463, 4976.676516026447, 4979.551840334388, 4668.136394766979, 4770.284457331428, 4817.855464336076, 4856.538628830255, 4884.511548845087, 3869.071422858494, 3959.6634286086005, 3967.325554655658, 4035.3139966205817, 4042.959570404317, 1243.589615426907, 1244.9875501244871, 1247.600767754328, 1251.249250449723, 1255.54172726954, 781.5193655901579, 898.9146031127033, 921.8755468011867, 936.5083331251147, 938.1697197979701, 5474.124140137559, 5480.780768769284, 5540.445955404427, 5583.3858275589655, 5590.049691552445, 452.7985046654273, 468.377058512178, 981.5386768218925, 1040.8290672992882, 1083.0469187115289, 3836.712246581518, 4040.5151381834366, 4064.1262128641893, 4097.91804163921, 4152.007036622438, 9735.902640973642, 10238.436885971343, 10285.794284114276, 10325.32885362449, 10361.740956475998, 9957.203423726229, 10135.847962280572, 10166.288359814742, 10171.084602385821, 10200.489975501196, 7458.85082298351, 7565.924340756632, 7569.621518923922, 7583.696652133853, 7597.050368703912, 5607.271054762855, 5662.745176466987, 5711.685857277889, 5803.100519419328, 5892.204552385373, 9535.0, 9539.666111686058, 9627.989061148759, 9643.373180743229, 9654.903450965401, 9465.384749991228, 9564.0, 9609.279304052085, 9658.517074146404, 9674.56464459087, 6691.799246022627, 6831.385175334244, 7134.571925684476, 7241.674124664508, 7302.0, 8187.590620469072, 8196.713115040944, 8203.097659257357, 8214.753557393287, 8223.05434874997, 6782.626955517297, 6823.112995310578, 6845.726170953305, 6888.242293347627, 7034.226235114031, 6750.5274630775375, 6812.693428795816, 6844.760433384808, 6926.06498122747, 6957.721691132298, 6713.832154196184, 6789.762358317435, 6832.726690932506, 6834.726610935507, 6872.725090996304, 4843.975780121077, 5033.949660503348, 5098.847034588968, 5110.744462776921, 5145.9228111579105, 4829.0, 4927.507249275044, 5063.87340316495, 5094.5669618082875, 5120.974395128001], "value": 4449.515208936484, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.45164108323974, 339.41450997030125, 354.40283122937853, 357.76208821133946, 358.29058464240785, 5487.423820498845, 5588.189712491686, 5645.463680950314, 5658.773649054043, 5668.716564171796, 5557.444255574441, 5569.164625306206, 5572.944270557293, 5591.720413979295, 5638.238837756901, 4005.638083051762, 4350.825966961325, 4372.606465418112, 4388.451443569554, 4402.9873129180305, 4244.893877653068, 4299.957000429987, 4327.783610819462, 4347.804348804311, 4348.326009468537, 4319.416878721364, 4322.243607368714, 4323.265044942352, 4324.264874971247, 4328.394024836525, 4325.502567204764, 4339.2406328892475, 4340.457442819647, 4343.305071188594, 4344.413504176927, 3642.6721595056574, 3703.611120832301, 3748.887533374003, 3760.52993375828, 3830.1382189007527, 5343.706096164709, 5391.16436952273, 5394.757235924393, 5399.460053994609, 5413.242146099549, 4934.777934992934, 4937.7410908800375, 4945.901081978376, 4963.4292056413615, 4970.2793095001025, 5644.548436125141, 5809.622374545641, 5827.184194212814, 5829.88340233193, 5834.241548598655, 4205.537390887, 4208.968802643372, 4215.873523794291, 4224.704270701052, 4225.112726327475, 5817.360090390053, 6027.457528822427, 6041.184440100574, 6072.817815465543, 6091.969540152271, 4251.489821221473, 4281.828726850953, 4295.487140023059, 4295.871123866289, 4296.6347860432215, 4330.17726631939, 4340.417451616283, 4347.6304514116655, 4360.912781744348, 4365.519792822787, 4847.636427267969, 4954.331165292711, 4957.256411538298, 4968.0, 4984.77568509418, 5852.853678658068, 5862.8534286642325, 5866.794662186803, 5870.53035757147, 5959.64593985382, 1453.738327101132, 1468.9632759180893, 1473.5505670770303, 1476.1585896039155, 1480.6076389756722, 957.5068839547639, 1011.2516737614112, 1014.6753039027587, 1014.7716763728102, 1024.6874703215442, 5542.63972841764, 5544.3346798384455, 5560.972195138998, 5561.277033985637, 5576.749046292926, 5746.913796293059, 5792.594518383673, 5798.9130163047585, 5826.912596311059, 5834.3080506652595, 5367.484297784957, 5458.935507575985, 5464.9453505464435, 5489.627593101724, 5530.308711411074, 3086.583311252997, 3095.7091752103283, 3097.1947293703797, 3104.59640246771, 3108.7875728465915, 5821.301443826768, 5832.88334233313, 5964.671943043174, 5994.820155395258, 6036.698165091816, 5763.7406316715005, 5818.359980402152, 5820.679862607597, 5820.738066787005, 5879.441453061952, 5941.376155503696, 5986.880262394728, 5988.0, 6007.459328660441, 6028.156058151862, 5480.945190548044, 5671.092625179951, 5682.289713785777, 5727.226824378822, 5804.332501762351, 5692.260006199168, 5697.635481275224, 5697.658140511582, 5717.628354156966, 5734.340550836707, 5978.551608629283, 5979.910301345396, 6210.161628180138, 6227.688615569294, 6277.529185311211, 4261.595148460891, 4273.401723758614, 4274.786260687016, 4283.528811830758, 4330.220560299176, 5886.735096920564, 6044.607100538451, 6066.514678825772, 6098.420650038239, 6100.627358844225, 5819.505342045804, 5875.559333049953, 5877.001819381431, 5879.353271140257, 5887.146363777314, 5837.532997360286, 5849.327327357409, 5851.561132914963, 5852.736626851717, 5884.7940322088525, 5698.54411647059, 5729.169270455677, 5750.48245657876, 5811.912821307768, 5821.76712931495, 5889.5582831286965, 5926.525877929669, 5927.940720592739, 5936.554758393224, 5944.405559444021, 5637.5489960802215, 5771.68255745938, 5777.191193232867, 5788.797392091256, 5810.1575271586225], "value": 4422.406659537687, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.3009150117873, 647.7441410642796, 672.143017652493, 739.9445041621876, 765.7587859824155, 14678.486252981134, 15250.313735881884, 15266.007709498888, 15321.616959576017, 15434.0, 12908.93545532271, 12982.675433114176, 12983.675408114801, 13002.804957925615, 15290.923545382286, 812.6221307092186, 814.2142832166958, 832.8334333133367, 839.9286060684849, 842.4439869686008, 823.3783493462457, 829.7801082713056, 833.1918039501704, 833.4874052457756, 833.4957350802767, 877.4340550345023, 879.2570278114982, 879.5646155153177, 880.9911900880974, 881.3301890563187, 870.316801310971, 872.2106493623281, 873.253368370044, 874.2874557235896, 877.2981614708208, 644.1561554363799, 645.1451826330132, 645.5416654175541, 647.0552992630764, 648.4909346163239, 14026.43894244229, 14312.42750289987, 14359.0, 14380.0, 15151.090934543852, 13460.528881489101, 14076.718465630733, 14221.004529682927, 14351.928240358731, 14396.712065758626, 10544.894551054467, 10570.312929659547, 10737.731556711067, 10871.45642717869, 10908.50911708975, 3809.771413715186, 3820.4269359596005, 3854.3640299350573, 3863.2273545291055, 3928.7446315989655, 65344.34655653478, 66331.0, 66426.0, 67115.66442167757, 67987.0, 10530.368177909197, 10639.946800265949, 10723.14214862809, 10723.30298530593, 10848.78302433947, 19827.206911723657, 19890.303839365843, 19976.20095196176, 20031.29890453827, 20031.899840500704, 7144.249853765384, 7353.558786472829, 7362.852742945218, 7431.256874312526, 7860.0567931848545, 4581.152486789954, 4626.329182268552, 4631.328457373662, 4655.767211639404, 4721.291806229093, 2922.444735500248, 2995.400919816002, 3035.028790786971, 3035.1501579557757, 3035.605371301717, 544.8147629805885, 545.5635491606698, 559.2282649943133, 571.5027925704663, 581.4795757796749, 632.6899819088613, 654.1496055128314, 690.2510775808204, 719.4136778525485, 723.6526467295728, 8709.564521773886, 8975.326850486239, 9070.637174512945, 9149.313801464918, 9180.816383672423, 591.8668299632549, 635.3202073781102, 646.8997305417668, 684.5687217053224, 686.7836631461174, 4255.723377980483, 4387.890302742457, 4420.809202460139, 4462.955370446254, 4593.54064593538, 90112.5494372524, 90420.09579904248, 90535.54732226297, 91084.54457727668, 94282.52858735662, 49878.25182622264, 70834.9374759379, 72109.0, 81208.59395703101, 83047.99999999879, 70483.29516704768, 71463.28536714567, 71616.64191679009, 71638.0, 72823.63588182026, 8265.586720664063, 8812.206901378906, 8836.513991730517, 8925.107489251022, 8990.5921692912, 48925.5107448921, 49391.01217975548, 50142.749286254795, 50504.24243636422, 51548.226776599135, 39065.82802515929, 39313.41029884497, 62143.6892815533, 64190.0, 66173.66913165404, 11472.139589530652, 11494.367809770209, 11589.6523104307, 11684.766304673689, 11769.52921883115, 11179.217454778087, 11297.661070167907, 11662.183647144957, 11759.235649682743, 11838.171328006956, 12145.574904878287, 12221.083418743452, 12313.0, 12320.646446889274, 12457.314847683101, 11097.667069987914, 11169.609063682732, 11403.372814495282, 11415.37215453158, 11471.655850324503, 10763.838542422027, 10877.0, 11624.6512604622, 11745.0, 12135.08986825974, 9520.143187113194, 9715.222782177267, 9907.603695852085, 10095.192384609361, 10337.224708147069, 10102.848457273, 10542.220901141969, 10552.314099583502, 10623.89376106229, 10676.679699609023], "value": 6888.021487113967, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1470.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 115.0, 113.0, 114.0, 117.0, 113.0, 109.0, 112.0, 111.0, 111.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 119.0, 120.0, 161.0, 120.0, 117.0, 118.0, 119.0, 153.0, 118.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 163.0, 162.0, 167.0, 163.0, 162.0, 165.0, 165.0, 164.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 118.0, 74.0, 75.0, 76.0, 76.0, 100.0, 74.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 108.0, 87.0, 86.0, 84.0, 93.0, 82.0, 81.0, 120.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 116.0, 117.0, 119.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 146.0, 151.0, 149.0, 147.0, 150.0, 147.0, 154.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 86.0, 85.0, 85.0, 89.0, 85.0, 85.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 53.0, 52.0, 51.0, 51.0, 52.0, 52.0, 53.0, 51.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 64.0, 62.0, 60.0, 59.0, 58.0, 58.0, 58.0, 60.0, 61.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 74.0, 76.0, 87.0, 81.0, 75.0, 74.0, 75.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 121.0, 125.0, 128.0, 136.0, 127.0, 126.0, 125.0, 172.0, 136.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 156.0, 160.0, 158.0, 155.0, 160.0, 156.0, 153.0, 155.0], "value": 157.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 60.0, 63.0, 62.0, 62.0], "value": 63.1, "unit": "score"}]}]} 05:46:26 INFO - Return code: 0 05:46:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:46:26 ERROR - # TBPL SUCCESS # 05:46:26 INFO - Running post-action listener: _resource_record_post_action 05:46:26 INFO - [mozharness: 2017-02-16 13:46:26.241931Z] Finished run-tests step (success) 05:46:26 INFO - Running post-run listener: _resource_record_post_run 05:46:26 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 638976; Write bytes: 321462272; Read time: 236; Write time: 175472 05:46:26 INFO - TinderboxPrint: CPU usage
13.2% 05:46:26 INFO - TinderboxPrint: I/O read bytes / time
638,976 / 236 05:46:26 INFO - TinderboxPrint: I/O write bytes / time
321,462,272 / 175,472 05:46:26 INFO - TinderboxPrint: CPU idle
8,223.6 (86.7%) 05:46:26 INFO - TinderboxPrint: CPU user
1,203.8 (12.7%) 05:46:26 INFO - TinderboxPrint: Swap in / out
0 / 0 05:46:26 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101236736; Read time: 0; Write time: 56868 05:46:26 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 638976; Write bytes: 220225536; Read time: 236; Write time: 118604 05:46:26 INFO - Running post-run listener: _upload_blobber_files 05:46:26 INFO - Blob upload gear active. 05:46:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:46:26 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 05:46:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:46:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:46:27 INFO - (blobuploader) - INFO - Open directory for files ... 05:46:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:46:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:46:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:28 INFO - (blobuploader) - INFO - Done attempting. 05:46:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:46:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:46:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:29 INFO - (blobuploader) - INFO - Done attempting. 05:46:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:46:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:46:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:32 INFO - (blobuploader) - INFO - Done attempting. 05:46:32 INFO - (blobuploader) - INFO - Iteration through files over. 05:46:32 INFO - Return code: 0 05:46:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:46:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:46:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29da19264b3325a1a25906a746cb6c707d1daf79b0baee89c86c9f9f288f43356932698c5f1c8be7e6c50fc73215d41ee8c59a986fbe6d6cdeacc1e8a24ac7f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/075f53c612b75592b06df08493b9efc2855ad40928bc60d698aa337e3e06083aade510b36d131c09e587ebddce32e294de06bfbe636c7628b2b1f4ce347bd89d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f4750e19af30d1aef6999e68e4be2f648ae677c35ea047abb51ce77828eadb73479e79c4a9406166f7d53f85211c4d6745a64ec8286126ee4389917ddef8cf1b"} 05:46:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:46:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:46:32 INFO - Contents: 05:46:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29da19264b3325a1a25906a746cb6c707d1daf79b0baee89c86c9f9f288f43356932698c5f1c8be7e6c50fc73215d41ee8c59a986fbe6d6cdeacc1e8a24ac7f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/075f53c612b75592b06df08493b9efc2855ad40928bc60d698aa337e3e06083aade510b36d131c09e587ebddce32e294de06bfbe636c7628b2b1f4ce347bd89d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f4750e19af30d1aef6999e68e4be2f648ae677c35ea047abb51ce77828eadb73479e79c4a9406166f7d53f85211c4d6745a64ec8286126ee4389917ddef8cf1b"} 05:46:32 INFO - Running post-run listener: copy_logs_to_upload_dir 05:46:32 INFO - Copying logs to upload dir... 05:46:32 INFO - mkdir: /builds/slave/test/build/upload/logs 05:46:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.329448 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-16 05:46:31.867911) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 05:46:31.871818) ========= 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=7de08804244eb36560b44971000001c3-1487251558.475970-857223227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29da19264b3325a1a25906a746cb6c707d1daf79b0baee89c86c9f9f288f43356932698c5f1c8be7e6c50fc73215d41ee8c59a986fbe6d6cdeacc1e8a24ac7f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/075f53c612b75592b06df08493b9efc2855ad40928bc60d698aa337e3e06083aade510b36d131c09e587ebddce32e294de06bfbe636c7628b2b1f4ce347bd89d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f4750e19af30d1aef6999e68e4be2f648ae677c35ea047abb51ce77828eadb73479e79c4a9406166f7d53f85211c4d6745a64ec8286126ee4389917ddef8cf1b"} build_url:https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011417 build_url: 'https://queue.taskcluster.net/v1/task/bIpCzpDgTwq_7vGfyd5rEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29da19264b3325a1a25906a746cb6c707d1daf79b0baee89c86c9f9f288f43356932698c5f1c8be7e6c50fc73215d41ee8c59a986fbe6d6cdeacc1e8a24ac7f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/075f53c612b75592b06df08493b9efc2855ad40928bc60d698aa337e3e06083aade510b36d131c09e587ebddce32e294de06bfbe636c7628b2b1f4ce347bd89d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f4750e19af30d1aef6999e68e4be2f648ae677c35ea047abb51ce77828eadb73479e79c4a9406166f7d53f85211c4d6745a64ec8286126ee4389917ddef8cf1b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 05:46:31.896693) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 05:46:31.897040) ========= 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=7de08804244eb36560b44971000001c3-1487251558.475970-857223227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 05:46:31.980153) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 05:46:31.980476) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 05:46:31.980771) ========= ========= Total master_lag: 0.16 =========