builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-012 starttime: 1480640283.86 results: success (0) buildid: 20161201153553 builduid: 89d1ab6de46948b7bb760c21eade42a4 revision: b49684127ce464141b0a989cd621cb4794b6a85f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 16:58:03.858803) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 16:58:03.859261) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 16:58:03.859543) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 16:58:03.875242) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 16:58:03.875538) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-01 16:58:04-- 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% 224M=0s 2016-12-01 16:58:04 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146204 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 16:58:04.037736) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 16:58:04.038049) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015099 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 16:58:04.087797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 16:58:04.088178) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b49684127ce464141b0a989cd621cb4794b6a85f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b49684127ce464141b0a989cd621cb4794b6a85f --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=2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-01 16:58:04,342 truncating revision to first 12 chars 2016-12-01 16:58:04,342 Setting DEBUG logging. 2016-12-01 16:58:04,342 attempt 1/10 2016-12-01 16:58:04,342 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b49684127ce4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-01 16:58:04,691 unpacking tar archive at: mozilla-central-b49684127ce4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.744365 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 16:58:04.847794) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 16:58:04.848120) ========= script_repo_revision: b49684127ce464141b0a989cd621cb4794b6a85f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 16:58:04.848548) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 16:58:04.848834) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 16:58:04.863664) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-12-01 16:58:04.864069) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:58:05 INFO - MultiFileLogger online at 20161201 16:58:05 in /builds/slave/test 16:58:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:58:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:58:05 INFO - {'append_to_log': False, 16:58:05 INFO - 'base_work_dir': '/builds/slave/test', 16:58:05 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:58:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:58:05 INFO - 'branch': 'Firefox-Non-PGO', 16:58:05 INFO - 'buildbot_json_path': 'buildprops.json', 16:58:05 INFO - 'config_files': ('talos/linux_config.py',), 16:58:05 INFO - 'default_actions': ('clobber', 16:58:05 INFO - 'read-buildbot-config', 16:58:05 INFO - 'download-and-extract', 16:58:05 INFO - 'populate-webroot', 16:58:05 INFO - 'create-virtualenv', 16:58:05 INFO - 'install', 16:58:05 INFO - 'run-tests'), 16:58:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:58:05 INFO - 'download_minidump_stackwalk': True, 16:58:05 INFO - 'download_symbols': 'ondemand', 16:58:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:58:05 INFO - 'tooltool.py': '/tools/tooltool.py', 16:58:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:58:05 INFO - '/tools/misc-python/virtualenv.py')}, 16:58:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:58:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:58:05 INFO - 'installer_path': 'installer.exe', 16:58:05 INFO - 'log_level': 'info', 16:58:05 INFO - 'log_name': 'talos', 16:58:05 INFO - 'log_to_console': True, 16:58:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:58:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:58:05 INFO - 'opt_config_files': (), 16:58:05 INFO - 'pip_index': False, 16:58:05 INFO - 'sps_profile': False, 16:58:05 INFO - 'sps_profile_interval': 0, 16:58:05 INFO - 'suite': 'dromaeojs', 16:58:05 INFO - 'system_bits': '32', 16:58:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:58:05 INFO - 'title': 'talos-linux64-ix-012', 16:58:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:58:05 INFO - 'use_talos_json': True, 16:58:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:58:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:58:05 INFO - 'work_dir': 'build'} 16:58:05 INFO - [mozharness: 2016-12-02 00:58:05.213323Z] Running clobber step. 16:58:05 INFO - Running pre-action listener: _resource_record_pre_action 16:58:05 INFO - Running main action method: clobber 16:58:05 INFO - rmtree: /builds/slave/test/build 16:58:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:58:06 INFO - Running post-action listener: _resource_record_post_action 16:58:06 INFO - [mozharness: 2016-12-02 00:58:06.197685Z] Finished clobber step (success) 16:58:06 INFO - [mozharness: 2016-12-02 00:58:06.197784Z] Running read-buildbot-config step. 16:58:06 INFO - Running pre-action listener: _resource_record_pre_action 16:58:06 INFO - Running main action method: read_buildbot_config 16:58:06 INFO - Using buildbot properties: 16:58:06 INFO - { 16:58:06 INFO - "project": "", 16:58:06 INFO - "product": "firefox", 16:58:06 INFO - "script_repo_revision": "production", 16:58:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:58:06 INFO - "repository": "", 16:58:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 16:58:06 INFO - "buildid": "20161201153553", 16:58:06 INFO - "pgo_build": "False", 16:58:06 INFO - "basedir": "/builds/slave/test", 16:58:06 INFO - "buildnumber": 847, 16:58:06 INFO - "slavename": "talos-linux64-ix-012", 16:58:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:58:06 INFO - "platform": "ubuntu64_hw", 16:58:06 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:58:06 INFO - "branch": "mozilla-central", 16:58:06 INFO - "repo_path": "mozilla-central", 16:58:06 INFO - "revision": "b49684127ce464141b0a989cd621cb4794b6a85f", 16:58:06 INFO - "stage_platform": "linux64", 16:58:06 INFO - "builduid": "89d1ab6de46948b7bb760c21eade42a4", 16:58:06 INFO - "slavebuilddir": "test" 16:58:06 INFO - } 16:58:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 16:58:06 INFO - Running post-action listener: _resource_record_post_action 16:58:06 INFO - [mozharness: 2016-12-02 00:58:06.200214Z] Finished read-buildbot-config step (success) 16:58:06 INFO - [mozharness: 2016-12-02 00:58:06.200304Z] Running download-and-extract step. 16:58:06 INFO - Running pre-action listener: _resource_record_pre_action 16:58:06 INFO - Running main action method: download_and_extract 16:58:06 INFO - mkdir: /builds/slave/test/build/tests 16:58:06 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')]} 16:58:06 INFO - trying https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 16:58:06 INFO - Downloading https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 16:58:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:58:06 INFO - Downloaded 1361 bytes. 16:58:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 16:58:06 INFO - Using the following test package requirements: 16:58:06 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 16:58:06 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:58:06 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:58:06 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:06 INFO - u'jsshell-linux-x86_64.zip'], 16:58:06 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:58:06 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 16:58:06 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:58:06 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:58:06 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:58:06 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:58:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:58:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 16:58:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:58:06 INFO - Fetch https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:58:07 INFO - Expected file size: 20210405 16:58:07 INFO - Obtained file size: 20210405 16:58:11 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:58:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 16:58:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:58:11 INFO - Fetch https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:58:12 INFO - Expected file size: 20210405 16:58:12 INFO - Obtained file size: 20210405 16:58:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 16:58:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:58:17 INFO - Fetch https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:58:17 INFO - Expected file size: 14409702 16:58:17 INFO - Obtained file size: 14409702 16:58: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')]} 16:58:18 INFO - trying https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 16:58:18 INFO - Downloading https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 16:58:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:58:19 INFO - Downloaded 55706195 bytes. 16:58:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 16:58:19 INFO - mkdir: /builds/slave/test/properties 16:58:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:58:19 INFO - Writing to file /builds/slave/test/properties/build_url 16:58:19 INFO - Contents: 16:58:19 INFO - build_url:https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 16:58:19 INFO - Running post-action listener: _resource_record_post_action 16:58:19 INFO - Running post-action listener: set_extra_try_arguments 16:58:19 INFO - [mozharness: 2016-12-02 00:58:19.877458Z] Finished download-and-extract step (success) 16:58:19 INFO - [mozharness: 2016-12-02 00:58:19.877686Z] Running populate-webroot step. 16:58:19 INFO - Running pre-action listener: _resource_record_pre_action 16:58:19 INFO - Running main action method: populate_webroot 16:58:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:58:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:58:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:58:19 INFO - '--tppagecycles', 16:58:19 INFO - '7'], 16:58:19 INFO - 'tests': ['tsvgm']}}, 16:58:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:58:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:58:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:58:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:58:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:58:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:58:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:58:19 INFO - 'talos_options': ['--disable-e10s'], 16:58:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:58:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:58:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:58:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:58:19 INFO - 'talos_options': ['--disable-e10s'], 16:58:19 INFO - 'tests': ['damp', 'tps']}, 16:58:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:58:19 INFO - 'tests': ['damp', 'tps']}, 16:58:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:58:19 INFO - 'tests': ['dromaeo_dom']}, 16:58:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:58:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:58:19 INFO - 'tests': ['basic_compositor_video']}, 16:58:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:58:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:58:19 INFO - 'tests': ['a11yr', 16:58:19 INFO - 'ts_paint', 16:58:19 INFO - 'tpaint', 16:58:19 INFO - 'sessionrestore', 16:58:19 INFO - 'sessionrestore_no_auto_restore', 16:58:19 INFO - 'tabpaint']}, 16:58:19 INFO - 'other-e10s': {'tests': ['a11yr', 16:58:19 INFO - 'ts_paint', 16:58:19 INFO - 'tpaint', 16:58:19 INFO - 'sessionrestore', 16:58:19 INFO - 'sessionrestore_no_auto_restore', 16:58:19 INFO - 'tabpaint']}, 16:58:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:58:19 INFO - 'ts_paint', 16:58:19 INFO - 'tpaint', 16:58:19 INFO - 'sessionrestore', 16:58:19 INFO - 'sessionrestore_no_auto_restore', 16:58:19 INFO - 'tabpaint']}, 16:58:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:58:19 INFO - 'ts_paint', 16:58:19 INFO - 'tpaint', 16:58:19 INFO - 'sessionrestore', 16:58:19 INFO - 'sessionrestore_no_auto_restore', 16:58:19 INFO - 'tabpaint']}, 16:58:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:58:19 INFO - 'tests': ['a11yr', 16:58:19 INFO - 'ts_paint', 16:58:19 INFO - 'tpaint', 16:58:19 INFO - 'sessionrestore', 16:58:19 INFO - 'sessionrestore_no_auto_restore', 16:58:19 INFO - 'tabpaint']}, 16:58:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:58:19 INFO - 'tests': ['a11yr', 16:58:19 INFO - 'ts_paint', 16:58:19 INFO - 'tpaint', 16:58:19 INFO - 'sessionrestore', 16:58:19 INFO - 'sessionrestore_no_auto_restore', 16:58:19 INFO - 'tabpaint']}, 16:58:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:58:19 INFO - 'tests': ['tsvgx', 16:58:19 INFO - 'tsvgr_opacity', 16:58:19 INFO - 'tart', 16:58:19 INFO - 'tscrollx', 16:58:19 INFO - 'cart', 16:58:19 INFO - 'tsvg_static']}, 16:58:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:58:19 INFO - 'tsvgr_opacity', 16:58:19 INFO - 'tart', 16:58:19 INFO - 'tscrollx', 16:58:19 INFO - 'cart', 16:58:19 INFO - 'tsvg_static']}, 16:58:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:58:19 INFO - 'talos_options': ['--disable-e10s'], 16:58:19 INFO - 'tests': ['tp5o']}, 16:58:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:58:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:58:19 INFO - 'talos_options': ['--disable-e10s', 16:58:19 INFO - '--xperf_path', 16:58:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:58:19 INFO - 'tests': ['tp5n']}, 16:58:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:58:19 INFO - 'talos_options': ['--xperf_path', 16:58:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:58:19 INFO - 'tests': ['tp5n']}}, 16:58:19 INFO - 'talos.zip': {'path': '', 16:58:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:58:19 INFO - Running post-action listener: _resource_record_post_action 16:58:19 INFO - [mozharness: 2016-12-02 00:58:19.895401Z] Finished populate-webroot step (success) 16:58:19 INFO - [mozharness: 2016-12-02 00:58:19.895490Z] Running create-virtualenv step. 16:58:19 INFO - Running pre-action listener: _resource_record_pre_action 16:58:19 INFO - Running main action method: create_virtualenv 16:58:19 INFO - Creating virtualenv /builds/slave/test/build/venv 16:58:19 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 16:58:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:58:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:58:19 INFO - Using real prefix '/usr' 16:58:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:58:20 INFO - Installing distribute.............................................................................................................................................................................................done. 16:58:22 INFO - Installing pip.................done. 16:58:22 INFO - Return code: 0 16:58:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:58:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:58:22 INFO - Reading from file tmpfile_stdout 16:58:22 INFO - Output received: 16:58:22 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) 16:58:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8682a1e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1811130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189ffc0>, '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 0x18a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a1350>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', '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 16:58:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:58:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:58:22 INFO - Using env: {'DISPLAY': ':0', 16:58:22 INFO - 'HOME': '/home/cltbld', 16:58:22 INFO - 'LANG': 'en_US.UTF-8', 16:58:22 INFO - 'LANGUAGE': 'en_US:en', 16:58:22 INFO - 'LOGNAME': 'cltbld', 16:58:22 INFO - 'MAIL': '/var/mail/cltbld', 16:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:22 INFO - 'MOZ_NO_REMOTE': '1', 16:58:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:22 INFO - 'NO_EM_RESTART': '1', 16:58:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:22 INFO - 'PWD': '/builds/slave/test', 16:58:22 INFO - 'SHELL': '/bin/bash', 16:58:22 INFO - 'SHLVL': '1', 16:58:22 INFO - 'TERM': 'linux', 16:58:22 INFO - 'TMOUT': '86400', 16:58:22 INFO - 'USER': 'cltbld', 16:58:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', 16:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:22 INFO - '_': '/tools/buildbot/bin/python'} 16:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:22 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 16:58:22 INFO - Cleaning up... 16:58:22 INFO - Return code: 0 16:58:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc8682a1e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1811130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189ffc0>, '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 0x18a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a1350>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', '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 16:58:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:58:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:58:22 INFO - Using env: {'DISPLAY': ':0', 16:58:22 INFO - 'HOME': '/home/cltbld', 16:58:22 INFO - 'LANG': 'en_US.UTF-8', 16:58:22 INFO - 'LANGUAGE': 'en_US:en', 16:58:22 INFO - 'LOGNAME': 'cltbld', 16:58:22 INFO - 'MAIL': '/var/mail/cltbld', 16:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:22 INFO - 'MOZ_NO_REMOTE': '1', 16:58:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:22 INFO - 'NO_EM_RESTART': '1', 16:58:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:22 INFO - 'PWD': '/builds/slave/test', 16:58:22 INFO - 'SHELL': '/bin/bash', 16:58:22 INFO - 'SHLVL': '1', 16:58:22 INFO - 'TERM': 'linux', 16:58:22 INFO - 'TMOUT': '86400', 16:58:22 INFO - 'USER': 'cltbld', 16:58:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', 16:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:22 INFO - '_': '/tools/buildbot/bin/python'} 16:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:23 INFO - Downloading/unpacking psutil>=3.1.1 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:58:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:25 INFO - Installing collected packages: psutil 16:58:25 INFO - Running setup.py install for psutil 16:58:25 INFO - building 'psutil._psutil_linux' extension 16:58:25 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 16:58:25 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 16:58:25 INFO - building 'psutil._psutil_posix' extension 16:58:25 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 16:58:25 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 16:58:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:25 INFO - Successfully installed psutil 16:58:25 INFO - Cleaning up... 16:58:25 INFO - Return code: 0 16:58:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8682a1e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1811130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189ffc0>, '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 0x18a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a1350>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', '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 16:58:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:58:25 INFO - Using env: {'DISPLAY': ':0', 16:58:25 INFO - 'HOME': '/home/cltbld', 16:58:25 INFO - 'LANG': 'en_US.UTF-8', 16:58:25 INFO - 'LANGUAGE': 'en_US:en', 16:58:25 INFO - 'LOGNAME': 'cltbld', 16:58:25 INFO - 'MAIL': '/var/mail/cltbld', 16:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:25 INFO - 'MOZ_NO_REMOTE': '1', 16:58:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:25 INFO - 'NO_EM_RESTART': '1', 16:58:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:25 INFO - 'PWD': '/builds/slave/test', 16:58:25 INFO - 'SHELL': '/bin/bash', 16:58:25 INFO - 'SHLVL': '1', 16:58:25 INFO - 'TERM': 'linux', 16:58:25 INFO - 'TMOUT': '86400', 16:58:25 INFO - 'USER': 'cltbld', 16:58:25 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', 16:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:25 INFO - '_': '/tools/buildbot/bin/python'} 16:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:58:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:58:28 INFO - Installing collected packages: mozsystemmonitor 16:58:28 INFO - Running setup.py install for mozsystemmonitor 16:58:28 INFO - Successfully installed mozsystemmonitor 16:58:28 INFO - Cleaning up... 16:58:28 INFO - Return code: 0 16:58:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:28 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 0x7fc8682a1e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1811130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189ffc0>, '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 0x18a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a1350>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', '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 16:58:28 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 16:58:28 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 16:58:28 INFO - Using env: {'DISPLAY': ':0', 16:58:28 INFO - 'HOME': '/home/cltbld', 16:58:28 INFO - 'LANG': 'en_US.UTF-8', 16:58:28 INFO - 'LANGUAGE': 'en_US:en', 16:58:28 INFO - 'LOGNAME': 'cltbld', 16:58:28 INFO - 'MAIL': '/var/mail/cltbld', 16:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:28 INFO - 'MOZ_NO_REMOTE': '1', 16:58:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:28 INFO - 'NO_EM_RESTART': '1', 16:58:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:28 INFO - 'PWD': '/builds/slave/test', 16:58:28 INFO - 'SHELL': '/bin/bash', 16:58:28 INFO - 'SHLVL': '1', 16:58:28 INFO - 'TERM': 'linux', 16:58:28 INFO - 'TMOUT': '86400', 16:58:28 INFO - 'USER': 'cltbld', 16:58:28 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', 16:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:28 INFO - '_': '/tools/buildbot/bin/python'} 16:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:28 INFO - Downloading/unpacking jsonschema==2.5.1 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:58:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:58:30 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 16:58:30 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 16:58:30 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 16:58:30 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 16:58:30 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 16:58:30 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 16:58:30 INFO - Downloading functools32-3.2.3-2.tar.gz 16:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:58:30 INFO - warning: no files found matching '*.txt' 16:58:30 INFO - no previously-included directories found matching 'build' 16:58:30 INFO - no previously-included directories found matching 'dist' 16:58:30 INFO - no previously-included directories found matching '.git*' 16:58:30 INFO - Installing collected packages: jsonschema, functools32 16:58:30 INFO - Running setup.py install for functools32 16:58:30 INFO - warning: no files found matching '*.txt' 16:58:30 INFO - no previously-included directories found matching 'build' 16:58:30 INFO - no previously-included directories found matching 'dist' 16:58:30 INFO - no previously-included directories found matching '.git*' 16:58:30 INFO - Successfully installed jsonschema functools32 16:58:30 INFO - Cleaning up... 16:58:31 INFO - Return code: 0 16:58:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:31 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 0x7fc8682a1e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1811130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189ffc0>, '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 0x18a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a1350>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', '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 16:58:31 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 16:58:31 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 16:58:31 INFO - Using env: {'DISPLAY': ':0', 16:58:31 INFO - 'HOME': '/home/cltbld', 16:58:31 INFO - 'LANG': 'en_US.UTF-8', 16:58:31 INFO - 'LANGUAGE': 'en_US:en', 16:58:31 INFO - 'LOGNAME': 'cltbld', 16:58:31 INFO - 'MAIL': '/var/mail/cltbld', 16:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:31 INFO - 'MOZ_NO_REMOTE': '1', 16:58:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:31 INFO - 'NO_EM_RESTART': '1', 16:58:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:31 INFO - 'PWD': '/builds/slave/test', 16:58:31 INFO - 'SHELL': '/bin/bash', 16:58:31 INFO - 'SHLVL': '1', 16:58:31 INFO - 'TERM': 'linux', 16:58:31 INFO - 'TMOUT': '86400', 16:58:31 INFO - 'USER': 'cltbld', 16:58:31 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', 16:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:31 INFO - '_': '/tools/buildbot/bin/python'} 16:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:58:31 INFO - Cleaning up... 16:58:31 INFO - Return code: 0 16:58:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:31 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 0x7fc8682a1e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1811130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189ffc0>, '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 0x18a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a1350>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', '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 16:58:31 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 16:58:31 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 16:58:31 INFO - Using env: {'DISPLAY': ':0', 16:58:31 INFO - 'HOME': '/home/cltbld', 16:58:31 INFO - 'LANG': 'en_US.UTF-8', 16:58:31 INFO - 'LANGUAGE': 'en_US:en', 16:58:31 INFO - 'LOGNAME': 'cltbld', 16:58:31 INFO - 'MAIL': '/var/mail/cltbld', 16:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:31 INFO - 'MOZ_NO_REMOTE': '1', 16:58:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:31 INFO - 'NO_EM_RESTART': '1', 16:58:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:31 INFO - 'PWD': '/builds/slave/test', 16:58:31 INFO - 'SHELL': '/bin/bash', 16:58:31 INFO - 'SHLVL': '1', 16:58:31 INFO - 'TERM': 'linux', 16:58:31 INFO - 'TMOUT': '86400', 16:58:31 INFO - 'USER': 'cltbld', 16:58:31 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', 16:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:31 INFO - '_': '/tools/buildbot/bin/python'} 16:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:31 INFO - Downloading/unpacking blobuploader==1.2.4 16:58:31 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 16:58:31 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 16:58:31 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 16:58:31 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 16:58:31 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 16:58:31 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 16:58:33 INFO - Downloading blobuploader-1.2.4.tar.gz 16:58:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:58:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:58:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:34 INFO - Downloading docopt-0.6.1.tar.gz 16:58:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:58:34 INFO - Installing collected packages: blobuploader, requests, docopt 16:58:34 INFO - Running setup.py install for blobuploader 16:58:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:58:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:58:34 INFO - Running setup.py install for requests 16:58:34 INFO - Running setup.py install for docopt 16:58:34 INFO - Successfully installed blobuploader requests docopt 16:58:34 INFO - Cleaning up... 16:58:34 INFO - Return code: 0 16:58:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:34 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 0x7fc8682a1e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1811130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189ffc0>, '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 0x18a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a1350>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', '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 16:58:34 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 16:58:34 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 16:58:34 INFO - Using env: {'DISPLAY': ':0', 16:58:34 INFO - 'HOME': '/home/cltbld', 16:58:34 INFO - 'LANG': 'en_US.UTF-8', 16:58:34 INFO - 'LANGUAGE': 'en_US:en', 16:58:34 INFO - 'LOGNAME': 'cltbld', 16:58:34 INFO - 'MAIL': '/var/mail/cltbld', 16:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:34 INFO - 'MOZ_NO_REMOTE': '1', 16:58:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:34 INFO - 'NO_EM_RESTART': '1', 16:58:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:34 INFO - 'PWD': '/builds/slave/test', 16:58:34 INFO - 'SHELL': '/bin/bash', 16:58:34 INFO - 'SHLVL': '1', 16:58:34 INFO - 'TERM': 'linux', 16:58:34 INFO - 'TMOUT': '86400', 16:58:34 INFO - 'USER': 'cltbld', 16:58:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', 16:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:34 INFO - '_': '/tools/buildbot/bin/python'} 16:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:58:35 INFO - Running setup.py (path:/tmp/pip-WTbDuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:58:35 INFO - Running setup.py (path:/tmp/pip-UDUuOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:58:35 INFO - Running setup.py (path:/tmp/pip-TztPdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:58:35 INFO - Running setup.py (path:/tmp/pip-FrWqKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:58:35 INFO - Running setup.py (path:/tmp/pip-vM0X17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:58:35 INFO - Running setup.py (path:/tmp/pip-uQ_h2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:58:35 INFO - Running setup.py (path:/tmp/pip-FfehKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:58:35 INFO - Running setup.py (path:/tmp/pip-In89Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:58:35 INFO - Running setup.py (path:/tmp/pip-2p6c3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:58:35 INFO - Running setup.py (path:/tmp/pip-k1281K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:58:35 INFO - Running setup.py (path:/tmp/pip-RxSXcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:58:35 INFO - Running setup.py (path:/tmp/pip-PvbbV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:58:35 INFO - Running setup.py (path:/tmp/pip-HD9ZWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:58:36 INFO - Running setup.py (path:/tmp/pip-1SQVOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:36 INFO - Running setup.py (path:/tmp/pip-hJoQUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:58:36 INFO - Running setup.py (path:/tmp/pip-vEIZo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:58:36 INFO - Running setup.py (path:/tmp/pip-LD92QI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:58:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:58:36 INFO - Running setup.py install for manifestparser 16:58:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:58:36 INFO - Running setup.py install for mozcrash 16:58:36 INFO - Running setup.py install for mozdebug 16:58:36 INFO - Running setup.py install for mozdevice 16:58:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:58:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:58:36 INFO - Running setup.py install for mozfile 16:58:36 INFO - Running setup.py install for mozhttpd 16:58:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:58:36 INFO - Running setup.py install for mozinfo 16:58:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:58:37 INFO - Running setup.py install for mozInstall 16:58:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:58:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:58:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:58:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:58:37 INFO - Running setup.py install for mozleak 16:58:37 INFO - Running setup.py install for mozlog 16:58:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:58:37 INFO - Running setup.py install for moznetwork 16:58:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:58:37 INFO - Running setup.py install for mozprocess 16:58:37 INFO - Running setup.py install for mozprofile 16:58:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:58:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:58:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:58:37 INFO - Running setup.py install for mozrunner 16:58:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:58:37 INFO - Running setup.py install for mozscreenshot 16:58:37 INFO - Running setup.py install for moztest 16:58:37 INFO - Running setup.py install for mozversion 16:58:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:58:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:58:38 INFO - Cleaning up... 16:58:38 INFO - Return code: 0 16:58:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58:38 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')]} 16:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:38 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')]} 16:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:38 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 0x7fc8682a1e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1811130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189ffc0>, '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 0x18a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a1350>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', '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 16:58:38 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 16:58:38 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 16:58:38 INFO - Using env: {'DISPLAY': ':0', 16:58:38 INFO - 'HOME': '/home/cltbld', 16:58:38 INFO - 'LANG': 'en_US.UTF-8', 16:58:38 INFO - 'LANGUAGE': 'en_US:en', 16:58:38 INFO - 'LOGNAME': 'cltbld', 16:58:38 INFO - 'MAIL': '/var/mail/cltbld', 16:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:38 INFO - 'MOZ_NO_REMOTE': '1', 16:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:38 INFO - 'NO_EM_RESTART': '1', 16:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:38 INFO - 'PWD': '/builds/slave/test', 16:58:38 INFO - 'SHELL': '/bin/bash', 16:58:38 INFO - 'SHLVL': '1', 16:58:38 INFO - 'TERM': 'linux', 16:58:38 INFO - 'TMOUT': '86400', 16:58:38 INFO - 'USER': 'cltbld', 16:58:38 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', 16:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:38 INFO - '_': '/tools/buildbot/bin/python'} 16:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:58:38 INFO - Running setup.py (path:/tmp/pip-OqN6R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:58:38 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)) 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:58:38 INFO - Running setup.py (path:/tmp/pip-faxrLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:58:38 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)) 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:58:38 INFO - Running setup.py (path:/tmp/pip-ZbzfD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:58:38 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)) 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:58:38 INFO - Running setup.py (path:/tmp/pip-Lbf3R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:58:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:58:38 INFO - Running setup.py (path:/tmp/pip-FtMLE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:58:38 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)) 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:58:38 INFO - Running setup.py (path:/tmp/pip-g662YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:58:38 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)) 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:58:38 INFO - Running setup.py (path:/tmp/pip-W9OQug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:58:38 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)) 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:58:38 INFO - Running setup.py (path:/tmp/pip-ycvgj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:58:38 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)) 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:58:38 INFO - Running setup.py (path:/tmp/pip-NhzaKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:58:39 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)) 16:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:58:39 INFO - Running setup.py (path:/tmp/pip-yXEgmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:58:39 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)) 16:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:58:39 INFO - Running setup.py (path:/tmp/pip-AFGe6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:58:39 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)) 16:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:58:39 INFO - Running setup.py (path:/tmp/pip-6GhFKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:58:39 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)) 16:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:58:39 INFO - Running setup.py (path:/tmp/pip-0Pqrrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:58:39 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)) 16:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:58:39 INFO - Running setup.py (path:/tmp/pip-HFNolm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:58:39 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)) 16:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:39 INFO - Running setup.py (path:/tmp/pip-4S5uIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:39 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)) 16:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:58:39 INFO - Running setup.py (path:/tmp/pip-71iiD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:58:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:58:39 INFO - Running setup.py (path:/tmp/pip-ml3k5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:58:39 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)) 16:58:39 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)) 16:58:39 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)) 16:58:39 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)) 16:58:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:58:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:58:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:41 INFO - Downloading blessings-1.6.tar.gz 16:58:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:58:41 INFO - Installing collected packages: blessings 16:58:41 INFO - Running setup.py install for blessings 16:58:41 INFO - Successfully installed blessings 16:58:41 INFO - Cleaning up... 16:58:41 INFO - Return code: 0 16:58:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:58:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:58:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:58:42 INFO - Reading from file tmpfile_stdout 16:58:42 INFO - Current package versions: 16:58:42 INFO - argparse == 1.2.1 16:58:42 INFO - blessings == 1.6 16:58:42 INFO - blobuploader == 1.2.4 16:58:42 INFO - docopt == 0.6.1 16:58:42 INFO - functools32 == 3.2.3-2 16:58:42 INFO - jsonschema == 2.5.1 16:58:42 INFO - manifestparser == 1.1 16:58:42 INFO - mozInstall == 1.12 16:58:42 INFO - mozcrash == 1.0 16:58:42 INFO - mozdebug == 0.1 16:58:42 INFO - mozdevice == 0.49 16:58:42 INFO - mozfile == 1.2 16:58:42 INFO - mozhttpd == 0.7 16:58:42 INFO - mozinfo == 0.9 16:58:42 INFO - mozleak == 0.1 16:58:42 INFO - mozlog == 3.4 16:58:42 INFO - moznetwork == 0.27 16:58:42 INFO - mozprocess == 0.23 16:58:42 INFO - mozprofile == 0.28 16:58:42 INFO - mozrunner == 6.13 16:58:42 INFO - mozscreenshot == 0.1 16:58:42 INFO - mozsystemmonitor == 0.3 16:58:42 INFO - moztest == 0.7 16:58:42 INFO - mozversion == 1.4 16:58:42 INFO - psutil == 3.1.1 16:58:42 INFO - requests == 1.2.3 16:58:42 INFO - wsgiref == 0.1.2 16:58:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:42 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 0x7fc8682a1e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1811130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189ffc0>, '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 0x18a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a1350>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', '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 16:58:42 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 16:58:42 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 16:58:42 INFO - Using env: {'DISPLAY': ':0', 16:58:42 INFO - 'HOME': '/home/cltbld', 16:58:42 INFO - 'LANG': 'en_US.UTF-8', 16:58:42 INFO - 'LANGUAGE': 'en_US:en', 16:58:42 INFO - 'LOGNAME': 'cltbld', 16:58:42 INFO - 'MAIL': '/var/mail/cltbld', 16:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:42 INFO - 'MOZ_NO_REMOTE': '1', 16:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:42 INFO - 'NO_EM_RESTART': '1', 16:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:42 INFO - 'PWD': '/builds/slave/test', 16:58:42 INFO - 'SHELL': '/bin/bash', 16:58:42 INFO - 'SHLVL': '1', 16:58:42 INFO - 'TERM': 'linux', 16:58:42 INFO - 'TMOUT': '86400', 16:58:42 INFO - 'USER': 'cltbld', 16:58:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', 16:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:42 INFO - '_': '/tools/buildbot/bin/python'} 16:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:42 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)) 16:58:42 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)) 16:58:42 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)) 16:58:42 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)) 16:58:42 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)) 16:58:42 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)) 16:58:42 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)) 16:58:42 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)) 16:58:42 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)) 16:58:42 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)) 16:58:42 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)) 16:58:42 INFO - Cleaning up... 16:58:42 INFO - Return code: 0 16:58:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:42 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 0x7fc8682a1e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1811130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189ffc0>, '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 0x18a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a1350>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', '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 16:58:42 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 16:58:42 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 16:58:42 INFO - Using env: {'DISPLAY': ':0', 16:58:42 INFO - 'HOME': '/home/cltbld', 16:58:42 INFO - 'LANG': 'en_US.UTF-8', 16:58:42 INFO - 'LANGUAGE': 'en_US:en', 16:58:42 INFO - 'LOGNAME': 'cltbld', 16:58:42 INFO - 'MAIL': '/var/mail/cltbld', 16:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:42 INFO - 'MOZ_NO_REMOTE': '1', 16:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:42 INFO - 'NO_EM_RESTART': '1', 16:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:42 INFO - 'PWD': '/builds/slave/test', 16:58:42 INFO - 'SHELL': '/bin/bash', 16:58:42 INFO - 'SHLVL': '1', 16:58:42 INFO - 'TERM': 'linux', 16:58:42 INFO - 'TMOUT': '86400', 16:58:42 INFO - 'USER': 'cltbld', 16:58:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', 16:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:42 INFO - '_': '/tools/buildbot/bin/python'} 16:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:58:42 INFO - Cleaning up... 16:58:42 INFO - Return code: 0 16:58:42 INFO - Running post-action listener: _resource_record_post_action 16:58:42 INFO - Running post-action listener: _start_resource_monitoring 16:58:42 INFO - Starting resource monitoring. 16:58:42 INFO - [mozharness: 2016-12-02 00:58:42.545725Z] Finished create-virtualenv step (success) 16:58:42 INFO - [mozharness: 2016-12-02 00:58:42.546197Z] Running install step. 16:58:42 INFO - Running pre-action listener: _resource_record_pre_action 16:58:42 INFO - Running main action method: install 16:58:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:58:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:58:42 INFO - Reading from file tmpfile_stdout 16:58:42 INFO - Detecting whether we're running mozinstall >=1.0... 16:58:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:58:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:58:42 INFO - Reading from file tmpfile_stdout 16:58:42 INFO - Output received: 16:58:42 INFO - Usage: mozinstall [options] installer 16:58:42 INFO - Options: 16:58:42 INFO - -h, --help show this help message and exit 16:58:42 INFO - -d DEST, --destination=DEST 16:58:42 INFO - Directory to install application into. [default: 16:58:42 INFO - "/builds/slave/test"] 16:58:42 INFO - --app=APP Application being installed. [default: firefox] 16:58:42 INFO - mkdir: /builds/slave/test/build/application 16:58:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:58:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:58:58 INFO - Reading from file tmpfile_stdout 16:58:58 INFO - Output received: 16:58:58 INFO - /builds/slave/test/build/application/firefox/firefox 16:58:58 INFO - Running post-action listener: _resource_record_post_action 16:58:58 INFO - [mozharness: 2016-12-02 00:58:58.912798Z] Finished install step (success) 16:58:58 INFO - [mozharness: 2016-12-02 00:58:58.913049Z] Running run-tests step. 16:58:58 INFO - Running pre-action listener: _resource_record_pre_action 16:58:58 INFO - Running main action method: run_tests 16:58:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:58:58 INFO - Python 2.7.3 16:58:58 INFO - Return code: 0 16:58:58 INFO - grabbing minidump binary from tooltool 16:58:58 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')]} 16:58:58 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 0x189ffc0>, '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 0x18a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a1350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:58:58 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 16:58:58 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 16:58:58 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 16:58:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:58:58 INFO - Return code: 0 16:58:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:58:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:58:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:58:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:58:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:58:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:58:58 INFO - Using env: {'DISPLAY': ':0', 16:58:58 INFO - 'HOME': '/home/cltbld', 16:58:58 INFO - 'LANG': 'en_US.UTF-8', 16:58:58 INFO - 'LANGUAGE': 'en_US:en', 16:58:58 INFO - 'LOGNAME': 'cltbld', 16:58:58 INFO - 'MAIL': '/var/mail/cltbld', 16:58:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:58:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:58 INFO - 'MOZ_NO_REMOTE': '1', 16:58:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:58 INFO - 'NO_EM_RESTART': '1', 16:58:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:58 INFO - 'PWD': '/builds/slave/test', 16:58:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:58:58 INFO - 'SHELL': '/bin/bash', 16:58:58 INFO - 'SHLVL': '1', 16:58:58 INFO - 'TERM': 'linux', 16:58:59 INFO - 'TMOUT': '86400', 16:58:59 INFO - 'USER': 'cltbld', 16:58:59 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809', 16:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:59 INFO - '_': '/tools/buildbot/bin/python'} 16:58:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:58:59 INFO - mozversion application_buildid: 20161201153553 16:58:59 INFO - mozversion application_changeset: b49684127ce464141b0a989cd621cb4794b6a85f 16:58:59 INFO - mozversion application_display_name: Nightly 16:58:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:58:59 INFO - mozversion application_name: Firefox 16:58:59 INFO - mozversion application_remotingname: firefox 16:58:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:58:59 INFO - mozversion application_vendor: Mozilla 16:58:59 INFO - mozversion application_version: 53.0a1 16:58:59 INFO - mozversion platform_buildid: 20161201153553 16:58:59 INFO - mozversion platform_changeset: b49684127ce464141b0a989cd621cb4794b6a85f 16:58:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:58:59 INFO - mozversion platform_version: 53.0a1 16:58:59 INFO - using testdate: 1480640339 16:58:59 INFO - actual date: 1480640339 16:58:59 INFO - starting webserver on 'localhost:50001' 16:58:59 INFO - SUITE-START | Running 2 tests 16:58:59 INFO - TEST-START | dromaeo_css 16:58:59 INFO - operating with platform_type : linux_ 16:58:59 INFO - Initialising browser for dromaeo_css test... 16:58:59 INFO - TEST-INFO | started process 6683 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprnN7R5/profile http://localhost:50001/getInfo.html) 16:59:03 INFO - PROCESS | 6683 | __metrics Screen width/height:1600/1200 16:59:03 INFO - PROCESS | 6683 | colorDepth:24 16:59:03 INFO - PROCESS | 6683 | Browser inner width/height: 1024/697 16:59:03 INFO - PROCESS | 6683 | __metrics 16:59:03 INFO - PROCESS | 6683 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:59:03 INFO - PROCESS | 6683 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:59:04 INFO - PROCESS | 6683 | console.error: PushService: 16:59:04 INFO - PROCESS | 6683 | stateChangeProcessEnqueue: Error transitioning state 16:59:04 INFO - PROCESS | 6683 | UnknownError 16:59:05 INFO - TEST-INFO | 6683: exit 0 16:59:05 INFO - Browser initialized. 16:59:05 INFO - Running cycle 1/1 for dromaeo_css test... 16:59:05 INFO - TEST-INFO | started process 6765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprnN7R5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:59:17 INFO - PROCESS | 6765 | RSS: Main: 175263744 16:59:17 INFO - PROCESS | 6765 | 17:00:08 INFO - PROCESS | 6765 | 1480640408173 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:02:22 INFO - PROCESS | 6765 | Cycle 1(1): loaded http://localhost:50001/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50001/tests/dromaeo/cssquery-ext.html) 17:02:23 INFO - PROCESS | 6765 | RSS: Main: 325828608 17:02:23 INFO - PROCESS | 6765 | 17:05:26 INFO - PROCESS | 6765 | Cycle 1(1): loaded http://localhost:50001/tests/dromaeo/cssquery-ext.html (next: http://localhost:50001/tests/dromaeo/cssquery-jquery.html) 17:05:27 INFO - PROCESS | 6765 | RSS: Main: 282484736 17:05:27 INFO - PROCESS | 6765 | 17:08:29 INFO - PROCESS | 6765 | Cycle 1(1): loaded http://localhost:50001/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50001/tests/dromaeo/cssquery-mootools.html) 17:08:30 INFO - PROCESS | 6765 | RSS: Main: 223715328 17:08:30 INFO - PROCESS | 6765 | 17:11:32 INFO - PROCESS | 6765 | Cycle 1(1): loaded http://localhost:50001/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50001/tests/dromaeo/cssquery-prototype.html) 17:11:33 INFO - PROCESS | 6765 | RSS: Main: 238133248 17:11:33 INFO - PROCESS | 6765 | 17:14:36 INFO - PROCESS | 6765 | Cycle 1(1): loaded http://localhost:50001/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50001/tests/dromaeo/cssquery-yui.html) 17:14:36 INFO - PROCESS | 6765 | RSS: Main: 226185216 17:14:36 INFO - PROCESS | 6765 | 17:17:39 INFO - PROCESS | 6765 | Cycle 1(1): loaded http://localhost:50001/tests/dromaeo/cssquery-yui.html (next: http://localhost:50001/tests/dromaeo/cssquery-dojo.html) 17:17:39 INFO - PROCESS | 6765 | RSS: Main: 318357504 17:17:39 INFO - PROCESS | 6765 | 17:17:39 INFO - PROCESS | 6765 | __start_tp_report 17:17:39 INFO - PROCESS | 6765 | _x_x_mozilla_page_load 17:17:39 INFO - PROCESS | 6765 | _x_x_mozilla_page_load_details 17:17:39 INFO - PROCESS | 6765 | |i|pagename|runs| 17:17:39 INFO - PROCESS | 6765 | |0;dojo.html;2569.1008147148495;2594.6886373635166;2614.4248265381616;2620.92137235883;2631.710511843698;4507.90984180317;4588.105319462706;4604.608608268297;4611.746353950532;4666.976665116674;4582.564656357641;4586.4266966629175;4624.976875115628;4673.813047478096;4729.668923175371;4209.936850947238;4239.236937351276;4272.487301523822;4301.741895486265;4344.304911214206;4272.124214536013;4338.370936214247;4343.630791382736;4395.142947125312;4434.268345722968;4200.747955122672;4248.299030659938;4341.41390912226;4397.274449715825;4426.690131690783;4262.573742625744;4268.359746038088;4283.571642835723;4284.121755040209;4286.914261714748;4278.593533614302;4281.186574550826;4282.293421585435;4289.399484072233;4290.506591741959;4627.976860115711;4638.072385522909;4641.280601506772;4646;4647.070585882803;4899.1426500362295;4934.185859333205;4946.307516947631;4946.72792996385;4996.400431948153;4958.801647934079;4975.850724478271;4976.925346119811;4980.551750342486;5001.7499125043605;4521.389612402284;4627.6066534344955;4643.442786865564;4643.512431194744;4645.9303110453375;5032.0690672225755;5034.546890779848;5052.873678158076;5100.38795344561;5110.744462776846;4847.151748444008;4901.509849015141;4910.533499317559;4945.010997800454;4966.776495057658;4976.776045077981;4985.102681517289;4985.476524964899;4985.850424487271;4989.900201996013;4715.363425937455;4734.384530011076;4739.526047395233;4804.591609713144;4966.205407134913;4884.340614017062;4890.413150421901;4895.583875370633;4936.333594964705;4939.160342741742;4210.894727631834;4216.030313027959;4217.810198541073;4252.4471818664;4257.957420425818;3598;3626.6192049834917;3671.173985853215;3682;3736.3461394255896;4230.450041494586;4245.469316335458;4276.294411422143;4276.401303817468;4331.6534677225745;4976.328195693607;5011.599072074226;5020.146575082172;5023.372078490189;5023.547880690682;4237.216115018731;4248.915021699549;4253.128108737701;4254.127903779718;4288.935665965013;4361.629261512807;4393.165298593257;4430.490493593214;4479.865604031885;4482.327650852399;4608.147492713859;4640.605548528413;4652.604528615106;4659.2079346511855;4660.533946605312;4971.850844474671;4978.47725988766;4985.351904252424;4990.775415106402;5017.774200160929;4711.976440117777;4747.8575642730775;4750.097481478508;4753.429588449409;4753.881152971203;4955.628327875352;4962.082014827269;4965.900681986413;4965.925511117264;5013.598912086952;4850.684705494132;4984.127777638826;5036.748162591929;5039.21892106724;5090.312807771052;4788.592969597623;4797.280407938837;4802.807887684454;4802.903941921212;4804.5195480451675;4773.522647735337;4781.665283430127;4784.952150478451;4790.233562629963;4792.400949881265;4682.023784561047;4723.267893476516;4788.928166077581;4813.387515182453;4839.564439200489;4964.255361695775;4964.875878102932;4966.925496117489;4970.254461830755;5004.574611158092;4836.419629644465;4841.443234028132;4843.588294994965;4875.658703890694;4888.560029597211 17:17:39 INFO - PROCESS | 6765 | |1;ext.html;556.151868400689;568.2385603291589;572.6535446055137;573.5297056413742;586.1003359842642;27191.5921261181;37580.624193758056;38857.417138742945;38884.61115388845;42477.57522424783;38736.22527549447;39034.219315613744;39137.41293880594;39138;39161.60838391615;7522.962385188066;7667.309942105209;7674.616269186547;7680.039995000625;7680.385569154454;7412.962935185316;7635.160132385433;9501;9766.414015159078;9789;9765.853512197322;9823.263255255848;9828.361156524803;9832.655857045005;9843.360181588174;9754.365966212208;9808.656697015642;9824.90175098254;9835.213182945346;9837.655682051165;9531.285153613506;9589.232861371074;9591.904080959172;9598.280128990353;9603.231741460666;36653;37115.81442092799;37164.44253336175;37186.44220336697;37211.25577488462;2913.1988703106817;3048.420800047984;3254.300325430044;3353.899383018513;3457.8271086445575;27832.443351133068;27833.721662783315;27835.02577409781;28014.159575212776;28020.43959120806;3387.458006718913;3459.892834293027;3461.5153878457036;3471.7916924984584;3509;235770;236358;236926;237033;237550;47361.28958065632;47646;47694.52305476901;47723.52276477191;47779;50216.246756298686;50268.74865625649;50310.49689503131;50359;50466.49533504618;12916;13094.607161785161;13110.147840390344;13119.803202951773;13122.34388280582;8145.5927203639585;8314.958425207835;10039.548220330104;10095.7476063099;10101.292909496266;12799.616011519669;12916.41876115577;12957.416916238792;13749.518766843112;14294.571162865132;4911.028827559347;5469.343678758574;5572.498475137257;5687.208529313253;5709.200711900337;800.4596897094555;940.1068984464649;982.219135787051;995.3679413572289;1002.5288114586133;26242;26255.606165907528;26615.733842661324;27050;27051.458970820866;947.4173383369179;966.5119114847098;972.8576697267864;1000.6747806962766;1020.2348238820884;13940.86059139416;14241.287935603179;14276.14343139415;14520.782188267185;14584.927075364556;334125;335304;336062;336274;336402;40869.38695919564;41843.7907810459;45481.49851758185;46509.76745116253;46616;1141.4349896801302;1148.0700632487712;1176.3647630279725;1183.3728124094243;1185.863625683023;26513;27610.44779104447;28047.158585242476;28444;28569.28576785597;39795.80102099471;40258;40300.1939961205;40307.3953890686;40341.39487907625;300676;301375.3280839895;301497;302444;302847;32910.17724556905;33346.33307333791;33700.49449258214;33703;33754.66245337515;38025.4296185563;39020.6097939017;39046.414303786034;39516.209675805745;40324.1935161301;30676.693233067384;33858.32283354369;33970.490442642884;34052.31895362029;34546.65453345535;33184;33939.49090763591;34193.14517137092;34304.313913722086;35151.64848351484;33799.32401352008;34426.655733443346;34560;34706.652933470345;34818.65181348154;29733.198042258842;31045.04980342788;31159.25052711299;31330;31366.686333137288;23897.52204955926;23923.880380597984;23948.93506415577;24306.27081187567;24403.877980609985 17:17:39 INFO - PROCESS | 6765 | |2;jquery.html;330.64455710111633;344.77761843610887;347.91476088358354;349.17942834339306;371.11489098500067;12431.19197252179;12440.813387799179;13413.19520828751;13448.798268025976;16213.351465941349;12536.310502922335;12726.109172357916;13055.543055993043;16189.514314570582;16370.181490925466;4038.7778672173017;4827.686200396972;4970.826021089245;4993.400791904976;5013.724245166514;4868.659193856432;4947.356843610343;4972.5276098770555;4975.104481193402;4976.3033175355295;4937.888974980637;4938.851834444955;4943.23379876118;4943.332650092228;4947.579455746248;4733.077049975256;4885.389326334208;4908.754562271908;4913.778879950411;4916.213405855046;4402.977985110086;4412.40432541606;4412.514623391425;4424.225760491933;4430.5126436092005;19385;19395.418137455898;19607.411777646692;19652.70520942187;19729.50676233091;1800.3608718904732;1863.2360732099773;1872.662920674278;2243.1251811793413;2316.2124877541546;11937.701557461047;12523.812142817866;12778.744425111445;13113.606591802261;13202.801957970638;1620.6839666265082;1639.7458393948957;1666.6666666666715;1698.7621732957396;1712.7088394972884;64897.3510264896;65063.349366506205;65686.67156664234;65699.3430065698;66040.67918641648;8629.568521573896;8680.218780309677;8895.911040889638;8935.419197752255;9113;11712.004479619158;11785.705357365963;11810.468528916219;11852.585159519547;12165.939170304091;6587.571807832572;6748.358905903931;6795.150606174228;6932.445404367639;6942.132233470817;6519.511036672268;6548.19815347958;6607.240167380716;6719.294474080249;6776.05135281061;5706.514946229534;5721.77112915487;5757.193992841006;5865.560082993792;5935.625749700068;1634.2482458069182;1646.4319809665647;1665.7751203587602;1665.900045997244;1687.4853169783335;808.2160304504621;813.0974618173823;826.2604968553111;875.2210532625968;898.883145191121;16168.676626467404;16805.15974201285;16906.577335566464;17080.829191708173;17108.144592770313;823.8846561481397;839.8530257204965;846.2045677063663;860.1785295043219;898.573177740568;9203.585838637277;9505.287103467268;9680.806383872283;9779.26655500826;9934.15559677421;271491;273866;275074;343006;356139;69376.30623693799;73751.78102737157;77663;78806.6059669698;80536.59731701305;864.8962124544969;870.5168631409501;909.508865212791;911.6854685133618;913.4656226107669;15060.698786023999;15170.524695214717;15574.922125389301;15808.367665293259;16049.277782499583;33324.50013249851;34614.30771384609;36516.81741591275;36929;37746.245075098894;48787;49568.75215624043;50573.49426505688;50771;52988;6968.581885086911;7022.43820494349;7167.569945803269;7272.818179545554;7689.077310722749;11012.119030477703;11256.493457794582;11263.155263355116;11368.54525818958;11531.538738450368;9237.491937943478;9482.668106616235;9673.467959262309;9750.60997560118;9944.30389872702;9799.559019844266;10326.845097323696;10330.690079297634;10348.689539313833;10625.734356641145;9805.382111951449;10117.29178957466;10172.694819155437;10436.99237630194;10770.461476925966;7011.228764835762;7110.217876033736;7193.244709305448;7234.96382518084;7302.415806735555;8804;9666.516674166403;10109.292349535463;10125.848112278174;10279.794404112026 17:17:39 INFO - PROCESS | 6765 | |3;mootools.html;1222.7615614955075;1317.4861803896476;1367.8495365509793;1392.9094608850423;1592.4665237145555;6146.078088286754;6565.212174539056;6753.561018533792;6754.054432379458;6927.688254028568;6767;6805.761798337059;6813.012113243577;6830.146231721035;6832.48756343275;1754.0528114817982;1811.601447681508;1970.044528403723;1991.760988681353;2006.9297574584893;2025.473376921996;2064.5354795171115;2071.0680193912726;2078.3453212238173;2085.4369320283513;1992.790756970519;2008.548076682742;2015.9798402016013;2020.2525065725702;2023.5143565544238;2020.5857799151138;2045.2228153301799;2045.4170561389933;2045.8056484633937;2050.610384027045;2006.8795872247713;2009.7688765791975;2022.916396112007;2023.7369142011444;2025.463252238158;6958.199807022206;7041.155061392615;7142.178649455327;7152.320529549685;7202.855942881113;3990.960090399117;4094.877153685364;4112.424260603518;4113.321301985169;4115;2542.4915016996674;2742.643456350662;2774.153883065664;2787.986060069707;2796.482650709605;817.6279792694369;858.51064893011;864.7016779211162;890.7194233816392;907.5280853955906;8406.537640429835;8476.321894248445;8501.532415717133;8533.701320453816;8553.828923421559;3571.160777217352;3636.745427820027;3701.4632878232505;3714.1086139326367;3823.9617603824163;7969.760907172794;8034.15641357649;8035.678572857137;8038.919610803934;8043.436959412785;4224.281872081753;4234.724742891703;4237.025484138604;4237.788110594458;4240.512341080754;3425.1094715373683;3531.52324436203;3737.177820879402;3846.8461261549783;3856.402257650069;3212.3414699986447;3255.5930508686415;3370.292238629915;3379.121428428626;3385.23832137767;1036.7874585709912;1051.3271506236015;1053.1416895230363;1055.9102476289447;1064.6114168328504;729.5586170366852;758.7913323835879;769.97690069298;777.7550071727501;801.983960320802;4585.380973568593;4628.583427491542;4636.814527418933;4906.656534042654;5018.372703412074;808.3937047214589;819.8237378963552;821.4742564758559;824.5671022713003;827.1563005734117;3193.5848339716154;3249.8212598306845;3250.4799232122746;3271.9672803272138;3330.6502817203846;7888.64501097452;8215.917840821634;8238.752837414888;8238.876416853753;8245;8217.671293148207;8226.341892648574;8227.259546640831;8228.50628962264;8229.95885020571;6212.9068063979075;6491.545591808623;6497.057926600616;6497.772577959749;6635.568688035262;4937.728424936663;4946;4983.227599722049;5027.371578552681;5194.740262986911;7683.385329173541;7772.417068719982;7799.571023593757;7853.410994175346;7869.567173805495;7791.961040194763;7872.921270787448;7944.967154270139;7991.120976692443;7996.520208787491;5054.747262636927;5176.145935920682;5661.405552416937;5813.883722325445;5878.3239927408895;6364.204474440695;6662.06731057662;6692.732290708317;6799.218089919723;6807.5575087619145;6017.187679663364;6025.66858822769;6040.486558642565;6139.956207444656;6159.476444502267;5970.552208584287;6070.271567411939;6076.361981992004;6079.179310792986;6090.969545152246;5591.860203494945;5679.574031947703;5696.743646535833;5698.6010979232715;5701.4298570142655;4080.224757296223;4110.321796903597;4225.323948168279;4236.957630423656;4250.574942505848;4279.186954478639;4286.399904013379;4287.7841618785915;4289.5495972923645;4472.127935052764 17:17:39 INFO - PROCESS | 6765 | |4;prototype.html;280.38455589979975;286.6402664655857;289.905780621298;291.17016502966544;293.30925670047054;4600.8389706360285;4819.831305904289;4827.71033737976;4838.225883858583;4879.804807807684;4624.306354046895;4711.222648263032;4724.433068031833;4781.235002399617;4789.568938795508;3756.812159392033;3766.2090960898245;3768.246350729851;3776.565694945089;3798.3922572388424;3556.9644303556893;3779.4708740776177;3789.109559253573;3790.4882840816413;3801.733878628497;3509.631488693689;3675.246574452231;3701.518802555664;3711.350513660112;3743.4010558310674;3721.088333358331;3721.5534135903863;3728.0866187783895;3730.813459327023;3740.3828368319196;3278.8852390166467;3285.0637568292923;3290.276139249361;3309.9172520686934;3317.4360358739073;4563.475200351969;4637.628989680851;4648.837290694843;4669.182892993713;4686.36734040907;4225.4365884622885;4232.661387089025;4234.428352172448;4243.533211346749;4253.829846806124;4936.802527898915;4951.084049450863;4961.776720047606;4962.4045114586115;5007.399112106534;3518.1380561762276;3561.6972557332397;3572.7856328620364;3587.587427445851;3601.94597081044;5173.551405606437;5175.948240517622;5221.190715439113;5225.294585230983;5243.295928823148;3628.838771593065;3633.1462106404974;3636.072801435617;3656.305301992613;3659.14010207601;3723.3670276053135;3724.2923844469465;3736.178040831013;3747.887563373103;3751.9249615007548;4072.6538244248977;4200.3699445082875;4208.137331846964;4244.808983595745;4256.489221293465;4924.365464476559;4937.987712518925;4946;4982.975085124551;4993.626752642979;1195.338479513477;1225.546547777328;1230.9630711078682;1236.6970092327438;1244.3840299052026;858.5449711652834;864.7838040489878;879.5734068976541;888.493558671551;888.9022207557164;4238.660907127422;4246.384274280212;4250.404943307939;4251.744895306291;4327;4915.549912775668;4969;4979.912454278298;5005.224190250517;5043.621728370387;4058.495312368717;4200.6219440250525;4222.4299719538085;4251.404803327537;4295.291276939332;2625.9496201519164;2628.303499572615;2633.9473210536066;2638.1953504181024;2638.3272265572155;4581.9690569622235;4619.630429565626;4637.559431853969;4652.976735116303;4670.252759558454;4874.756936981118;5015.924761128586;5053.823116190915;5067.6452648315;5075.822346217865;4611.239145540948;4622.491525932145;4630.32860235264;4634.976825115853;4638.582527572467;4924.310596516419;4945.579625731709;4946.752662366939;4964.900701985868;4977.183328085295;4710.7281034119915;4825.4933232011535;4859.829905953275;4867.683600565952;4875.829345972874;4593.678442509126;4645.558671926162;4656.4412270527755;4664.277037059262;4678.976605116953;3543.645635436436;3559.074640593516;3560.3947328953623;3574.57105147384;3580.928381432409;4820.457453614809;4909.4354149273295;4932.630052745986;4978.153713868579;4980.825671101494;4769.594584460221;4774.785134669018;4785.688930219525;4794.2089555223;4808.519148085164;4791.688540244873;4803.711777293373;4817.494163112823;4819.3252944588485;4837.548735379442;4530.841420550265;4727.692699974491;4729.17239483096;4747.833825816218;4752.740523761275;4824.383831416374;4831.299461577981;4860.295257187618;4872.878178045577;4877.95122048775;4714.481407045154;4721.339012538178;4728.62171026324;4777.617790576676;4786.736729479772 17:17:39 INFO - PROCESS | 6765 | |5;yui.html;600.3306313460492;603.592575011867;614.3702704727654;659.8288038731251;676.8510927595927;12145.75708485831;12663.810042849365;12714.364281785896;12722.809157862639;13010.414531346089;12455.68860778481;12556.977209116358;12746.68133296668;12759.808602870964;12785.552505662303;746.3432179681872;764.1708746010585;764.2548515197666;764.4763337114094;764.5221736414741;612.6691586543261;633.7243299164878;729.9343059124677;766.3218052023943;770.118214644232;811.2414892075899;823.7775800533852;824.3405275779382;825.859603867344;827.5903427803246;813.0812182234097;813.9104698483162;814.1817473439215;814.6130587970725;814.9062857771373;477.27930824455325;486.5839707050492;564.497597138547;599.5263741644096;599.9910001349983;11789.88210117905;12447;12460.252384856938;12477.937610311981;12483;11730.17888747788;11831.290122592673;12127.02983761297;12355.938220308932;12390.690232744164;10614.363138211733;10948.288361256493;11003.889961100367;11105.777884442266;11291.604793832259;3942.2903877302074;3979.602039796026;3989.7606143631474;3990.1620659661507;4021.095253567924;71449.28550714531;72183.27816721817;73349.63325183393;73473.6326318365;73506;9253.907460925304;9257.120573545502;9385.812283754287;9465.66870159541;9541.713748587554;18086.5478363042;18257.269709211483;18282.817171828377;18291;18309.7253541197;6353.618782873043;6440.02872875272;6445;6532.08550802888;6682.064510968468;3407.0630576591634;3494.633063528344;3533.8586456541966;3564;3608.7654302470255;2542.6694529711017;2629.81591288608;2644.656194694677;2649.1257884897936;2649.562822134365;436.9912601747947;438.91002344519296;446.5489855246225;453.64388954670426;458.06326063200834;483.62780561346653;494.53019631349645;505.7117443057422;526.2658591265164;531.171372658646;7107.6446177690905;7168.319009694071;7236;7238.059052323164;7337.266273372727;497.9427365852901;516.9534741873249;521.5983692556711;531.0335189954324;533.0427028633691;3426.5716785401823;3484.9477257841154;3503.8598456061472;3655.5613326401003;3661.7802931824176;69279;69795;71114.28885711076;71259;71690.28309716836;60722.39277607256;60732.696336518035;60971;61542.69228653828;64866;52700.73649631727;55893.7205313979;56608.150877736865;57154;57406.42593574095;6808.251092379934;6895.34494223048;6905.1713794342995;7015.36861682451;7046.964765176142;36334.8183259082;38175.23649526938;38990.220195595364;39364.409533856444;39654;44327.90229123563;48198;50825.49174508208;51853;52718.73640631772;9184.908150918673;9217.216536594464;9255.67605133817;9339.48632825174;9458.952705236705;9942.204623630238;10045.598176072876;10048.397096174253;10113.49432528356;10204.336718113298;9713.320067595483;9762.60949562038;9794.363366381162;9820.852687209555;9884.505774711091;9513.809723805347;9528.333016688764;9682.128608425275;9852.901470985198;9864.5560949756;9562.521873906417;9689.467079310705;9713.660021899199;9742.61029558838;9747.951260243653;8314.777252642178;8496.447730897471;8577.528235947082;8627.654893804178;8656.264217541328;7779.92220077792;8111.594420279081;8156.469829461066;8191;8222.38332125081 17:17:39 INFO - PROCESS | 6765 | __end_tp_report 17:17:39 INFO - PROCESS | 6765 | __start_cc_report 17:17:39 INFO - PROCESS | 6765 | _x_x_mozilla_cycle_collect,1597 17:17:39 INFO - PROCESS | 6765 | __end_cc_report 17:17:39 INFO - PROCESS | 6765 | __startTimestamp1480641459905__endTimestamp 17:17:39 INFO - PROCESS | 6765 | 17:17:39 INFO - PROCESS | 6765 | ------- Summary: start ------- 17:17:39 INFO - PROCESS | 6765 | Number of tests: 6 17:17:39 INFO - PROCESS | 6765 | 17:17:39 INFO - PROCESS | 6765 | [#0] dojo.html Cycles:165 Average:4593.90 Median:4723.27 stddev:479.94 (10.2%) stddev-sans-first:454.37 17:17:39 INFO - PROCESS | 6765 | Values: 2569.1 2594.7 2614.4 2620.9 2631.7 4507.9 4588.1 4604.6 4611.7 4667.0 4582.6 4586.4 4625.0 4673.8 4729.7 4209.9 4239.2 4272.5 4301.7 4344.3 4272.1 4338.4 4343.6 4395.1 4434.3 4200.7 4248.3 4341.4 4397.3 4426.7 4262.6 4268.4 4283.6 4284.1 4286.9 4278.6 4281.2 4282.3 4289.4 4290.5 4628.0 4638.1 4641.3 4646.0 4647.1 4899.1 4934.2 4946.3 4946.7 4996.4 4958.8 4975.9 4976.9 4980.6 5001.7 4521.4 4627.6 4643.4 4643.5 4645.9 5032.1 5034.5 5052.9 5100.4 5110.7 4847.2 4901.5 4910.5 4945.0 4966.8 4976.8 4985.1 4985.5 4985.9 4989.9 4715.4 4734.4 4739.5 4804.6 4966.2 4884.3 4890.4 4895.6 4936.3 4939.2 4210.9 4216.0 4217.8 4252.4 4258.0 3598.0 3626.6 3671.2 3682.0 3736.3 4230.5 4245.5 4276.3 4276.4 4331.7 4976.3 5011.6 5020.1 5023.4 5023.5 4237.2 4248.9 4253.1 4254.1 4288.9 4361.6 4393.2 4430.5 4479.9 4482.3 4608.1 4640.6 4652.6 4659.2 4660.5 4971.9 4978.5 4985.4 4990.8 5017.8 4712.0 4747.9 4750.1 4753.4 4753.9 4955.6 4962.1 4965.9 4965.9 5013.6 4850.7 4984.1 5036.7 5039.2 5090.3 4788.6 4797.3 4802.8 4802.9 4804.5 4773.5 4781.7 4785.0 4790.2 4792.4 4682.0 4723.3 4788.9 4813.4 4839.6 4964.3 4964.9 4966.9 4970.3 5004.6 4836.4 4841.4 4843.6 4875.7 4888.6 17:17:39 INFO - PROCESS | 6765 | 17:17:39 INFO - PROCESS | 6765 | [#1] ext.html Cycles:180 Average:44259.08 Median:3460.70 stddev:77128.28 (2228.7%) stddev-sans-first:77274.84 17:17:39 INFO - PROCESS | 6765 | Values: 556.2 568.2 572.7 573.5 586.1 27191.6 37580.6 38857.4 38884.6 42477.6 38736.2 39034.2 39137.4 39138.0 39161.6 7523.0 7667.3 7674.6 7680.0 7680.4 7413.0 7635.2 9501.0 9766.4 9789.0 9765.9 9823.3 9828.4 9832.7 9843.4 9754.4 9808.7 9824.9 9835.2 9837.7 9531.3 9589.2 9591.9 9598.3 9603.2 36653.0 37115.8 37164.4 37186.4 37211.3 2913.2 3048.4 3254.3 3353.9 3457.8 27832.4 27833.7 27835.0 28014.2 28020.4 3387.5 3459.9 3461.5 3471.8 3509.0 235770.0 236358.0 236926.0 237033.0 237550.0 47361.3 47646.0 47694.5 47723.5 47779.0 50216.2 50268.7 50310.5 50359.0 50466.5 12916.0 13094.6 13110.1 13119.8 13122.3 8145.6 8315.0 10039.5 10095.7 10101.3 12799.6 12916.4 12957.4 13749.5 14294.6 4911.0 5469.3 5572.5 5687.2 5709.2 800.5 940.1 982.2 995.4 1002.5 26242.0 26255.6 26615.7 27050.0 27051.5 947.4 966.5 972.9 1000.7 1020.2 13940.9 14241.3 14276.1 14520.8 14584.9 334125.0 335304.0 336062.0 336274.0 336402.0 40869.4 41843.8 45481.5 46509.8 46616.0 1141.4 1148.1 1176.4 1183.4 1185.9 26513.0 27610.4 28047.2 28444.0 28569.3 39795.8 40258.0 40300.2 40307.4 40341.4 300676.0 301375.3 301497.0 302444.0 302847.0 32910.2 33346.3 33700.5 33703.0 33754.7 38025.4 39020.6 39046.4 39516.2 40324.2 30676.7 33858.3 33970.5 34052.3 34546.7 33184.0 33939.5 34193.1 34304.3 35151.6 33799.3 34426.7 34560.0 34706.7 34818.7 29733.2 31045.0 31159.3 31330.0 31366.7 23897.5 23923.9 23948.9 24306.3 24403.9 17:17:39 INFO - PROCESS | 6765 | 17:17:39 INFO - PROCESS | 6765 | [#2] jquery.html Cycles:180 Average:21433.52 Median:26836.19 stddev:51190.62 (190.8%) stddev-sans-first:51309.70 17:17:39 INFO - PROCESS | 6765 | Values: 330.6 344.8 347.9 349.2 371.1 12431.2 12440.8 13413.2 13448.8 16213.4 12536.3 12726.1 13055.5 16189.5 16370.2 4038.8 4827.7 4970.8 4993.4 5013.7 4868.7 4947.4 4972.5 4975.1 4976.3 4937.9 4938.9 4943.2 4943.3 4947.6 4733.1 4885.4 4908.8 4913.8 4916.2 4403.0 4412.4 4412.5 4424.2 4430.5 19385.0 19395.4 19607.4 19652.7 19729.5 1800.4 1863.2 1872.7 2243.1 2316.2 11937.7 12523.8 12778.7 13113.6 13202.8 1620.7 1639.7 1666.7 1698.8 1712.7 64897.4 65063.3 65686.7 65699.3 66040.7 8629.6 8680.2 8895.9 8935.4 9113.0 11712.0 11785.7 11810.5 11852.6 12165.9 6587.6 6748.4 6795.2 6932.4 6942.1 6519.5 6548.2 6607.2 6719.3 6776.1 5706.5 5721.8 5757.2 5865.6 5935.6 1634.2 1646.4 1665.8 1665.9 1687.5 808.2 813.1 826.3 875.2 898.9 16168.7 16805.2 16906.6 17080.8 17108.1 823.9 839.9 846.2 860.2 898.6 9203.6 9505.3 9680.8 9779.3 9934.2 271491.0 273866.0 275074.0 343006.0 356139.0 69376.3 73751.8 77663.0 78806.6 80536.6 864.9 870.5 909.5 911.7 913.5 15060.7 15170.5 15574.9 15808.4 16049.3 33324.5 34614.3 36516.8 36929.0 37746.2 48787.0 49568.8 50573.5 50771.0 52988.0 6968.6 7022.4 7167.6 7272.8 7689.1 11012.1 11256.5 11263.2 11368.5 11531.5 9237.5 9482.7 9673.5 9750.6 9944.3 9799.6 10326.8 10330.7 10348.7 10625.7 9805.4 10117.3 10172.7 10437.0 10770.5 7011.2 7110.2 7193.2 7235.0 7302.4 8804.0 9666.5 10109.3 10125.8 10279.8 17:17:39 INFO - PROCESS | 6765 | 17:17:39 INFO - PROCESS | 6765 | [#3] mootools.html Cycles:180 Average:4550.69 Median:5185.44 stddev:2436.46 (47.0%) stddev-sans-first:2430.46 17:17:39 INFO - PROCESS | 6765 | Values: 1222.8 1317.5 1367.8 1392.9 1592.5 6146.1 6565.2 6753.6 6754.1 6927.7 6767.0 6805.8 6813.0 6830.1 6832.5 1754.1 1811.6 1970.0 1991.8 2006.9 2025.5 2064.5 2071.1 2078.3 2085.4 1992.8 2008.5 2016.0 2020.3 2023.5 2020.6 2045.2 2045.4 2045.8 2050.6 2006.9 2009.8 2022.9 2023.7 2025.5 6958.2 7041.2 7142.2 7152.3 7202.9 3991.0 4094.9 4112.4 4113.3 4115.0 2542.5 2742.6 2774.2 2788.0 2796.5 817.6 858.5 864.7 890.7 907.5 8406.5 8476.3 8501.5 8533.7 8553.8 3571.2 3636.7 3701.5 3714.1 3824.0 7969.8 8034.2 8035.7 8038.9 8043.4 4224.3 4234.7 4237.0 4237.8 4240.5 3425.1 3531.5 3737.2 3846.8 3856.4 3212.3 3255.6 3370.3 3379.1 3385.2 1036.8 1051.3 1053.1 1055.9 1064.6 729.6 758.8 770.0 777.8 802.0 4585.4 4628.6 4636.8 4906.7 5018.4 808.4 819.8 821.5 824.6 827.2 3193.6 3249.8 3250.5 3272.0 3330.7 7888.6 8215.9 8238.8 8238.9 8245.0 8217.7 8226.3 8227.3 8228.5 8230.0 6212.9 6491.5 6497.1 6497.8 6635.6 4937.7 4946.0 4983.2 5027.4 5194.7 7683.4 7772.4 7799.6 7853.4 7869.6 7792.0 7872.9 7945.0 7991.1 7996.5 5054.7 5176.1 5661.4 5813.9 5878.3 6364.2 6662.1 6692.7 6799.2 6807.6 6017.2 6025.7 6040.5 6140.0 6159.5 5970.6 6070.3 6076.4 6079.2 6091.0 5591.9 5679.6 5696.7 5698.6 5701.4 4080.2 4110.3 4225.3 4237.0 4250.6 4279.2 4286.4 4287.8 4289.5 4472.1 17:17:39 INFO - PROCESS | 6765 | 17:17:39 INFO - PROCESS | 6765 | [#4] prototype.html Cycles:180 Average:4067.96 Median:4636.27 stddev:1159.88 (25.0%) stddev-sans-first:1127.76 17:17:39 INFO - PROCESS | 6765 | Values: 280.4 286.6 289.9 291.2 293.3 4600.8 4819.8 4827.7 4838.2 4879.8 4624.3 4711.2 4724.4 4781.2 4789.6 3756.8 3766.2 3768.2 3776.6 3798.4 3557.0 3779.5 3789.1 3790.5 3801.7 3509.6 3675.2 3701.5 3711.4 3743.4 3721.1 3721.6 3728.1 3730.8 3740.4 3278.9 3285.1 3290.3 3309.9 3317.4 4563.5 4637.6 4648.8 4669.2 4686.4 4225.4 4232.7 4234.4 4243.5 4253.8 4936.8 4951.1 4961.8 4962.4 5007.4 3518.1 3561.7 3572.8 3587.6 3601.9 5173.6 5175.9 5221.2 5225.3 5243.3 3628.8 3633.1 3636.1 3656.3 3659.1 3723.4 3724.3 3736.2 3747.9 3751.9 4072.7 4200.4 4208.1 4244.8 4256.5 4924.4 4938.0 4946.0 4983.0 4993.6 1195.3 1225.5 1231.0 1236.7 1244.4 858.5 864.8 879.6 888.5 888.9 4238.7 4246.4 4250.4 4251.7 4327.0 4915.5 4969.0 4979.9 5005.2 5043.6 4058.5 4200.6 4222.4 4251.4 4295.3 2625.9 2628.3 2633.9 2638.2 2638.3 4582.0 4619.6 4637.6 4653.0 4670.3 4874.8 5015.9 5053.8 5067.6 5075.8 4611.2 4622.5 4630.3 4635.0 4638.6 4924.3 4945.6 4946.8 4964.9 4977.2 4710.7 4825.5 4859.8 4867.7 4875.8 4593.7 4645.6 4656.4 4664.3 4679.0 3543.6 3559.1 3560.4 3574.6 3580.9 4820.5 4909.4 4932.6 4978.2 4980.8 4769.6 4774.8 4785.7 4794.2 4808.5 4791.7 4803.7 4817.5 4819.3 4837.5 4530.8 4727.7 4729.2 4747.8 4752.7 4824.4 4831.3 4860.3 4872.9 4878.0 4714.5 4721.3 4728.6 4777.6 4786.7 17:17:39 INFO - PROCESS | 6765 | 17:17:39 INFO - PROCESS | 6765 | [#5] yui.html Cycles:180 Average:15078.10 Median:30662.99 stddev:20449.83 (66.7%) stddev-sans-first:20478.31 17:17:39 INFO - PROCESS | 6765 | Values: 600.3 603.6 614.4 659.8 676.9 12145.8 12663.8 12714.4 12722.8 13010.4 12455.7 12557.0 12746.7 12759.8 12785.6 746.3 764.2 764.3 764.5 764.5 612.7 633.7 729.9 766.3 770.1 811.2 823.8 824.3 825.9 827.6 813.1 813.9 814.2 814.6 814.9 477.3 486.6 564.5 599.5 600.0 11789.9 12447.0 12460.3 12477.9 12483.0 11730.2 11831.3 12127.0 12355.9 12390.7 10614.4 10948.3 11003.9 11105.8 11291.6 3942.3 3979.6 3989.8 3990.2 4021.1 71449.3 72183.3 73349.6 73473.6 73506.0 9253.9 9257.1 9385.8 9465.7 9541.7 18086.5 18257.3 18282.8 18291.0 18309.7 6353.6 6440.0 6445.0 6532.1 6682.1 3407.1 3494.6 3533.9 3564.0 3608.8 2542.7 2629.8 2644.7 2649.1 2649.6 437.0 438.9 446.5 453.6 458.1 483.6 494.5 505.7 526.3 531.2 7107.6 7168.3 7236.0 7238.1 7337.3 497.9 517.0 521.6 531.0 533.0 3426.6 3484.9 3503.9 3655.6 3661.8 69279.0 69795.0 71114.3 71259.0 71690.3 60722.4 60732.7 60971.0 61542.7 64866.0 52700.7 55893.7 56608.2 57154.0 57406.4 6808.3 6895.3 6905.2 7015.4 7047.0 36334.8 38175.2 38990.2 39364.4 39654.0 44327.9 48198.0 50825.5 51853.0 52718.7 9184.9 9217.2 9255.7 9339.5 9459.0 9942.2 10045.6 10048.4 10113.5 10204.3 9713.3 9762.6 9794.4 9820.9 9884.5 9513.8 9528.3 9682.1 9852.9 9864.6 9562.5 9689.5 9713.7 9742.6 9748.0 8314.8 8496.4 8577.5 8627.7 8656.3 7779.9 8111.6 8156.5 8191.0 8222.4 17:17:39 INFO - PROCESS | 6765 | -------- Summary: end -------- 17:17:39 INFO - PROCESS | 6765 | 17:17:40 INFO - TEST-INFO | 6765: exit 0 17:17:40 INFO - TEST-OK | dromaeo_css | took 1121715ms 17:17:40 INFO - TEST-START | kraken 17:17:40 INFO - operating with platform_type : linux_ 17:17:40 INFO - Initialising browser for kraken test... 17:17:40 INFO - TEST-INFO | started process 7074 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCznCHm/profile http://localhost:50001/getInfo.html) 17:17:44 INFO - PROCESS | 7074 | __metrics Screen width/height:1600/1200 17:17:44 INFO - PROCESS | 7074 | colorDepth:24 17:17:44 INFO - PROCESS | 7074 | Browser inner width/height: 1024/697 17:17:44 INFO - PROCESS | 7074 | __metrics 17:17:45 INFO - PROCESS | 7074 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:17:45 INFO - PROCESS | 7074 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:17:46 INFO - TEST-INFO | 7074: exit 0 17:17:46 INFO - Browser initialized. 17:17:46 INFO - Running cycle 1/1 for kraken test... 17:17:46 INFO - TEST-INFO | started process 7157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCznCHm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:17:58 INFO - PROCESS | 7157 | RSS: Main: 174903296 17:17:58 INFO - PROCESS | 7157 | 17:18:01 INFO - PROCESS | 7157 | Cycle 1(1): loaded http://localhost:50001/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50001/tests/kraken/driver.html?testName=audio-beat-detection) 17:18:02 INFO - PROCESS | 7157 | RSS: Main: 240742400 17:18:02 INFO - PROCESS | 7157 | 17:18:05 INFO - PROCESS | 7157 | Cycle 1(1): loaded http://localhost:50001/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50001/tests/kraken/driver.html?testName=audio-dft) 17:18:05 INFO - PROCESS | 7157 | RSS: Main: 218689536 17:18:05 INFO - PROCESS | 7157 | 17:18:08 INFO - PROCESS | 7157 | Cycle 1(1): loaded http://localhost:50001/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50001/tests/kraken/driver.html?testName=audio-fft) 17:18:09 INFO - PROCESS | 7157 | RSS: Main: 300564480 17:18:09 INFO - PROCESS | 7157 | 17:18:11 INFO - PROCESS | 7157 | Cycle 1(1): loaded http://localhost:50001/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50001/tests/kraken/driver.html?testName=audio-oscillator) 17:18:12 INFO - PROCESS | 7157 | RSS: Main: 211034112 17:18:12 INFO - PROCESS | 7157 | 17:18:14 INFO - PROCESS | 7157 | Cycle 1(1): loaded http://localhost:50001/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50001/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:18:15 INFO - PROCESS | 7157 | RSS: Main: 215023616 17:18:15 INFO - PROCESS | 7157 | 17:18:18 INFO - PROCESS | 7157 | Cycle 1(1): loaded http://localhost:50001/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50001/tests/kraken/driver.html?testName=imaging-darkroom) 17:18:19 INFO - PROCESS | 7157 | RSS: Main: 254107648 17:18:19 INFO - PROCESS | 7157 | 17:18:22 INFO - PROCESS | 7157 | Cycle 1(1): loaded http://localhost:50001/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50001/tests/kraken/driver.html?testName=imaging-desaturate) 17:18:23 INFO - PROCESS | 7157 | RSS: Main: 248205312 17:18:23 INFO - PROCESS | 7157 | 17:18:26 INFO - PROCESS | 7157 | Cycle 1(1): loaded http://localhost:50001/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50001/tests/kraken/driver.html?testName=json-parse-financial) 17:18:26 INFO - PROCESS | 7157 | RSS: Main: 250494976 17:18:26 INFO - PROCESS | 7157 | 17:18:28 INFO - PROCESS | 7157 | Cycle 1(1): loaded http://localhost:50001/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50001/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:18:29 INFO - PROCESS | 7157 | RSS: Main: 213516288 17:18:29 INFO - PROCESS | 7157 | 17:18:30 INFO - PROCESS | 7157 | Cycle 1(1): loaded http://localhost:50001/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50001/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:18:31 INFO - PROCESS | 7157 | RSS: Main: 221069312 17:18:31 INFO - PROCESS | 7157 | 17:18:33 INFO - PROCESS | 7157 | Cycle 1(1): loaded http://localhost:50001/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50001/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:18:34 INFO - PROCESS | 7157 | RSS: Main: 229715968 17:18:34 INFO - PROCESS | 7157 | 17:18:37 INFO - PROCESS | 7157 | Cycle 1(1): loaded http://localhost:50001/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:18:38 INFO - PROCESS | 7157 | RSS: Main: 238370816 17:18:38 INFO - PROCESS | 7157 | 17:18:41 INFO - PROCESS | 7157 | Cycle 1(1): loaded http://localhost:50001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:18:41 INFO - PROCESS | 7157 | RSS: Main: 235106304 17:18:41 INFO - PROCESS | 7157 | 17:18:43 INFO - PROCESS | 7157 | Cycle 1(1): loaded http://localhost:50001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50001/tests/kraken/driver.html?testName=ai-astar) 17:18:43 INFO - PROCESS | 7157 | RSS: Main: 286314496 17:18:43 INFO - PROCESS | 7157 | 17:18:43 INFO - PROCESS | 7157 | __start_tp_report 17:18:43 INFO - PROCESS | 7157 | _x_x_mozilla_page_load 17:18:43 INFO - PROCESS | 7157 | _x_x_mozilla_page_load_details 17:18:43 INFO - PROCESS | 7157 | |i|pagename|runs| 17:18:43 INFO - PROCESS | 7157 | |0;ai-astar;108;118;118;118;118;118;118;116;118;117 17:18:43 INFO - PROCESS | 7157 | |1;audio-beat-detection;154;132;130;166;130;133;133;132;152;133 17:18:43 INFO - PROCESS | 7157 | |2;audio-dft;161;161;162;162;163;162;160;162;162;161 17:18:43 INFO - PROCESS | 7157 | |3;audio-fft;77;77;79;110;78;78;77;78;106;77 17:18:43 INFO - PROCESS | 7157 | |4;audio-oscillator;84;89;102;84;84;83;99;83;84;105 17:18:43 INFO - PROCESS | 7157 | |5;imaging-gaussian-blur;118;118;118;118;118;118;119;117;117;117 17:18:43 INFO - PROCESS | 7157 | |6;imaging-darkroom;146;146;147;147;147;147;146;147;147;146 17:18:43 INFO - PROCESS | 7157 | |7;imaging-desaturate;95;95;95;95;95;95;96;96;96;94 17:18:43 INFO - PROCESS | 7157 | |8;json-parse-financial;64;64;63;64;65;64;63;65;67;65 17:18:43 INFO - PROCESS | 7157 | |9;json-stringify-tinderbox;66;66;66;66;67;67;68;67;67;67 17:18:43 INFO - PROCESS | 7157 | |10;stanford-crypto-aes;86;96;85;85;85;93;85;86;91;94 17:18:43 INFO - PROCESS | 7157 | |11;stanford-crypto-ccm;145;150;146;153;139;146;145;150;197;142 17:18:43 INFO - PROCESS | 7157 | |12;stanford-crypto-pbkdf2;186;186;186;186;181;185;181;181;182;181 17:18:43 INFO - PROCESS | 7157 | |13;stanford-crypto-sha256-iterative;74;76;76;74;71;71;72;76;74;71 17:18:43 INFO - PROCESS | 7157 | __end_tp_report 17:18:43 INFO - PROCESS | 7157 | __start_cc_report 17:18:43 INFO - PROCESS | 7157 | _x_x_mozilla_cycle_collect,1984 17:18:43 INFO - PROCESS | 7157 | __end_cc_report 17:18:43 INFO - PROCESS | 7157 | __startTimestamp1480641523890__endTimestamp 17:18:43 INFO - PROCESS | 7157 | 17:18:43 INFO - PROCESS | 7157 | ------- Summary: start ------- 17:18:43 INFO - PROCESS | 7157 | Number of tests: 14 17:18:43 INFO - PROCESS | 7157 | 17:18:43 INFO - PROCESS | 7157 | [#0] ai-astar Cycles:10 Average:116.70 Median:118.00 stddev:3.13 (2.7%) stddev-sans-first:0.71 17:18:43 INFO - PROCESS | 7157 | Values: 108.0 118.0 118.0 118.0 118.0 118.0 118.0 116.0 118.0 117.0 17:18:43 INFO - PROCESS | 7157 | 17:18:43 INFO - PROCESS | 7157 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:133.00 stddev:12.86 (9.7%) stddev-sans-first:12.52 17:18:43 INFO - PROCESS | 7157 | Values: 154.0 132.0 130.0 166.0 130.0 133.0 133.0 132.0 152.0 133.0 17:18:43 INFO - PROCESS | 7157 | 17:18:43 INFO - PROCESS | 7157 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 17:18:43 INFO - PROCESS | 7157 | Values: 161.0 161.0 162.0 162.0 163.0 162.0 160.0 162.0 162.0 161.0 17:18:43 INFO - PROCESS | 7157 | 17:18:43 INFO - PROCESS | 7157 | [#3] audio-fft Cycles:10 Average:83.70 Median:77.50 stddev:12.86 (16.6%) stddev-sans-first:13.41 17:18:43 INFO - PROCESS | 7157 | Values: 77.0 77.0 79.0 110.0 78.0 78.0 77.0 78.0 106.0 77.0 17:18:43 INFO - PROCESS | 7157 | 17:18:43 INFO - PROCESS | 7157 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:84.00 stddev:8.77 (10.4%) stddev-sans-first:9.06 17:18:43 INFO - PROCESS | 7157 | Values: 84.0 89.0 102.0 84.0 84.0 83.0 99.0 83.0 84.0 105.0 17:18:43 INFO - PROCESS | 7157 | 17:18:43 INFO - PROCESS | 7157 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 17:18:43 INFO - PROCESS | 7157 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 119.0 117.0 117.0 117.0 17:18:43 INFO - PROCESS | 7157 | 17:18:43 INFO - PROCESS | 7157 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 17:18:43 INFO - PROCESS | 7157 | Values: 146.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 146.0 17:18:43 INFO - PROCESS | 7157 | 17:18:43 INFO - PROCESS | 7157 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 17:18:43 INFO - PROCESS | 7157 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 94.0 17:18:43 INFO - PROCESS | 7157 | 17:18:43 INFO - PROCESS | 7157 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.50 stddev:1.17 (1.8%) stddev-sans-first:1.24 17:18:43 INFO - PROCESS | 7157 | Values: 64.0 64.0 63.0 64.0 65.0 64.0 63.0 65.0 67.0 65.0 17:18:43 INFO - PROCESS | 7157 | 17:18:43 INFO - PROCESS | 7157 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 17:18:43 INFO - PROCESS | 7157 | Values: 66.0 66.0 66.0 66.0 67.0 67.0 68.0 67.0 67.0 67.0 17:18:43 INFO - PROCESS | 7157 | 17:18:43 INFO - PROCESS | 7157 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:88.50 stddev:4.40 (5.0%) stddev-sans-first:4.57 17:18:43 INFO - PROCESS | 7157 | Values: 86.0 96.0 85.0 85.0 85.0 93.0 85.0 86.0 91.0 94.0 17:18:43 INFO - PROCESS | 7157 | 17:18:43 INFO - PROCESS | 7157 | [#11] stanford-crypto-ccm Cycles:10 Average:151.30 Median:148.00 stddev:16.56 (11.2%) stddev-sans-first:17.41 17:18:43 INFO - PROCESS | 7157 | Values: 145.0 150.0 146.0 153.0 139.0 146.0 145.0 150.0 197.0 142.0 17:18:43 INFO - PROCESS | 7157 | 17:18:43 INFO - PROCESS | 7157 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.50 Median:185.50 stddev:2.46 (1.3%) stddev-sans-first:2.44 17:18:43 INFO - PROCESS | 7157 | Values: 186.0 186.0 186.0 186.0 181.0 185.0 181.0 181.0 182.0 181.0 17:18:43 INFO - PROCESS | 7157 | 17:18:43 INFO - PROCESS | 7157 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:74.00 stddev:2.12 (2.9%) stddev-sans-first:2.24 17:18:43 INFO - PROCESS | 7157 | Values: 74.0 76.0 76.0 74.0 71.0 71.0 72.0 76.0 74.0 71.0 17:18:43 INFO - PROCESS | 7157 | -------- Summary: end -------- 17:18:43 INFO - PROCESS | 7157 | 17:18:45 INFO - TEST-INFO | 7157: exit 0 17:18:45 INFO - TEST-OK | kraken | took 64293ms 17:18:45 INFO - SUITE-END | took 1186s 17:18:45 INFO - Completed test suite (00:19:46) 17:18:45 INFO - javascript benchmark 17:18:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2569.1008147148495, 2594.6886373635166, 2614.4248265381616, 2620.92137235883, 2631.710511843698, 4507.90984180317, 4588.105319462706, 4604.608608268297, 4611.746353950532, 4666.976665116674, 4582.564656357641, 4586.4266966629175, 4624.976875115628, 4673.813047478096, 4729.668923175371, 4209.936850947238, 4239.236937351276, 4272.487301523822, 4301.741895486265, 4344.304911214206, 4272.124214536013, 4338.370936214247, 4343.630791382736, 4395.142947125312, 4434.268345722968, 4200.747955122672, 4248.299030659938, 4341.41390912226, 4397.274449715825, 4426.690131690783, 4262.573742625744, 4268.359746038088, 4283.571642835723, 4284.121755040209, 4286.914261714748, 4278.593533614302, 4281.186574550826, 4282.293421585435, 4289.399484072233, 4290.506591741959, 4627.976860115711, 4638.072385522909, 4641.280601506772, 4646.0, 4647.070585882803, 4899.1426500362295, 4934.185859333205, 4946.307516947631, 4946.72792996385, 4996.400431948153, 4958.801647934079, 4975.850724478271, 4976.925346119811, 4980.551750342486, 5001.7499125043605, 4521.389612402284, 4627.6066534344955, 4643.442786865564, 4643.512431194744, 4645.9303110453375, 5032.0690672225755, 5034.546890779848, 5052.873678158076, 5100.38795344561, 5110.744462776846, 4847.151748444008, 4901.509849015141, 4910.533499317559, 4945.010997800454, 4966.776495057658, 4976.776045077981, 4985.102681517289, 4985.476524964899, 4985.850424487271, 4989.900201996013, 4715.363425937455, 4734.384530011076, 4739.526047395233, 4804.591609713144, 4966.205407134913, 4884.340614017062, 4890.413150421901, 4895.583875370633, 4936.333594964705, 4939.160342741742, 4210.894727631834, 4216.030313027959, 4217.810198541073, 4252.4471818664, 4257.957420425818, 3598.0, 3626.6192049834917, 3671.173985853215, 3682.0, 3736.3461394255896, 4230.450041494586, 4245.469316335458, 4276.294411422143, 4276.401303817468, 4331.6534677225745, 4976.328195693607, 5011.599072074226, 5020.146575082172, 5023.372078490189, 5023.547880690682, 4237.216115018731, 4248.915021699549, 4253.128108737701, 4254.127903779718, 4288.935665965013, 4361.629261512807, 4393.165298593257, 4430.490493593214, 4479.865604031885, 4482.327650852399, 4608.147492713859, 4640.605548528413, 4652.604528615106, 4659.2079346511855, 4660.533946605312, 4971.850844474671, 4978.47725988766, 4985.351904252424, 4990.775415106402, 5017.774200160929, 4711.976440117777, 4747.8575642730775, 4750.097481478508, 4753.429588449409, 4753.881152971203, 4955.628327875352, 4962.082014827269, 4965.900681986413, 4965.925511117264, 5013.598912086952, 4850.684705494132, 4984.127777638826, 5036.748162591929, 5039.21892106724, 5090.312807771052, 4788.592969597623, 4797.280407938837, 4802.807887684454, 4802.903941921212, 4804.5195480451675, 4773.522647735337, 4781.665283430127, 4784.952150478451, 4790.233562629963, 4792.400949881265, 4682.023784561047, 4723.267893476516, 4788.928166077581, 4813.387515182453, 4839.564439200489, 4964.255361695775, 4964.875878102932, 4966.925496117489, 4970.254461830755, 5004.574611158092, 4836.419629644465, 4841.443234028132, 4843.588294994965, 4875.658703890694, 4888.560029597211], "value": 4563.354550075226, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.151868400689, 568.2385603291589, 572.6535446055137, 573.5297056413742, 586.1003359842642, 27191.5921261181, 37580.624193758056, 38857.417138742945, 38884.61115388845, 42477.57522424783, 38736.22527549447, 39034.219315613744, 39137.41293880594, 39138.0, 39161.60838391615, 7522.962385188066, 7667.309942105209, 7674.616269186547, 7680.039995000625, 7680.385569154454, 7412.962935185316, 7635.160132385433, 9501.0, 9766.414015159078, 9789.0, 9765.853512197322, 9823.263255255848, 9828.361156524803, 9832.655857045005, 9843.360181588174, 9754.365966212208, 9808.656697015642, 9824.90175098254, 9835.213182945346, 9837.655682051165, 9531.285153613506, 9589.232861371074, 9591.904080959172, 9598.280128990353, 9603.231741460666, 36653.0, 37115.81442092799, 37164.44253336175, 37186.44220336697, 37211.25577488462, 2913.1988703106817, 3048.420800047984, 3254.300325430044, 3353.899383018513, 3457.8271086445575, 27832.443351133068, 27833.721662783315, 27835.02577409781, 28014.159575212776, 28020.43959120806, 3387.458006718913, 3459.892834293027, 3461.5153878457036, 3471.7916924984584, 3509.0, 235770.0, 236358.0, 236926.0, 237033.0, 237550.0, 47361.28958065632, 47646.0, 47694.52305476901, 47723.52276477191, 47779.0, 50216.246756298686, 50268.74865625649, 50310.49689503131, 50359.0, 50466.49533504618, 12916.0, 13094.607161785161, 13110.147840390344, 13119.803202951773, 13122.34388280582, 8145.5927203639585, 8314.958425207835, 10039.548220330104, 10095.7476063099, 10101.292909496266, 12799.616011519669, 12916.41876115577, 12957.416916238792, 13749.518766843112, 14294.571162865132, 4911.028827559347, 5469.343678758574, 5572.498475137257, 5687.208529313253, 5709.200711900337, 800.4596897094555, 940.1068984464649, 982.219135787051, 995.3679413572289, 1002.5288114586133, 26242.0, 26255.606165907528, 26615.733842661324, 27050.0, 27051.458970820866, 947.4173383369179, 966.5119114847098, 972.8576697267864, 1000.6747806962766, 1020.2348238820884, 13940.86059139416, 14241.287935603179, 14276.14343139415, 14520.782188267185, 14584.927075364556, 334125.0, 335304.0, 336062.0, 336274.0, 336402.0, 40869.38695919564, 41843.7907810459, 45481.49851758185, 46509.76745116253, 46616.0, 1141.4349896801302, 1148.0700632487712, 1176.3647630279725, 1183.3728124094243, 1185.863625683023, 26513.0, 27610.44779104447, 28047.158585242476, 28444.0, 28569.28576785597, 39795.80102099471, 40258.0, 40300.1939961205, 40307.3953890686, 40341.39487907625, 300676.0, 301375.3280839895, 301497.0, 302444.0, 302847.0, 32910.17724556905, 33346.33307333791, 33700.49449258214, 33703.0, 33754.66245337515, 38025.4296185563, 39020.6097939017, 39046.414303786034, 39516.209675805745, 40324.1935161301, 30676.693233067384, 33858.32283354369, 33970.490442642884, 34052.31895362029, 34546.65453345535, 33184.0, 33939.49090763591, 34193.14517137092, 34304.313913722086, 35151.64848351484, 33799.32401352008, 34426.655733443346, 34560.0, 34706.652933470345, 34818.65181348154, 29733.198042258842, 31045.04980342788, 31159.25052711299, 31330.0, 31366.686333137288, 23897.52204955926, 23923.880380597984, 23948.93506415577, 24306.27081187567, 24403.877980609985], "value": 17088.158385621515, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.64455710111633, 344.77761843610887, 347.91476088358354, 349.17942834339306, 371.11489098500067, 12431.19197252179, 12440.813387799179, 13413.19520828751, 13448.798268025976, 16213.351465941349, 12536.310502922335, 12726.109172357916, 13055.543055993043, 16189.514314570582, 16370.181490925466, 4038.7778672173017, 4827.686200396972, 4970.826021089245, 4993.400791904976, 5013.724245166514, 4868.659193856432, 4947.356843610343, 4972.5276098770555, 4975.104481193402, 4976.3033175355295, 4937.888974980637, 4938.851834444955, 4943.23379876118, 4943.332650092228, 4947.579455746248, 4733.077049975256, 4885.389326334208, 4908.754562271908, 4913.778879950411, 4916.213405855046, 4402.977985110086, 4412.40432541606, 4412.514623391425, 4424.225760491933, 4430.5126436092005, 19385.0, 19395.418137455898, 19607.411777646692, 19652.70520942187, 19729.50676233091, 1800.3608718904732, 1863.2360732099773, 1872.662920674278, 2243.1251811793413, 2316.2124877541546, 11937.701557461047, 12523.812142817866, 12778.744425111445, 13113.606591802261, 13202.801957970638, 1620.6839666265082, 1639.7458393948957, 1666.6666666666715, 1698.7621732957396, 1712.7088394972884, 64897.3510264896, 65063.349366506205, 65686.67156664234, 65699.3430065698, 66040.67918641648, 8629.568521573896, 8680.218780309677, 8895.911040889638, 8935.419197752255, 9113.0, 11712.004479619158, 11785.705357365963, 11810.468528916219, 11852.585159519547, 12165.939170304091, 6587.571807832572, 6748.358905903931, 6795.150606174228, 6932.445404367639, 6942.132233470817, 6519.511036672268, 6548.19815347958, 6607.240167380716, 6719.294474080249, 6776.05135281061, 5706.514946229534, 5721.77112915487, 5757.193992841006, 5865.560082993792, 5935.625749700068, 1634.2482458069182, 1646.4319809665647, 1665.7751203587602, 1665.900045997244, 1687.4853169783335, 808.2160304504621, 813.0974618173823, 826.2604968553111, 875.2210532625968, 898.883145191121, 16168.676626467404, 16805.15974201285, 16906.577335566464, 17080.829191708173, 17108.144592770313, 823.8846561481397, 839.8530257204965, 846.2045677063663, 860.1785295043219, 898.573177740568, 9203.585838637277, 9505.287103467268, 9680.806383872283, 9779.26655500826, 9934.15559677421, 271491.0, 273866.0, 275074.0, 343006.0, 356139.0, 69376.30623693799, 73751.78102737157, 77663.0, 78806.6059669698, 80536.59731701305, 864.8962124544969, 870.5168631409501, 909.508865212791, 911.6854685133618, 913.4656226107669, 15060.698786023999, 15170.524695214717, 15574.922125389301, 15808.367665293259, 16049.277782499583, 33324.50013249851, 34614.30771384609, 36516.81741591275, 36929.0, 37746.245075098894, 48787.0, 49568.75215624043, 50573.49426505688, 50771.0, 52988.0, 6968.581885086911, 7022.43820494349, 7167.569945803269, 7272.818179545554, 7689.077310722749, 11012.119030477703, 11256.493457794582, 11263.155263355116, 11368.54525818958, 11531.538738450368, 9237.491937943478, 9482.668106616235, 9673.467959262309, 9750.60997560118, 9944.30389872702, 9799.559019844266, 10326.845097323696, 10330.690079297634, 10348.689539313833, 10625.734356641145, 9805.382111951449, 10117.29178957466, 10172.694819155437, 10436.99237630194, 10770.461476925966, 7011.228764835762, 7110.217876033736, 7193.244709305448, 7234.96382518084, 7302.415806735555, 8804.0, 9666.516674166403, 10109.292349535463, 10125.848112278174, 10279.794404112026], "value": 7853.678208746944, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1222.7615614955075, 1317.4861803896476, 1367.8495365509793, 1392.9094608850423, 1592.4665237145555, 6146.078088286754, 6565.212174539056, 6753.561018533792, 6754.054432379458, 6927.688254028568, 6767.0, 6805.761798337059, 6813.012113243577, 6830.146231721035, 6832.48756343275, 1754.0528114817982, 1811.601447681508, 1970.044528403723, 1991.760988681353, 2006.9297574584893, 2025.473376921996, 2064.5354795171115, 2071.0680193912726, 2078.3453212238173, 2085.4369320283513, 1992.790756970519, 2008.548076682742, 2015.9798402016013, 2020.2525065725702, 2023.5143565544238, 2020.5857799151138, 2045.2228153301799, 2045.4170561389933, 2045.8056484633937, 2050.610384027045, 2006.8795872247713, 2009.7688765791975, 2022.916396112007, 2023.7369142011444, 2025.463252238158, 6958.199807022206, 7041.155061392615, 7142.178649455327, 7152.320529549685, 7202.855942881113, 3990.960090399117, 4094.877153685364, 4112.424260603518, 4113.321301985169, 4115.0, 2542.4915016996674, 2742.643456350662, 2774.153883065664, 2787.986060069707, 2796.482650709605, 817.6279792694369, 858.51064893011, 864.7016779211162, 890.7194233816392, 907.5280853955906, 8406.537640429835, 8476.321894248445, 8501.532415717133, 8533.701320453816, 8553.828923421559, 3571.160777217352, 3636.745427820027, 3701.4632878232505, 3714.1086139326367, 3823.9617603824163, 7969.760907172794, 8034.15641357649, 8035.678572857137, 8038.919610803934, 8043.436959412785, 4224.281872081753, 4234.724742891703, 4237.025484138604, 4237.788110594458, 4240.512341080754, 3425.1094715373683, 3531.52324436203, 3737.177820879402, 3846.8461261549783, 3856.402257650069, 3212.3414699986447, 3255.5930508686415, 3370.292238629915, 3379.121428428626, 3385.23832137767, 1036.7874585709912, 1051.3271506236015, 1053.1416895230363, 1055.9102476289447, 1064.6114168328504, 729.5586170366852, 758.7913323835879, 769.97690069298, 777.7550071727501, 801.983960320802, 4585.380973568593, 4628.583427491542, 4636.814527418933, 4906.656534042654, 5018.372703412074, 808.3937047214589, 819.8237378963552, 821.4742564758559, 824.5671022713003, 827.1563005734117, 3193.5848339716154, 3249.8212598306845, 3250.4799232122746, 3271.9672803272138, 3330.6502817203846, 7888.64501097452, 8215.917840821634, 8238.752837414888, 8238.876416853753, 8245.0, 8217.671293148207, 8226.341892648574, 8227.259546640831, 8228.50628962264, 8229.95885020571, 6212.9068063979075, 6491.545591808623, 6497.057926600616, 6497.772577959749, 6635.568688035262, 4937.728424936663, 4946.0, 4983.227599722049, 5027.371578552681, 5194.740262986911, 7683.385329173541, 7772.417068719982, 7799.571023593757, 7853.410994175346, 7869.567173805495, 7791.961040194763, 7872.921270787448, 7944.967154270139, 7991.120976692443, 7996.520208787491, 5054.747262636927, 5176.145935920682, 5661.405552416937, 5813.883722325445, 5878.3239927408895, 6364.204474440695, 6662.06731057662, 6692.732290708317, 6799.218089919723, 6807.5575087619145, 6017.187679663364, 6025.66858822769, 6040.486558642565, 6139.956207444656, 6159.476444502267, 5970.552208584287, 6070.271567411939, 6076.361981992004, 6079.179310792986, 6090.969545152246, 5591.860203494945, 5679.574031947703, 5696.743646535833, 5698.6010979232715, 5701.4298570142655, 4080.224757296223, 4110.321796903597, 4225.323948168279, 4236.957630423656, 4250.574942505848, 4279.186954478639, 4286.399904013379, 4287.7841618785915, 4289.5495972923645, 4472.127935052764], "value": 3720.8704603974124, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.38455589979975, 286.6402664655857, 289.905780621298, 291.17016502966544, 293.30925670047054, 4600.8389706360285, 4819.831305904289, 4827.71033737976, 4838.225883858583, 4879.804807807684, 4624.306354046895, 4711.222648263032, 4724.433068031833, 4781.235002399617, 4789.568938795508, 3756.812159392033, 3766.2090960898245, 3768.246350729851, 3776.565694945089, 3798.3922572388424, 3556.9644303556893, 3779.4708740776177, 3789.109559253573, 3790.4882840816413, 3801.733878628497, 3509.631488693689, 3675.246574452231, 3701.518802555664, 3711.350513660112, 3743.4010558310674, 3721.088333358331, 3721.5534135903863, 3728.0866187783895, 3730.813459327023, 3740.3828368319196, 3278.8852390166467, 3285.0637568292923, 3290.276139249361, 3309.9172520686934, 3317.4360358739073, 4563.475200351969, 4637.628989680851, 4648.837290694843, 4669.182892993713, 4686.36734040907, 4225.4365884622885, 4232.661387089025, 4234.428352172448, 4243.533211346749, 4253.829846806124, 4936.802527898915, 4951.084049450863, 4961.776720047606, 4962.4045114586115, 5007.399112106534, 3518.1380561762276, 3561.6972557332397, 3572.7856328620364, 3587.587427445851, 3601.94597081044, 5173.551405606437, 5175.948240517622, 5221.190715439113, 5225.294585230983, 5243.295928823148, 3628.838771593065, 3633.1462106404974, 3636.072801435617, 3656.305301992613, 3659.14010207601, 3723.3670276053135, 3724.2923844469465, 3736.178040831013, 3747.887563373103, 3751.9249615007548, 4072.6538244248977, 4200.3699445082875, 4208.137331846964, 4244.808983595745, 4256.489221293465, 4924.365464476559, 4937.987712518925, 4946.0, 4982.975085124551, 4993.626752642979, 1195.338479513477, 1225.546547777328, 1230.9630711078682, 1236.6970092327438, 1244.3840299052026, 858.5449711652834, 864.7838040489878, 879.5734068976541, 888.493558671551, 888.9022207557164, 4238.660907127422, 4246.384274280212, 4250.404943307939, 4251.744895306291, 4327.0, 4915.549912775668, 4969.0, 4979.912454278298, 5005.224190250517, 5043.621728370387, 4058.495312368717, 4200.6219440250525, 4222.4299719538085, 4251.404803327537, 4295.291276939332, 2625.9496201519164, 2628.303499572615, 2633.9473210536066, 2638.1953504181024, 2638.3272265572155, 4581.9690569622235, 4619.630429565626, 4637.559431853969, 4652.976735116303, 4670.252759558454, 4874.756936981118, 5015.924761128586, 5053.823116190915, 5067.6452648315, 5075.822346217865, 4611.239145540948, 4622.491525932145, 4630.32860235264, 4634.976825115853, 4638.582527572467, 4924.310596516419, 4945.579625731709, 4946.752662366939, 4964.900701985868, 4977.183328085295, 4710.7281034119915, 4825.4933232011535, 4859.829905953275, 4867.683600565952, 4875.829345972874, 4593.678442509126, 4645.558671926162, 4656.4412270527755, 4664.277037059262, 4678.976605116953, 3543.645635436436, 3559.074640593516, 3560.3947328953623, 3574.57105147384, 3580.928381432409, 4820.457453614809, 4909.4354149273295, 4932.630052745986, 4978.153713868579, 4980.825671101494, 4769.594584460221, 4774.785134669018, 4785.688930219525, 4794.2089555223, 4808.519148085164, 4791.688540244873, 4803.711777293373, 4817.494163112823, 4819.3252944588485, 4837.548735379442, 4530.841420550265, 4727.692699974491, 4729.17239483096, 4747.833825816218, 4752.740523761275, 4824.383831416374, 4831.299461577981, 4860.295257187618, 4872.878178045577, 4877.95122048775, 4714.481407045154, 4721.339012538178, 4728.62171026324, 4777.617790576676, 4786.736729479772], "value": 3699.2996140015675, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.3306313460492, 603.592575011867, 614.3702704727654, 659.8288038731251, 676.8510927595927, 12145.75708485831, 12663.810042849365, 12714.364281785896, 12722.809157862639, 13010.414531346089, 12455.68860778481, 12556.977209116358, 12746.68133296668, 12759.808602870964, 12785.552505662303, 746.3432179681872, 764.1708746010585, 764.2548515197666, 764.4763337114094, 764.5221736414741, 612.6691586543261, 633.7243299164878, 729.9343059124677, 766.3218052023943, 770.118214644232, 811.2414892075899, 823.7775800533852, 824.3405275779382, 825.859603867344, 827.5903427803246, 813.0812182234097, 813.9104698483162, 814.1817473439215, 814.6130587970725, 814.9062857771373, 477.27930824455325, 486.5839707050492, 564.497597138547, 599.5263741644096, 599.9910001349983, 11789.88210117905, 12447.0, 12460.252384856938, 12477.937610311981, 12483.0, 11730.17888747788, 11831.290122592673, 12127.02983761297, 12355.938220308932, 12390.690232744164, 10614.363138211733, 10948.288361256493, 11003.889961100367, 11105.777884442266, 11291.604793832259, 3942.2903877302074, 3979.602039796026, 3989.7606143631474, 3990.1620659661507, 4021.095253567924, 71449.28550714531, 72183.27816721817, 73349.63325183393, 73473.6326318365, 73506.0, 9253.907460925304, 9257.120573545502, 9385.812283754287, 9465.66870159541, 9541.713748587554, 18086.5478363042, 18257.269709211483, 18282.817171828377, 18291.0, 18309.7253541197, 6353.618782873043, 6440.02872875272, 6445.0, 6532.08550802888, 6682.064510968468, 3407.0630576591634, 3494.633063528344, 3533.8586456541966, 3564.0, 3608.7654302470255, 2542.6694529711017, 2629.81591288608, 2644.656194694677, 2649.1257884897936, 2649.562822134365, 436.9912601747947, 438.91002344519296, 446.5489855246225, 453.64388954670426, 458.06326063200834, 483.62780561346653, 494.53019631349645, 505.7117443057422, 526.2658591265164, 531.171372658646, 7107.6446177690905, 7168.319009694071, 7236.0, 7238.059052323164, 7337.266273372727, 497.9427365852901, 516.9534741873249, 521.5983692556711, 531.0335189954324, 533.0427028633691, 3426.5716785401823, 3484.9477257841154, 3503.8598456061472, 3655.5613326401003, 3661.7802931824176, 69279.0, 69795.0, 71114.28885711076, 71259.0, 71690.28309716836, 60722.39277607256, 60732.696336518035, 60971.0, 61542.69228653828, 64866.0, 52700.73649631727, 55893.7205313979, 56608.150877736865, 57154.0, 57406.42593574095, 6808.251092379934, 6895.34494223048, 6905.1713794342995, 7015.36861682451, 7046.964765176142, 36334.8183259082, 38175.23649526938, 38990.220195595364, 39364.409533856444, 39654.0, 44327.90229123563, 48198.0, 50825.49174508208, 51853.0, 52718.73640631772, 9184.908150918673, 9217.216536594464, 9255.67605133817, 9339.48632825174, 9458.952705236705, 9942.204623630238, 10045.598176072876, 10048.397096174253, 10113.49432528356, 10204.336718113298, 9713.320067595483, 9762.60949562038, 9794.363366381162, 9820.852687209555, 9884.505774711091, 9513.809723805347, 9528.333016688764, 9682.128608425275, 9852.901470985198, 9864.5560949756, 9562.521873906417, 9689.467079310705, 9713.660021899199, 9742.61029558838, 9747.951260243653, 8314.777252642178, 8496.447730897471, 8577.528235947082, 8627.654893804178, 8656.264217541328, 7779.92220077792, 8111.594420279081, 8156.469829461066, 8191.0, 8222.38332125081], "value": 5900.677021424665, "unit": "score"}], "name": "dromaeo_css", "value": 6064.505550384837, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 116.0, 118.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 132.0, 130.0, 166.0, 130.0, 133.0, 133.0, 132.0, 152.0, 133.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 163.0, 162.0, 160.0, 162.0, 162.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 79.0, 110.0, 78.0, 78.0, 77.0, 78.0, 106.0, 77.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 89.0, 102.0, 84.0, 84.0, 83.0, 99.0, 83.0, 84.0, 105.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 117.0, 117.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 64.0, 65.0, 64.0, 63.0, 65.0, 67.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 96.0, 85.0, 85.0, 85.0, 93.0, 85.0, 86.0, 91.0, 94.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 150.0, 146.0, 153.0, 139.0, 146.0, 145.0, 150.0, 197.0, 142.0], "value": 151.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 186.0, 186.0, 181.0, 185.0, 181.0, 181.0, 182.0, 181.0], "value": 183.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 74.0, 71.0, 71.0, 72.0, 76.0, 74.0, 71.0], "value": 73.5, "unit": "score"}], "name": "kraken", "value": 1578.7999999999997, "alertThreshold": 2.0}]} 17:18:45 INFO - Return code: 0 17:18:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:18:45 INFO - # TBPL SUCCESS # 17:18:45 INFO - Running post-action listener: _resource_record_post_action 17:18:45 INFO - [mozharness: 2016-12-02 01:18:45.718180Z] Finished run-tests step (success) 17:18:45 INFO - Running post-run listener: _resource_record_post_run 17:18:45 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 402968576; Read time: 12; Write time: 230020 17:18:45 INFO - TinderboxPrint: CPU usage
13.1% 17:18:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:18:45 INFO - TinderboxPrint: I/O write bytes / time
402,968,576 / 230,020 17:18:45 INFO - TinderboxPrint: CPU idle
8,339.8 (86.9%) 17:18:45 INFO - TinderboxPrint: CPU user
1,212.6 (12.6%) 17:18:45 INFO - TinderboxPrint: Swap in / out
0 / 0 17:18:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115875840; Read time: 0; Write time: 67036 17:18:45 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 286068736; Read time: 0; Write time: 162948 17:18:46 INFO - Running post-run listener: _upload_blobber_files 17:18:46 INFO - Blob upload gear active. 17:18:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:18:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:18:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:18:46 INFO - (blobuploader) - INFO - Open directory for files ... 17:18:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:18:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:18:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:47 INFO - (blobuploader) - INFO - Done attempting. 17:18:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:18:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:18:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:51 INFO - (blobuploader) - INFO - Done attempting. 17:18:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:18:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:18:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:52 INFO - (blobuploader) - INFO - Done attempting. 17:18:52 INFO - (blobuploader) - INFO - Iteration through files over. 17:18:52 INFO - Return code: 0 17:18:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:18:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:18:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bf22d28b29252d218cf8563f9209570ef4a03b92d504683657b524fc08c632a39593b553c8143b8162c7de7304179a91a1110309df2c90bd9dda1a90f5ef89b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/17c0ba1f67dab967cc008672092923fe4c42ad948ffc080b2eba74947445085c6dd3a958b050bc8d3b25f3465f6d51994e7c805cbeb7057a24e86309a70cb3b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d824756cceca4f4942e1218ca313af43df60aaf90832481f538e455b48a31942109203019c14a73410dcbcfa947661e15460d3dc003e2ec751236ca4f8794490"} 17:18:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:18:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:18:52 INFO - Contents: 17:18:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bf22d28b29252d218cf8563f9209570ef4a03b92d504683657b524fc08c632a39593b553c8143b8162c7de7304179a91a1110309df2c90bd9dda1a90f5ef89b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/17c0ba1f67dab967cc008672092923fe4c42ad948ffc080b2eba74947445085c6dd3a958b050bc8d3b25f3465f6d51994e7c805cbeb7057a24e86309a70cb3b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d824756cceca4f4942e1218ca313af43df60aaf90832481f538e455b48a31942109203019c14a73410dcbcfa947661e15460d3dc003e2ec751236ca4f8794490"} 17:18:52 INFO - Running post-run listener: copy_logs_to_upload_dir 17:18:52 INFO - Copying logs to upload dir... 17:18:52 INFO - mkdir: /builds/slave/test/build/upload/logs 17:18:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.753854 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-12-01 17:18:52.631737) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 17:18:52.635099) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bf22d28b29252d218cf8563f9209570ef4a03b92d504683657b524fc08c632a39593b553c8143b8162c7de7304179a91a1110309df2c90bd9dda1a90f5ef89b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/17c0ba1f67dab967cc008672092923fe4c42ad948ffc080b2eba74947445085c6dd3a958b050bc8d3b25f3465f6d51994e7c805cbeb7057a24e86309a70cb3b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d824756cceca4f4942e1218ca313af43df60aaf90832481f538e455b48a31942109203019c14a73410dcbcfa947661e15460d3dc003e2ec751236ca4f8794490"} build_url:https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011742 build_url: 'https://queue.taskcluster.net/v1/task/WlREKRNkT5OrsA-8SMlAMQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bf22d28b29252d218cf8563f9209570ef4a03b92d504683657b524fc08c632a39593b553c8143b8162c7de7304179a91a1110309df2c90bd9dda1a90f5ef89b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/17c0ba1f67dab967cc008672092923fe4c42ad948ffc080b2eba74947445085c6dd3a958b050bc8d3b25f3465f6d51994e7c805cbeb7057a24e86309a70cb3b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d824756cceca4f4942e1218ca313af43df60aaf90832481f538e455b48a31942109203019c14a73410dcbcfa947661e15460d3dc003e2ec751236ca4f8794490"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 17:18:52.660747) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 17:18:52.661086) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1480640100.191972-923548809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004388 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 17:18:52.745906) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 17:18:52.746234) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 17:18:52.746587) ========= ========= Total master_lag: 0.17 =========